builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-013 starttime: 1472512768.64 results: success (0) buildid: 20160829143007 builduid: 0f0c1efa8727474a9030ef8adf4cf444 revision: 578a16bf30e47ceb2aba7c5fd53b7eaba9829610 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 16:19:28.640422) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 16:19:28.641079) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 16:19:28.641399) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 16:19:28.672594) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 16:19:28.672990) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1472511567.404289-2083425281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-29 16:19:28-- 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% 50.2M=0s 2016-08-29 16:19:28 (50.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124345 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 16:19:28.814600) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 16:19:28.814931) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1472511567.404289-2083425281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019095 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 16:19:28.866029) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 16:19:28.866436) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 578a16bf30e47ceb2aba7c5fd53b7eaba9829610 --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 578a16bf30e47ceb2aba7c5fd53b7eaba9829610 --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=9c3a94c35cc88655b05d2c08000001b2-1472511567.404289-2083425281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-29 16:19:28,972 truncating revision to first 12 chars 2016-08-29 16:19:28,972 Setting DEBUG logging. 2016-08-29 16:19:28,972 attempt 1/10 2016-08-29 16:19:28,972 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/578a16bf30e4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-29 16:19:29,227 unpacking tar archive at: fx-team-578a16bf30e4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.592826 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 16:19:29.476786) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 16:19:29.477315) ========= script_repo_revision: 578a16bf30e47ceb2aba7c5fd53b7eaba9829610 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 16:19:29.477983) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 16:19:29.478453) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 16:19:29.489533) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-29 16:19:29.489884) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1472511567.404289-2083425281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:19:29 INFO - MultiFileLogger online at 20160829 16:19:29 in /builds/slave/test 16:19:29 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 16:19:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:19:29 INFO - {'append_to_log': False, 16:19:29 INFO - 'base_work_dir': '/builds/slave/test', 16:19:29 INFO - 'blob_upload_branch': 'Fx-Team', 16:19:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:19:29 INFO - 'branch': 'Fx-Team', 16:19:29 INFO - 'buildbot_json_path': 'buildprops.json', 16:19:29 INFO - 'config_files': ('talos/linux_config.py',), 16:19:29 INFO - 'default_actions': ('clobber', 16:19:29 INFO - 'read-buildbot-config', 16:19:29 INFO - 'download-and-extract', 16:19:29 INFO - 'populate-webroot', 16:19:29 INFO - 'create-virtualenv', 16:19:29 INFO - 'install', 16:19:29 INFO - 'run-tests'), 16:19:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:19:29 INFO - 'download_minidump_stackwalk': True, 16:19:29 INFO - 'download_symbols': 'ondemand', 16:19:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:19:29 INFO - 'tooltool.py': '/tools/tooltool.py', 16:19:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:19:29 INFO - '/tools/misc-python/virtualenv.py')}, 16:19:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:19:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:19:29 INFO - 'installer_path': 'installer.exe', 16:19:29 INFO - 'log_level': 'info', 16:19:29 INFO - 'log_name': 'talos', 16:19:29 INFO - 'log_to_console': True, 16:19:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:19:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:19:29 INFO - 'opt_config_files': (), 16:19:29 INFO - 'pip_index': False, 16:19:29 INFO - 'sps_profile': False, 16:19:29 INFO - 'sps_profile_interval': 0, 16:19:29 INFO - 'suite': 'dromaeojs-e10s', 16:19:29 INFO - 'system_bits': '32', 16:19:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:19:29 INFO - 'title': 'talos-linux64-ix-013', 16:19:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:19:29 INFO - 'use_talos_json': True, 16:19:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:19:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:19:29 INFO - 'work_dir': 'build'} 16:19:29 INFO - [mozharness: 2016-08-29 23:19:29.685662Z] Running clobber step. 16:19:29 INFO - Running pre-action listener: _resource_record_pre_action 16:19:29 INFO - Running main action method: clobber 16:19:29 INFO - rmtree: /builds/slave/test/build 16:19:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:19:30 INFO - Running post-action listener: _resource_record_post_action 16:19:30 INFO - [mozharness: 2016-08-29 23:19:30.136147Z] Finished clobber step (success) 16:19:30 INFO - [mozharness: 2016-08-29 23:19:30.136248Z] Running read-buildbot-config step. 16:19:30 INFO - Running pre-action listener: _resource_record_pre_action 16:19:30 INFO - Running main action method: read_buildbot_config 16:19:30 INFO - Using buildbot properties: 16:19:30 INFO - { 16:19:30 INFO - "project": "", 16:19:30 INFO - "product": "firefox", 16:19:30 INFO - "script_repo_revision": "production", 16:19:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 16:19:30 INFO - "repository": "", 16:19:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 16:19:30 INFO - "buildid": "20160829143007", 16:19:30 INFO - "pgo_build": "True", 16:19:30 INFO - "basedir": "/builds/slave/test", 16:19:30 INFO - "buildnumber": 1090, 16:19:30 INFO - "slavename": "talos-linux64-ix-013", 16:19:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:19:30 INFO - "platform": "ubuntu64_hw", 16:19:30 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 16:19:30 INFO - "branch": "fx-team", 16:19:30 INFO - "repo_path": "integration/fx-team", 16:19:30 INFO - "revision": "578a16bf30e47ceb2aba7c5fd53b7eaba9829610", 16:19:30 INFO - "stage_platform": "linux64-pgo", 16:19:30 INFO - "builduid": "0f0c1efa8727474a9030ef8adf4cf444", 16:19:30 INFO - "slavebuilddir": "test" 16:19:30 INFO - } 16:19:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/fVmFULvXTIqPMYfJkhKKBw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 16:19:30 INFO - Running post-action listener: _resource_record_post_action 16:19:30 INFO - [mozharness: 2016-08-29 23:19:30.138720Z] Finished read-buildbot-config step (success) 16:19:30 INFO - [mozharness: 2016-08-29 23:19:30.138809Z] Running download-and-extract step. 16:19:30 INFO - Running pre-action listener: _resource_record_pre_action 16:19:30 INFO - Running main action method: download_and_extract 16:19:30 INFO - mkdir: /builds/slave/test/build/tests 16:19:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:30 INFO - trying https://queue.taskcluster.net/v1/task/fVmFULvXTIqPMYfJkhKKBw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:19:30 INFO - Downloading https://queue.taskcluster.net/v1/task/fVmFULvXTIqPMYfJkhKKBw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:19:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fVmFULvXTIqPMYfJkhKKBw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:19:30 INFO - Downloaded 1361 bytes. 16:19:30 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:19:30 INFO - Using the following test package requirements: 16:19:30 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:19:30 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:19:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:19:30 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:19:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:19:30 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:19:30 INFO - u'jsshell-linux-x86_64.zip'], 16:19:30 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:19:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:19:30 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:19:30 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:19:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:19:30 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:19:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:19:30 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:19:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:19:30 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:19:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:19:30 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:19:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:30 INFO - trying https://queue.taskcluster.net/v1/task/fVmFULvXTIqPMYfJkhKKBw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:19:30 INFO - Downloading https://queue.taskcluster.net/v1/task/fVmFULvXTIqPMYfJkhKKBw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:19:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fVmFULvXTIqPMYfJkhKKBw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:19:31 INFO - Downloaded 21876614 bytes. 16:19:31 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 16:19:35 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:35 INFO - trying https://queue.taskcluster.net/v1/task/fVmFULvXTIqPMYfJkhKKBw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:19:35 INFO - Downloading https://queue.taskcluster.net/v1/task/fVmFULvXTIqPMYfJkhKKBw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:19:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fVmFULvXTIqPMYfJkhKKBw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:19:36 INFO - Downloaded 21876614 bytes. 16:19:36 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 16:19:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:41 INFO - trying https://queue.taskcluster.net/v1/task/fVmFULvXTIqPMYfJkhKKBw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 16:19:41 INFO - Downloading https://queue.taskcluster.net/v1/task/fVmFULvXTIqPMYfJkhKKBw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 16:19:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fVmFULvXTIqPMYfJkhKKBw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:19:41 INFO - Downloaded 14413998 bytes. 16:19:41 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 16:19:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:42 INFO - trying https://queue.taskcluster.net/v1/task/fVmFULvXTIqPMYfJkhKKBw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:19:42 INFO - Downloading https://queue.taskcluster.net/v1/task/fVmFULvXTIqPMYfJkhKKBw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:19:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fVmFULvXTIqPMYfJkhKKBw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:19:43 INFO - Downloaded 59746643 bytes. 16:19:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fVmFULvXTIqPMYfJkhKKBw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:19:43 INFO - mkdir: /builds/slave/test/properties 16:19:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:19:43 INFO - Writing to file /builds/slave/test/properties/build_url 16:19:43 INFO - Contents: 16:19:43 INFO - build_url:https://queue.taskcluster.net/v1/task/fVmFULvXTIqPMYfJkhKKBw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:19:44 INFO - Running post-action listener: _resource_record_post_action 16:19:44 INFO - Running post-action listener: set_extra_try_arguments 16:19:44 INFO - [mozharness: 2016-08-29 23:19:44.033791Z] Finished download-and-extract step (success) 16:19:44 INFO - [mozharness: 2016-08-29 23:19:44.034094Z] Running populate-webroot step. 16:19:44 INFO - Running pre-action listener: _resource_record_pre_action 16:19:44 INFO - Running main action method: populate_webroot 16:19:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:19:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:19:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:19:44 INFO - '--tppagecycles', 16:19:44 INFO - '7'], 16:19:44 INFO - 'tests': ['tsvgm']}}, 16:19:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:19:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:19:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:19:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:19:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:19:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:19:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:19:44 INFO - 'talos_options': ['--disable-e10s'], 16:19:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:19:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:19:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:19:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:19:44 INFO - 'talos_options': ['--disable-e10s'], 16:19:44 INFO - 'tests': ['damp', 'tps']}, 16:19:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:19:44 INFO - 'tests': ['damp', 'tps']}, 16:19:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:19:44 INFO - 'tests': ['dromaeo_dom']}, 16:19:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:19:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:19:44 INFO - 'tests': ['basic_compositor_video']}, 16:19:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:19:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:19:44 INFO - 'tests': ['a11yr', 16:19:44 INFO - 'ts_paint', 16:19:44 INFO - 'tpaint', 16:19:44 INFO - 'sessionrestore', 16:19:44 INFO - 'sessionrestore_no_auto_restore', 16:19:44 INFO - 'tabpaint']}, 16:19:44 INFO - 'other-e10s': {'tests': ['a11yr', 16:19:44 INFO - 'ts_paint', 16:19:44 INFO - 'tpaint', 16:19:44 INFO - 'sessionrestore', 16:19:44 INFO - 'sessionrestore_no_auto_restore', 16:19:44 INFO - 'tabpaint']}, 16:19:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:19:44 INFO - 'ts_paint', 16:19:44 INFO - 'tpaint', 16:19:44 INFO - 'sessionrestore', 16:19:44 INFO - 'sessionrestore_no_auto_restore', 16:19:44 INFO - 'tabpaint']}, 16:19:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:19:44 INFO - 'ts_paint', 16:19:44 INFO - 'tpaint', 16:19:44 INFO - 'sessionrestore', 16:19:44 INFO - 'sessionrestore_no_auto_restore', 16:19:44 INFO - 'tabpaint']}, 16:19:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:19:44 INFO - 'tests': ['a11yr', 16:19:44 INFO - 'ts_paint', 16:19:44 INFO - 'tpaint', 16:19:44 INFO - 'sessionrestore', 16:19:44 INFO - 'sessionrestore_no_auto_restore', 16:19:44 INFO - 'tabpaint']}, 16:19:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:19:44 INFO - 'tests': ['a11yr', 16:19:44 INFO - 'ts_paint', 16:19:44 INFO - 'tpaint', 16:19:44 INFO - 'sessionrestore', 16:19:44 INFO - 'sessionrestore_no_auto_restore', 16:19:44 INFO - 'tabpaint']}, 16:19:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:19:44 INFO - 'tests': ['tsvgx', 16:19:44 INFO - 'tsvgr_opacity', 16:19:44 INFO - 'tart', 16:19:44 INFO - 'tscrollx', 16:19:44 INFO - 'cart']}, 16:19:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:19:44 INFO - 'tsvgr_opacity', 16:19:44 INFO - 'tart', 16:19:44 INFO - 'tscrollx', 16:19:44 INFO - 'cart']}, 16:19:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:19:44 INFO - 'talos_options': ['--disable-e10s'], 16:19:44 INFO - 'tests': ['tp5o']}, 16:19:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:19:44 INFO - 'tests': ['tp5o']}, 16:19:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:19:44 INFO - 'talos_options': ['--disable-e10s', 16:19:44 INFO - '--xperf_path', 16:19:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:19:44 INFO - 'tests': ['tp5n']}, 16:19:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:19:44 INFO - 'talos_options': ['--xperf_path', 16:19:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:19:44 INFO - 'tests': ['tp5n']}}, 16:19:44 INFO - 'talos.zip': {'path': '', 16:19:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:19:44 INFO - Running post-action listener: _resource_record_post_action 16:19:44 INFO - [mozharness: 2016-08-29 23:19:44.050973Z] Finished populate-webroot step (success) 16:19:44 INFO - [mozharness: 2016-08-29 23:19:44.051067Z] Running create-virtualenv step. 16:19:44 INFO - Running pre-action listener: _resource_record_pre_action 16:19:44 INFO - Running main action method: create_virtualenv 16:19:44 INFO - Creating virtualenv /builds/slave/test/build/venv 16:19:44 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 16:19:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:19:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:19:44 INFO - Using real prefix '/usr' 16:19:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:19:44 INFO - Installing distribute.............................................................................................................................................................................................done. 16:19:46 INFO - Installing pip.................done. 16:19:46 INFO - Return code: 0 16:19:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:46 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 0x7fe2fe460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2720850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271b370>, '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 0x271e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271ed80>, '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': '9c3a94c35cc88655b05d2c08000001b2-1472511567.404289-2083425281', '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 16:19:46 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 16:19:46 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 16:19:46 INFO - Using env: {'DISPLAY': ':0', 16:19:46 INFO - 'HOME': '/home/cltbld', 16:19:46 INFO - 'LANG': 'en_US.UTF-8', 16:19:46 INFO - 'LANGUAGE': 'en_US:en', 16:19:46 INFO - 'LOGNAME': 'cltbld', 16:19:46 INFO - 'MAIL': '/var/mail/cltbld', 16:19:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:46 INFO - 'MOZ_NO_REMOTE': '1', 16:19:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:46 INFO - 'NO_EM_RESTART': '1', 16:19:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:46 INFO - 'PWD': '/builds/slave/test', 16:19:46 INFO - 'SHELL': '/bin/bash', 16:19:46 INFO - 'SHLVL': '1', 16:19:46 INFO - 'TERM': 'linux', 16:19:46 INFO - 'TMOUT': '86400', 16:19:46 INFO - 'USER': 'cltbld', 16:19:46 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1472511567.404289-2083425281', 16:19:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:46 INFO - '_': '/tools/buildbot/bin/python'} 16:19:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:46 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 16:19:46 INFO - Cleaning up... 16:19:46 INFO - Return code: 0 16:19:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:46 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 0x7fe2fe460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2720850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271b370>, '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 0x271e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271ed80>, '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': '9c3a94c35cc88655b05d2c08000001b2-1472511567.404289-2083425281', '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 16:19:46 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 16:19:46 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 16:19:46 INFO - Using env: {'DISPLAY': ':0', 16:19:46 INFO - 'HOME': '/home/cltbld', 16:19:46 INFO - 'LANG': 'en_US.UTF-8', 16:19:46 INFO - 'LANGUAGE': 'en_US:en', 16:19:46 INFO - 'LOGNAME': 'cltbld', 16:19:46 INFO - 'MAIL': '/var/mail/cltbld', 16:19:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:46 INFO - 'MOZ_NO_REMOTE': '1', 16:19:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:46 INFO - 'NO_EM_RESTART': '1', 16:19:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:46 INFO - 'PWD': '/builds/slave/test', 16:19:46 INFO - 'SHELL': '/bin/bash', 16:19:46 INFO - 'SHLVL': '1', 16:19:46 INFO - 'TERM': 'linux', 16:19:46 INFO - 'TMOUT': '86400', 16:19:46 INFO - 'USER': 'cltbld', 16:19:46 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1472511567.404289-2083425281', 16:19:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:46 INFO - '_': '/tools/buildbot/bin/python'} 16:19:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:47 INFO - Downloading/unpacking psutil>=3.1.1 16:19:47 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 16:19:47 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 16:19:47 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 16:19:47 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 16:19:47 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 16:19:47 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 16:19:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:19:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:19:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:19:49 INFO - Installing collected packages: psutil 16:19:49 INFO - Running setup.py install for psutil 16:19:49 INFO - building 'psutil._psutil_linux' extension 16:19:49 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 16:19:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:19:49 INFO - building 'psutil._psutil_posix' extension 16:19:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:19:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:19:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:19:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:19:49 INFO - Successfully installed psutil 16:19:49 INFO - Cleaning up... 16:19:49 INFO - Return code: 0 16:19:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2fe460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2720850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271b370>, '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 0x271e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271ed80>, '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': '9c3a94c35cc88655b05d2c08000001b2-1472511567.404289-2083425281', '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 16:19:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:19:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:19:49 INFO - Using env: {'DISPLAY': ':0', 16:19:49 INFO - 'HOME': '/home/cltbld', 16:19:49 INFO - 'LANG': 'en_US.UTF-8', 16:19:49 INFO - 'LANGUAGE': 'en_US:en', 16:19:49 INFO - 'LOGNAME': 'cltbld', 16:19:49 INFO - 'MAIL': '/var/mail/cltbld', 16:19:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:49 INFO - 'MOZ_NO_REMOTE': '1', 16:19:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:49 INFO - 'NO_EM_RESTART': '1', 16:19:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:49 INFO - 'PWD': '/builds/slave/test', 16:19:49 INFO - 'SHELL': '/bin/bash', 16:19:49 INFO - 'SHLVL': '1', 16:19:49 INFO - 'TERM': 'linux', 16:19:49 INFO - 'TMOUT': '86400', 16:19:49 INFO - 'USER': 'cltbld', 16:19:49 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1472511567.404289-2083425281', 16:19:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:49 INFO - '_': '/tools/buildbot/bin/python'} 16:19:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:19:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:19:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:19:51 INFO - Installing collected packages: mozsystemmonitor 16:19:51 INFO - Running setup.py install for mozsystemmonitor 16:19:51 INFO - Successfully installed mozsystemmonitor 16:19:51 INFO - Cleaning up... 16:19:51 INFO - Return code: 0 16:19:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2fe460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2720850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271b370>, '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 0x271e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271ed80>, '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': '9c3a94c35cc88655b05d2c08000001b2-1472511567.404289-2083425281', '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 16:19:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:19:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:19:51 INFO - Using env: {'DISPLAY': ':0', 16:19:51 INFO - 'HOME': '/home/cltbld', 16:19:51 INFO - 'LANG': 'en_US.UTF-8', 16:19:51 INFO - 'LANGUAGE': 'en_US:en', 16:19:51 INFO - 'LOGNAME': 'cltbld', 16:19:51 INFO - 'MAIL': '/var/mail/cltbld', 16:19:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:51 INFO - 'MOZ_NO_REMOTE': '1', 16:19:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:51 INFO - 'NO_EM_RESTART': '1', 16:19:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:51 INFO - 'PWD': '/builds/slave/test', 16:19:51 INFO - 'SHELL': '/bin/bash', 16:19:51 INFO - 'SHLVL': '1', 16:19:51 INFO - 'TERM': 'linux', 16:19:51 INFO - 'TMOUT': '86400', 16:19:51 INFO - 'USER': 'cltbld', 16:19:51 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1472511567.404289-2083425281', 16:19:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:51 INFO - '_': '/tools/buildbot/bin/python'} 16:19:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:52 INFO - Downloading/unpacking jsonschema==2.5.1 16:19:52 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 16:19:52 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 16:19:52 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 16:19:52 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 16:19:52 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 16:19:52 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 16:19:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:19:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:54 INFO - Downloading functools32-3.2.3-2.tar.gz 16:19:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:19:54 INFO - warning: no files found matching '*.txt' 16:19:54 INFO - no previously-included directories found matching 'build' 16:19:54 INFO - no previously-included directories found matching 'dist' 16:19:54 INFO - no previously-included directories found matching '.git*' 16:19:54 INFO - Installing collected packages: jsonschema, functools32 16:19:54 INFO - Running setup.py install for functools32 16:19:54 INFO - warning: no files found matching '*.txt' 16:19:54 INFO - no previously-included directories found matching 'build' 16:19:54 INFO - no previously-included directories found matching 'dist' 16:19:54 INFO - no previously-included directories found matching '.git*' 16:19:54 INFO - Successfully installed jsonschema functools32 16:19:54 INFO - Cleaning up... 16:19:54 INFO - Return code: 0 16:19:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:19:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2fe460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2720850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271b370>, '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 0x271e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271ed80>, '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': '9c3a94c35cc88655b05d2c08000001b2-1472511567.404289-2083425281', '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 16:19:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:19:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:19:54 INFO - Using env: {'DISPLAY': ':0', 16:19:54 INFO - 'HOME': '/home/cltbld', 16:19:54 INFO - 'LANG': 'en_US.UTF-8', 16:19:54 INFO - 'LANGUAGE': 'en_US:en', 16:19:54 INFO - 'LOGNAME': 'cltbld', 16:19:54 INFO - 'MAIL': '/var/mail/cltbld', 16:19:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:54 INFO - 'MOZ_NO_REMOTE': '1', 16:19:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:54 INFO - 'NO_EM_RESTART': '1', 16:19:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:54 INFO - 'PWD': '/builds/slave/test', 16:19:54 INFO - 'SHELL': '/bin/bash', 16:19:54 INFO - 'SHLVL': '1', 16:19:54 INFO - 'TERM': 'linux', 16:19:54 INFO - 'TMOUT': '86400', 16:19:54 INFO - 'USER': 'cltbld', 16:19:54 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1472511567.404289-2083425281', 16:19:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:54 INFO - '_': '/tools/buildbot/bin/python'} 16:19:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:19:54 INFO - Cleaning up... 16:19:54 INFO - Return code: 0 16:19:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:19:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2fe460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2720850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271b370>, '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 0x271e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271ed80>, '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': '9c3a94c35cc88655b05d2c08000001b2-1472511567.404289-2083425281', '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 16:19:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:19:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:19:54 INFO - Using env: {'DISPLAY': ':0', 16:19:54 INFO - 'HOME': '/home/cltbld', 16:19:54 INFO - 'LANG': 'en_US.UTF-8', 16:19:54 INFO - 'LANGUAGE': 'en_US:en', 16:19:54 INFO - 'LOGNAME': 'cltbld', 16:19:54 INFO - 'MAIL': '/var/mail/cltbld', 16:19:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:54 INFO - 'MOZ_NO_REMOTE': '1', 16:19:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:54 INFO - 'NO_EM_RESTART': '1', 16:19:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:54 INFO - 'PWD': '/builds/slave/test', 16:19:54 INFO - 'SHELL': '/bin/bash', 16:19:54 INFO - 'SHLVL': '1', 16:19:54 INFO - 'TERM': 'linux', 16:19:54 INFO - 'TMOUT': '86400', 16:19:54 INFO - 'USER': 'cltbld', 16:19:54 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1472511567.404289-2083425281', 16:19:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:54 INFO - '_': '/tools/buildbot/bin/python'} 16:19:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:54 INFO - Downloading/unpacking blobuploader==1.2.4 16:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:56 INFO - Downloading blobuploader-1.2.4.tar.gz 16:19:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:19:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:19:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:57 INFO - Downloading docopt-0.6.1.tar.gz 16:19:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:19:57 INFO - Installing collected packages: blobuploader, requests, docopt 16:19:57 INFO - Running setup.py install for blobuploader 16:19:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:19:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:19:57 INFO - Running setup.py install for requests 16:19:57 INFO - Running setup.py install for docopt 16:19:58 INFO - Successfully installed blobuploader requests docopt 16:19:58 INFO - Cleaning up... 16:19:58 INFO - Return code: 0 16:19:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:19:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:58 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 0x7fe2fe460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2720850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271b370>, '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 0x271e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271ed80>, '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': '9c3a94c35cc88655b05d2c08000001b2-1472511567.404289-2083425281', '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 16:19:58 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 16:19:58 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 16:19:58 INFO - Using env: {'DISPLAY': ':0', 16:19:58 INFO - 'HOME': '/home/cltbld', 16:19:58 INFO - 'LANG': 'en_US.UTF-8', 16:19:58 INFO - 'LANGUAGE': 'en_US:en', 16:19:58 INFO - 'LOGNAME': 'cltbld', 16:19:58 INFO - 'MAIL': '/var/mail/cltbld', 16:19:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:58 INFO - 'MOZ_NO_REMOTE': '1', 16:19:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:58 INFO - 'NO_EM_RESTART': '1', 16:19:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:58 INFO - 'PWD': '/builds/slave/test', 16:19:58 INFO - 'SHELL': '/bin/bash', 16:19:58 INFO - 'SHLVL': '1', 16:19:58 INFO - 'TERM': 'linux', 16:19:58 INFO - 'TMOUT': '86400', 16:19:58 INFO - 'USER': 'cltbld', 16:19:58 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1472511567.404289-2083425281', 16:19:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:58 INFO - '_': '/tools/buildbot/bin/python'} 16:19:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:19:58 INFO - Running setup.py (path:/tmp/pip-STL6ZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:19:58 INFO - Running setup.py (path:/tmp/pip-zYb3PS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:19:58 INFO - Running setup.py (path:/tmp/pip-pCNFFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:19:58 INFO - Running setup.py (path:/tmp/pip-m1b06j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:19:58 INFO - Running setup.py (path:/tmp/pip-zUlubV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:19:58 INFO - Running setup.py (path:/tmp/pip-6mQJ5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:19:58 INFO - Running setup.py (path:/tmp/pip-FaYpWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:19:58 INFO - Running setup.py (path:/tmp/pip-7gHsba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:19:58 INFO - Running setup.py (path:/tmp/pip-3Yw1Qi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:19:58 INFO - Running setup.py (path:/tmp/pip-IAkolZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:19:59 INFO - Running setup.py (path:/tmp/pip-CZaawZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:19:59 INFO - Running setup.py (path:/tmp/pip-SAKPrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:19:59 INFO - Running setup.py (path:/tmp/pip-5u6tOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:19:59 INFO - Running setup.py (path:/tmp/pip-afGUKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:19:59 INFO - Running setup.py (path:/tmp/pip-fnYhGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:19:59 INFO - Running setup.py (path:/tmp/pip-BfiQlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:19:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:19:59 INFO - Running setup.py (path:/tmp/pip-wZ7xEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:19:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:19:59 INFO - Running setup.py install for manifestparser 16:19:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:19:59 INFO - Running setup.py install for mozcrash 16:19:59 INFO - Running setup.py install for mozdebug 16:19:59 INFO - Running setup.py install for mozdevice 16:19:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:19:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:19:59 INFO - Running setup.py install for mozfile 16:20:00 INFO - Running setup.py install for mozhttpd 16:20:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:20:00 INFO - Running setup.py install for mozinfo 16:20:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:20:00 INFO - Running setup.py install for mozInstall 16:20:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:20:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:20:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:20:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:20:00 INFO - Running setup.py install for mozleak 16:20:00 INFO - Running setup.py install for mozlog 16:20:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:20:00 INFO - Running setup.py install for moznetwork 16:20:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:20:00 INFO - Running setup.py install for mozprocess 16:20:00 INFO - Running setup.py install for mozprofile 16:20:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:20:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:20:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:20:00 INFO - Running setup.py install for mozrunner 16:20:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:20:01 INFO - Running setup.py install for mozscreenshot 16:20:01 INFO - Running setup.py install for moztest 16:20:01 INFO - Running setup.py install for mozversion 16:20:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:20:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:20:01 INFO - Cleaning up... 16:20:01 INFO - Return code: 0 16:20:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2fe460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2720850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271b370>, '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 0x271e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271ed80>, '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': '9c3a94c35cc88655b05d2c08000001b2-1472511567.404289-2083425281', '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 16:20:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:20:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:20:01 INFO - Using env: {'DISPLAY': ':0', 16:20:01 INFO - 'HOME': '/home/cltbld', 16:20:01 INFO - 'LANG': 'en_US.UTF-8', 16:20:01 INFO - 'LANGUAGE': 'en_US:en', 16:20:01 INFO - 'LOGNAME': 'cltbld', 16:20:01 INFO - 'MAIL': '/var/mail/cltbld', 16:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:01 INFO - 'MOZ_NO_REMOTE': '1', 16:20:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:01 INFO - 'NO_EM_RESTART': '1', 16:20:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:01 INFO - 'PWD': '/builds/slave/test', 16:20:01 INFO - 'SHELL': '/bin/bash', 16:20:01 INFO - 'SHLVL': '1', 16:20:01 INFO - 'TERM': 'linux', 16:20:01 INFO - 'TMOUT': '86400', 16:20:01 INFO - 'USER': 'cltbld', 16:20:01 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1472511567.404289-2083425281', 16:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:01 INFO - '_': '/tools/buildbot/bin/python'} 16:20:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:20:01 INFO - Running setup.py (path:/tmp/pip-HzAXfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:20:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:20:01 INFO - Running setup.py (path:/tmp/pip-EPMJuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:20:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:20:01 INFO - Running setup.py (path:/tmp/pip-j9HIiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:20:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:20:01 INFO - Running setup.py (path:/tmp/pip-VQognS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:20:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:20:01 INFO - Running setup.py (path:/tmp/pip-bSvzxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:20:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:20:01 INFO - Running setup.py (path:/tmp/pip-lLh9xl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:20:02 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)) 16:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:20:02 INFO - Running setup.py (path:/tmp/pip-2AxT8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:20:02 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)) 16:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:20:02 INFO - Running setup.py (path:/tmp/pip-TM5Lkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:20:02 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)) 16:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:20:02 INFO - Running setup.py (path:/tmp/pip-phSoV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:20:02 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)) 16:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:20:02 INFO - Running setup.py (path:/tmp/pip-9KIa6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:20:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 16:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:20:02 INFO - Running setup.py (path:/tmp/pip-ws4C1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:20:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:20:02 INFO - Running setup.py (path:/tmp/pip-nZHzAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:20:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:20:02 INFO - Running setup.py (path:/tmp/pip-aXoz0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:20:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:20:02 INFO - Running setup.py (path:/tmp/pip-F1Ug9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:20:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:20:02 INFO - Running setup.py (path:/tmp/pip-62pNM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:20:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:20:02 INFO - Running setup.py (path:/tmp/pip-hd8PvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:20:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:20:02 INFO - Running setup.py (path:/tmp/pip-qT070q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:20:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:20:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:20:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:20:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:20:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:20:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:20:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:20:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:04 INFO - Downloading blessings-1.6.tar.gz 16:20:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:20:04 INFO - Installing collected packages: blessings 16:20:04 INFO - Running setup.py install for blessings 16:20:04 INFO - Successfully installed blessings 16:20:04 INFO - Cleaning up... 16:20:04 INFO - Return code: 0 16:20:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:20:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:20:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:20:05 INFO - Reading from file tmpfile_stdout 16:20:05 INFO - Current package versions: 16:20:05 INFO - argparse == 1.2.1 16:20:05 INFO - blessings == 1.6 16:20:05 INFO - blobuploader == 1.2.4 16:20:05 INFO - docopt == 0.6.1 16:20:05 INFO - functools32 == 3.2.3-2 16:20:05 INFO - jsonschema == 2.5.1 16:20:05 INFO - manifestparser == 1.1 16:20:05 INFO - mozInstall == 1.12 16:20:05 INFO - mozcrash == 0.17 16:20:05 INFO - mozdebug == 0.1 16:20:05 INFO - mozdevice == 0.48 16:20:05 INFO - mozfile == 1.2 16:20:05 INFO - mozhttpd == 0.7 16:20:05 INFO - mozinfo == 0.9 16:20:05 INFO - mozleak == 0.1 16:20:05 INFO - mozlog == 3.3 16:20:05 INFO - moznetwork == 0.27 16:20:05 INFO - mozprocess == 0.23 16:20:05 INFO - mozprofile == 0.28 16:20:05 INFO - mozrunner == 6.12 16:20:05 INFO - mozscreenshot == 0.1 16:20:05 INFO - mozsystemmonitor == 0.3 16:20:05 INFO - moztest == 0.7 16:20:05 INFO - mozversion == 1.4 16:20:05 INFO - psutil == 3.1.1 16:20:05 INFO - requests == 1.2.3 16:20:05 INFO - wsgiref == 0.1.2 16:20:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:20: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20:05 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 0x7fe2fe460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2720850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271b370>, '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 0x271e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271ed80>, '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': '9c3a94c35cc88655b05d2c08000001b2-1472511567.404289-2083425281', '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 16:20:05 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 16:20:05 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 16:20:05 INFO - Using env: {'DISPLAY': ':0', 16:20:05 INFO - 'HOME': '/home/cltbld', 16:20:05 INFO - 'LANG': 'en_US.UTF-8', 16:20:05 INFO - 'LANGUAGE': 'en_US:en', 16:20:05 INFO - 'LOGNAME': 'cltbld', 16:20:05 INFO - 'MAIL': '/var/mail/cltbld', 16:20:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:05 INFO - 'MOZ_NO_REMOTE': '1', 16:20:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:05 INFO - 'NO_EM_RESTART': '1', 16:20:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:05 INFO - 'PWD': '/builds/slave/test', 16:20:05 INFO - 'SHELL': '/bin/bash', 16:20:05 INFO - 'SHLVL': '1', 16:20:05 INFO - 'TERM': 'linux', 16:20:05 INFO - 'TMOUT': '86400', 16:20:05 INFO - 'USER': 'cltbld', 16:20:05 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1472511567.404289-2083425281', 16:20:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:05 INFO - '_': '/tools/buildbot/bin/python'} 16:20:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:20:05 INFO - Cleaning up... 16:20:05 INFO - Return code: 0 16:20:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:20: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2fe460f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2720850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271b370>, '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 0x271e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271ed80>, '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': '9c3a94c35cc88655b05d2c08000001b2-1472511567.404289-2083425281', '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 16:20:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:20:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:20:05 INFO - Using env: {'DISPLAY': ':0', 16:20:05 INFO - 'HOME': '/home/cltbld', 16:20:05 INFO - 'LANG': 'en_US.UTF-8', 16:20:05 INFO - 'LANGUAGE': 'en_US:en', 16:20:05 INFO - 'LOGNAME': 'cltbld', 16:20:05 INFO - 'MAIL': '/var/mail/cltbld', 16:20:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:05 INFO - 'MOZ_NO_REMOTE': '1', 16:20:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:05 INFO - 'NO_EM_RESTART': '1', 16:20:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:05 INFO - 'PWD': '/builds/slave/test', 16:20:05 INFO - 'SHELL': '/bin/bash', 16:20:05 INFO - 'SHLVL': '1', 16:20:05 INFO - 'TERM': 'linux', 16:20:05 INFO - 'TMOUT': '86400', 16:20:05 INFO - 'USER': 'cltbld', 16:20:05 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1472511567.404289-2083425281', 16:20:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:05 INFO - '_': '/tools/buildbot/bin/python'} 16:20:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:20:05 INFO - Cleaning up... 16:20:05 INFO - Return code: 0 16:20:05 INFO - Running post-action listener: _resource_record_post_action 16:20:05 INFO - Running post-action listener: _start_resource_monitoring 16:20:05 INFO - Starting resource monitoring. 16:20:05 INFO - [mozharness: 2016-08-29 23:20:05.616248Z] Finished create-virtualenv step (success) 16:20:05 INFO - [mozharness: 2016-08-29 23:20:05.616790Z] Running install step. 16:20:05 INFO - Running pre-action listener: _resource_record_pre_action 16:20:05 INFO - Running main action method: install 16:20:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:20:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:20:05 INFO - Reading from file tmpfile_stdout 16:20:05 INFO - Detecting whether we're running mozinstall >=1.0... 16:20:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:20:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:20:05 INFO - Reading from file tmpfile_stdout 16:20:05 INFO - Output received: 16:20:05 INFO - Usage: mozinstall [options] installer 16:20:05 INFO - Options: 16:20:05 INFO - -h, --help show this help message and exit 16:20:05 INFO - -d DEST, --destination=DEST 16:20:05 INFO - Directory to install application into. [default: 16:20:05 INFO - "/builds/slave/test"] 16:20:05 INFO - --app=APP Application being installed. [default: firefox] 16:20:05 INFO - mkdir: /builds/slave/test/build/application 16:20:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:20:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:20:22 INFO - Reading from file tmpfile_stdout 16:20:22 INFO - Output received: 16:20:22 INFO - /builds/slave/test/build/application/firefox/firefox 16:20:22 INFO - Running post-action listener: _resource_record_post_action 16:20:22 INFO - [mozharness: 2016-08-29 23:20:22.928741Z] Finished install step (success) 16:20:22 INFO - [mozharness: 2016-08-29 23:20:22.929030Z] Running run-tests step. 16:20:22 INFO - Running pre-action listener: _resource_record_pre_action 16:20:22 INFO - Running main action method: run_tests 16:20:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:20:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:20:22 INFO - Python 2.7.3 16:20:22 INFO - Return code: 0 16:20:22 INFO - grabbing minidump binary from tooltool 16:20:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:22 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271b370>, '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 0x271e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271ed80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:20:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:20:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:20:22 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:20:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:20:23 INFO - Return code: 0 16:20:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:20:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:20:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:20:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:20:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:20:23 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/fVmFULvXTIqPMYfJkhKKBw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 16:20:23 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/fVmFULvXTIqPMYfJkhKKBw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 16:20:23 INFO - Using env: {'DISPLAY': ':0', 16:20:23 INFO - 'HOME': '/home/cltbld', 16:20:23 INFO - 'LANG': 'en_US.UTF-8', 16:20:23 INFO - 'LANGUAGE': 'en_US:en', 16:20:23 INFO - 'LOGNAME': 'cltbld', 16:20:23 INFO - 'MAIL': '/var/mail/cltbld', 16:20:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:20:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:20:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:23 INFO - 'MOZ_NO_REMOTE': '1', 16:20:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:20:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:23 INFO - 'NO_EM_RESTART': '1', 16:20:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:23 INFO - 'PWD': '/builds/slave/test', 16:20:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:20:23 INFO - 'SHELL': '/bin/bash', 16:20:23 INFO - 'SHLVL': '1', 16:20:23 INFO - 'TERM': 'linux', 16:20:23 INFO - 'TMOUT': '86400', 16:20:23 INFO - 'USER': 'cltbld', 16:20:23 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1472511567.404289-2083425281', 16:20:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:23 INFO - '_': '/tools/buildbot/bin/python'} 16:20:23 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/fVmFULvXTIqPMYfJkhKKBw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 16:20:23 INFO - mozversion application_buildid: 20160829143007 16:20:23 INFO - mozversion application_changeset: 578a16bf30e47ceb2aba7c5fd53b7eaba9829610 16:20:23 INFO - mozversion application_display_name: Nightly 16:20:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:20:23 INFO - mozversion application_name: Firefox 16:20:23 INFO - mozversion application_remotingname: firefox 16:20:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:20:23 INFO - mozversion application_vendor: Mozilla 16:20:23 INFO - mozversion application_version: 51.0a1 16:20:23 INFO - mozversion platform_buildid: 20160829143007 16:20:23 INFO - mozversion platform_changeset: 578a16bf30e47ceb2aba7c5fd53b7eaba9829610 16:20:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:20:23 INFO - mozversion platform_version: 51.0a1 16:20:23 INFO - using testdate: 1472512823 16:20:23 INFO - actual date: 1472512823 16:20:23 INFO - starting webserver on 'localhost:36070' 16:20:23 INFO - SUITE-START | Running 2 tests 16:20:23 INFO - TEST-START | dromaeo_css 16:20:23 INFO - operating with platform_type : linux_ 16:20:23 INFO - Initialising browser for dromaeo_css test... 16:20:23 INFO - TEST-INFO | started process 14780 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH7pG6W/profile http://localhost:36070/getInfo.html) 16:20:28 INFO - PROCESS | 14780 | __metrics Screen width/height:1600/1200 16:20:28 INFO - PROCESS | 14780 | colorDepth:24 16:20:28 INFO - PROCESS | 14780 | Browser inner width/height: 1024/697 16:20:28 INFO - PROCESS | 14780 | __metrics 16:20:28 ERROR - PROCESS | 14780 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 16:20:29 INFO - TEST-INFO | 14780: exit 0 16:20:29 INFO - Browser initialized. 16:20:29 INFO - Running cycle 1/1 for dromaeo_css test... 16:20:29 INFO - TEST-INFO | started process 14903 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH7pG6W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:20:41 INFO - PROCESS | 14903 | RSS: Main: 191582208 16:20:41 INFO - PROCESS | 14903 | 16:21:31 INFO - PROCESS | 14903 | 1472512891399 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] 16:23:41 INFO - PROCESS | 14903 | Cycle 1(1): loaded http://localhost:36070/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36070/tests/dromaeo/cssquery-ext.html) 16:23:42 INFO - PROCESS | 14903 | RSS: Main: 206925824 16:23:42 INFO - PROCESS | 14903 | 16:26:44 INFO - PROCESS | 14903 | Cycle 1(1): loaded http://localhost:36070/tests/dromaeo/cssquery-ext.html (next: http://localhost:36070/tests/dromaeo/cssquery-jquery.html) 16:26:45 INFO - PROCESS | 14903 | RSS: Main: 200564736 16:26:45 INFO - PROCESS | 14903 | 16:29:47 INFO - PROCESS | 14903 | Cycle 1(1): loaded http://localhost:36070/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36070/tests/dromaeo/cssquery-mootools.html) 16:29:48 INFO - PROCESS | 14903 | RSS: Main: 196481024 16:29:48 INFO - PROCESS | 14903 | 16:32:49 INFO - PROCESS | 14903 | Cycle 1(1): loaded http://localhost:36070/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36070/tests/dromaeo/cssquery-prototype.html) 16:32:50 INFO - PROCESS | 14903 | RSS: Main: 193593344 16:32:50 INFO - PROCESS | 14903 | 16:35:53 INFO - PROCESS | 14903 | Cycle 1(1): loaded http://localhost:36070/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36070/tests/dromaeo/cssquery-yui.html) 16:35:53 INFO - PROCESS | 14903 | RSS: Main: 196935680 16:35:53 INFO - PROCESS | 14903 | 16:38:56 INFO - PROCESS | 14903 | Cycle 1(1): loaded http://localhost:36070/tests/dromaeo/cssquery-yui.html (next: http://localhost:36070/tests/dromaeo/cssquery-dojo.html) 16:38:56 INFO - PROCESS | 14903 | RSS: Main: 197570560 16:38:56 INFO - PROCESS | 14903 | 16:38:56 INFO - PROCESS | 14903 | __start_tp_report 16:38:56 INFO - PROCESS | 14903 | _x_x_mozilla_page_load 16:38:56 INFO - PROCESS | 14903 | _x_x_mozilla_page_load_details 16:38:56 INFO - PROCESS | 14903 | |i|pagename|runs| 16:38:56 INFO - PROCESS | 14903 | |0;dojo.html;3140.7958482698623;3151.9054428367144;3173.5398367236753;3189.8405079746008;3193.8722451101958;5345.866353341168;5473.753681084351;5486.451354864512;5493.066178749612;5540.722963851811;5405.432429594885;5413.485718856702;5456.508914197721;5465.644733092357;5567.721613919308;4874.829380971658;4966.503349665023;5003.324551185598;5019.623528235397;5062.190049592066;5034.270030845543;5086.821961231358;5136.974315128419;5137.101007323722;5194.168932970725;4901.901961960776;4973.4280557735965;4982.60139188864;5065.366829146356;5079.3650793650795;5002.299678045077;5004.874878128039;5007.899842003139;5028.673136246169;5063.316452278932;4961.8511444656715;4970.82602108928;4981.676191047571;4987.6758010729545;5055.3933527976515;5411.675299482044;5432.239486471897;5512.007838589052;5532.5573954083575;5598.992181407345;5880.323762767293;5884.529237660977;5890.234269544974;5894.941050589482;5902.704864756745;5910.054391297372;5912.17229587858;5918.201042859245;5927.081302398092;5928.377520360344;5395.973020134874;5478.945210547883;5533.667979921177;5543.417941116125;5625.437456254342;6039.607425517327;6067.75728970845;6068.4538391544975;6082.817515474543;6092.939070609325;5820.24336836217;5830.7084645767545;5843.649381037151;5846.327672317653;5848.853778655568;5699.116636921284;5807.941920580824;5809.3609702932645;5872.236609240771;5920.259967504062;5794.88410231793;5885.764569417175;5910.113482977587;5911.733971971272;5915.1718759373725;5875.236219291465;5906.645601263938;5911.231539899785;5925.822225333247;5932.19915311436;4552.635789136861;4562.589366956923;4562.61217796491;4569.565891240327;4583.977080114645;4086.223617512663;4097.303458412077;4107.835686572564;4143.461350024538;4166.229247589205;5600.159976003632;5609.411011843697;5618.887622247532;5667.546596272288;5672.234248376416;5703.486686198262;5949.137375080589;5998;6004.459598636144;6010.218671572755;5562.833115006556;5587.664740115606;5593;5623.381428042912;5679.943200567942;5074.873128171751;5080.364954380702;5081.263216833612;5083.186690129562;5159.974200128975;5840.269966254218;6119.908201376983;6127.417895299939;6138.386161383826;6157;5809.970950145223;5850.53195744348;5871.6770577618645;5882.823515294548;5955.166276721349;5981.162637230878;6000.459958603747;6021.608595441282;6022.45797878193;6045.667488288186;5643.181738647955;5761.279840019997;5770;5772.913406298825;5774.39368866263;5863.912041319299;5921.437463440966;5930.851728706817;5941.376155503783;6008.489278411384;5737.942620573908;5754.108113242454;5769.221155144001;5773.653580784999;5803.303603567599;5527.50252477279;5672.546196304368;5712.457316554921;5728.169415434655;5732.398098199629;5699.886002279848;5709.115087161496;5767.480926716616;5772.480476756944;5783.19035335045;5782.624129431573;5785.82642520725;5800.738966746591;5806.709664516842;5826.242588463472;5383.219433182245;5642.040853054908;5642.153676948491;5643.717814109196;5643.830685079454 16:38:56 INFO - PROCESS | 14903 | |1;ext.html;556.4896513756007;594.064348650875;594.0821430889275;611.4222060153155;633.9302676705564;37952.43071353932;42510.362344564855;42730;42904.785476072655;42941;42544.361834572504;42784.572154278445;43388.69833904988;43393.56606433935;43428.3485747714;8793.208611224973;8969.461832290051;8970.147835955573;8976.506292153928;8986;8678.175573320525;8796.8680469793;8823.07357727439;8850.601722922484;8870.201681848632;8922.687705930293;8935.687250946217;8936.151065648786;8969.282457403391;9003.5048072356;8941.239994600466;8954;8981.371304008722;8985.820283594325;8999.865002024975;8815.471071735716;8818.691345802867;8850.495415779333;8870.911290887074;8881.111888811132;41728;41787.582124178676;41876.37185442221;42030.579694203276;42100.57899420997;3484.4773284007347;3609.675129238381;3620.475031120473;3624.619414961444;3722.8696995605296;32796.6720332796;32958;33408.3318333632;33435.33129337424;33485.665143348495;3998.3802510610903;4015.6385925266572;4063.7155399122075;4098.139390727951;4116.547179810218;365445.5915806325;365653;366184.16907915554;366759;369091;56771.71614141903;56788.43211567831;56789;56814.71592642093;57065;36682.81658591743;37263.81368093196;37690.62309376926;39291.60708392879;39346.40980385296;16528.25622846975;16701.91649041747;16725.330986760637;16762.83237167637;16824.327026919033;12424;12512.249265044127;12515.937420313023;12615.30615816139;12629.936850315873;19159.52101197481;19337.323193688153;19348.613027739368;19389.709154362696;19522.70715939262;6821.249662537117;7045.295470453017;7171.812597157813;7349.265073492715;7508.249175082448;943.306669597845;1058.692979036071;1146.6731981385265;1172.4841069929205;1172.806486929664;33204.517390152505;33530.66469335275;33663.4950475743;34089.82955085209;34092.31815363679;1060.8249638809664;1129.0854407929603;1147.74175810442;1159.7448561316496;1177.2289150606366;15480.22598870052;17204.913975430292;17297.56756081083;17319.740203896952;17335.133243337783;563788;564750;570931;572562;572739;59819.700901496086;60316.698416507636;60360.094598581054;60577.697111515045;60623.09065364023;1306.2097431054265;1343.147101590497;1353.7292541491545;1371.6022353517567;1373.3476598615578;30590.388192236474;31150.532742008436;31761.682383175874;32166.552505136857;32510.34979300448;50632.746836265585;50914.490855090975;51307;51420;51599.484005159466;437363;438560;440721;441697;442322;29309.26726831846;29351;29408.558871616515;29718.554221687125;29824;47874.76062619664;49166;49374.50625493699;49479.7526012382;49618.534331910305;41021.794891025354;41175.58824411718;42625.786871065444;42770.35844462273;43762.78118609514;41265.79367103145;41322.58677413307;42519.7874010628;43328.78335608302;43901.78049109734;40883.182336353704;41111;41514.37728434136;41553;44477.33284000678;34704.826475867456;37675.62324376721;38465;40578.59421405866;41044.384334235605;28716.13851584456;28750;28774.7122528772;29231.707682922897;29250.707492924797 16:38:56 INFO - PROCESS | 14903 | |2;jquery.html;400.9599040095991;404.0807163702578;416.1053734470887;416.48564023431055;430.4554738256107;17896.463106106807;19568.51078723031;19644.607107857853;19651.410457686256;19989.300374486895;19207.903960480176;19280.710789338136;19306.32427865025;19328.22687092518;19580.216791328367;5480.6437581557075;5534.889302213954;5651.632643878155;5680.3467601225975;5693.089105743082;5675.829725108253;5677.120046392815;5722.856928576777;5736.311642602894;5741.799037033684;5506.182959623335;5664.320281566218;5670.149477578355;5681.147827825818;5690.2887139107615;5456.154296084113;5632.690202038886;5636.887262254773;5672.8865422691315;5678.545716342683;4941.382327209099;4967.3542439483;4984.800607975677;5018.749062546858;5020.397552293712;22876.88561557198;22987.77012229873;23161.88419057911;23203.071877124894;23217.53564928709;2358.25714899806;2430.793382562484;2447.3881529617597;2452.448199155194;2554.220962606404;14277.571672849726;14728.410863565445;14732.631684207874;14806.333714982851;15352.309146088453;1863.794982551918;1867.6078023615057;1871.23279455424;1879.793222745497;1956.6771482705337;78507.60746196289;78840.60579697123;79255.60372198159;79662;80701;10288.434136122436;10305.433201174008;10331.48342582868;10443.634472793416;10449.791004179873;14675.77986330206;14740.11559306445;14743;14765.187914664797;14924.552263432115;8001.8399632008195;8090.919090809134;8220.63007164679;8267.586620668942;8300.086990431048;7632.694692212361;7735.9613201933635;7736.6518506667335;7913.248241417056;7936.880946785803;6286.245650521967;6335.176427064452;6483.967580162163;6486;6713.765018224339;1881.8870867747978;1918.654642164396;1952.2971730177126;1986.5828176082896;1988.2047181127375;913.8355096082769;998.6953979036464;1009.0666133826328;1034.2656713733334;1106.80630889594;19136.52158696016;20185.798142018684;20224.494387640425;20320.390388288375;20377.490562735755;1010.802893435773;1014.2089170447063;1031.376017509411;1072.6996440996534;1080.1790639114329;10319.226058045677;11527.942360288313;11642.35967021805;11644.126690498246;11704.765904681859;472015;483569;484243;492861;505413;86832.5658371704;87819.18961199856;91235;96411.51794240985;100614;1032.695354870315;1056.1761825775754;1057.846612241236;1068.3963560588243;1070.9678709638724;17560;17684.734728979332;18410.150052471607;18538;18608.44174674762;42205;42440.36339454973;42547.787261063495;42603.57396425996;42818;58217.41782582289;58773.412265876796;59938.70030649819;60763;61625.38374616196;8480.74557763268;8513.40406171562;8547.786305342415;8563;8787.384883058381;11359.602413915803;12773.23360598367;12778.68053298675;13088.80366794518;13791.586252412444;11138.610148644759;11246.1565382595;11602.303861768321;11841.940790295994;11925.15160150178;10905.34567925927;10950.34297942126;11279;11379.146564007568;11565.537378504765;10332.173426126043;11511.30932144074;11561.248518846249;11768.881956214145;11968.76062478763;7571.621418929141;7743.7676869694;7849.372050235853;8152.347812174893;8211.58942052907;11535.826962595736;11580.710482238012;11823.76352472963;11831.290122592673;11904.464299106388 16:38:56 INFO - PROCESS | 14903 | |3;mootools.html;1495.8578935001178;1517.3475405575603;1698.1763844535399;1751.0806826416137;1758.8680848936324;7860.135385107634;8399.076101628816;8583.742487725363;9066.592003359849;9082.364234503579;8841.292696584274;8936.463812171274;8943.41867778594;8949.105089491048;8974.685885993991;2467.062516243829;2490.1160088168713;2498.038255271724;2501.0871032073346;2508.736582658822;2390.486045500217;2462.495188486365;2479.2066538707622;2482.577961746498;2485.527749727546;2408.3256688127267;2426.0902161689364;2438.719547252062;2442.255112190781;2445.8899349529315;2373.038919237703;2380.976190238093;2388.0567175965484;2394.832361734679;2410.7950824179966;2369.206315884181;2388.10446082719;2394.7126344838557;2402.519496100787;2405.8436201646837;8941;9038.86441703375;9041.728748137566;9055.411398259092;9069.954650226706;5185.066687996159;5449.455054494559;5501.037318469292;5519.2824932758485;5535.225068490415;3443;3591.712662986955;3658.963410365889;3667.303212389664;3671.3575124353133;1180.4982882275085;1223.9143259971806;1226.6626677663626;1232.9075319350995;1240.8138779183105;12217.266963982189;12264.693382665415;12342.444589993473;12354;12452;4453.354263631755;4717.2216584263215;4814.614830813526;4838.274258861128;4860.1008813369635;10427.94786026065;10476.423796691102;10497.632582859716;10498.580056797642;10514.894851051391;5434.619576629677;5500.28496295487;5503.367112782082;5514.365847927459;5516.420775818481;4354.586314300136;4903.779329930162;5010.974945125251;5016.423111342169;5081;4081.510218773766;4089.3661482470266;4119.237940980928;4123.546409894909;4181.121964387513;1388.3891087921484;1389.1387339849357;1408.4225467558251;1413.8656827601362;1416.8016477693131;936.9203617692436;969.5588507229335;977.2865807960087;990.9554070066864;1011.7622358745689;5821.301443826768;5880.470757631833;5930.851728706817;5937.228160339215;6191.288001879841;488.3334248750501;490.93863267091615;494.29316078008793;499.66023104289434;500.9974950125299;4312.611864932172;4314.460692413449;4341.782910854445;4467.809447877244;4607.9308810367875;10382.480875956171;10901.890981090088;10908.290961087503;10931.18016148792;10943.726406839733;10751.83872241917;10883.67348979532;10884.292520986111;10914.617988370368;10919.727006824893;7867.803304917423;8182.713605023796;8193.67225310981;8237.50574965504;8333.2916702081;6057.1519987200945;6094.299155596986;6106.664133472702;6277.843053923689;6430.035494675836;9838.114569688476;9981.151602113901;10062.49687515636;10145.79708405813;10186.08325250731;9884.752881178028;10033.799324013626;10084;10111.747206319607;10132.44271565071;7537.849243015218;8168.877466838121;8270.958645206736;8281.254687078192;8451.746447606582;8643.308535317285;8743.562821858754;8744.562771861509;8751.168638979287;8777.736667899973;7558.281963213486;7609.391248700202;7642.5032372895585;7774.533527988338;8089.110197878346;7219;7397.297256760599;7405.185429602847;7620.085589729268;7649.770506884803;6817.761378351734;6919.065926099912;6934.9653251735435;6943.79168624942;6948.756793512202;5221.503957124067;5304.177852432879;5307.9734601326745;5320.680759154463;5531.529819965348;5329.200619907045;5364.544013758874;5388.784448622011;5431.918521222264;5473.781048758005 16:38:56 INFO - PROCESS | 14903 | |4;prototype.html;336.2400973799213;339.93261159957734;348.1366211794749;353.5933676272285;353.7488383247894;5328.254044433782;5460.262864513299;5526.226328314035;5535.391106978229;5562.443755624436;5467.507924286813;5495.313085864267;5495.945040549594;5539.14143307788;5543.944560554393;4284.528701842794;4287.978560107211;4302.870913872589;4317.76252306123;4345.174416860787;4181.60274773896;4294.871153865389;4304.31131019037;4310.159518893817;4336.176126535948;4281;4287.378330142127;4293.763842988635;4319.632831209351;4326.30779075348;4300.741955482666;4301.247281725717;4322.697411181219;4335.848245311399;4378.759168245745;3667.7615954963107;3843.865464708722;3854.614538546151;3859.5754467008605;3869.1681288522823;5390.56875449967;5394.190871369326;5400.324959380077;5420.051490989061;5430.456954304577;4868.683535570212;4869.683470574401;4874.46380898101;4878.56092951636;4878.682885612459;5560.77756889724;5736.942630573682;5772.769089236425;5779.219805326311;5789.131630255453;4160.521540022875;4163.500379954395;4169.937450938239;4176.331786914109;4192.769397683126;6068.453839154453;6113.816585502442;6122.47958923492;6123.785667501661;6128.57100003;3977.3835055566433;4184.121334519724;4291.957080429218;4313.568643135662;4322.113966636832;4198.538160802309;4221.78891055446;4239.435141739265;4248.196190514246;4252;4868.515102893581;4878.414590249193;4897.80003899047;4906.484819094015;4937.382827146606;5614.63504872182;5787.276590426197;5830.4461076197695;5867.266591676041;5929.37741537141;1468.6548661064642;1483.8129496402835;1491.6494623763406;1493.7983372244826;1497.7793098624586;1004.1013293102778;1013.7871047080196;1036.4144258493927;1039.0285083447002;1046;4877.731724755173;4884.535969082932;4886.926696099561;4915.606751459946;4936.234883593049;5207.687538747611;5209.01028804526;5244.265802787613;5245.790168393298;5247.895042099137;4666.859994200179;4877.293102328242;4910.183232204107;4910.631702622318;4911.557959783637;2760.4127626614777;2777.5417056185906;2783.860806959644;2788.288986308519;2813.254487560798;5246.344206974129;5294.841154765363;5300.681959082467;5332.9733351333;5393.973030134903;5109.9744501277255;5169.844904652867;5250.291210686509;5267.473252674702;5316.973415132977;5293.338332708411;5301.496357845998;5319;5361.908855546262;5436.20605200283;5148.6910785353;5177.974110129425;5201;5251.684898906078;5284.7886084556185;4907.515663878686;5047.722375269395;5074.238864170404;5086;5129.281900533853;5258.8956319171875;5300.316280185389;5349.261490015839;5377.650452720561;5384.6230763847725;3814.9127498662747;3832.4826148470715;3833.750806197588;3835.9616403835603;3879.84480620772;5008.924866127084;5142.280080788767;5143.485651434827;5806.071028635398;6001.07965451069;5889.882202355843;5895.204147440212;5913.201717768046;5949.8215053548465;5958;5867.119932010232;5877.265341832271;5893.823185304448;5911.970440147772;5916.230889984447;5679.432056794452;5811.883762324645;5839.0949402842625;5842.211301474416;5846.210761547137;5875.5604876805455;5936.584439089395;5944.821655350346;5980.37206093354;5982.760689572542;5527.871769368741;5728;5746.109353050284;5748.137779333133;5750.131207357709 16:38:56 INFO - PROCESS | 14903 | |5;yui.html;717.2361435071645;730.8757511223093;779.1779672445567;810.8175660476397;811.5414790643284;15553.533393998185;16008.919955400235;16525.173741312945;16632.58418539537;16806;15140.545783626509;15224.543263702079;15374.154421506813;15421.614459638515;15441;657.8355411147213;783.2598194706005;795.9363250939911;814.645629151321;815.2703330519182;815.9388045896552;829.8049958259804;830.7383174300077;830.9875351869727;832.6877420967137;856.0540602634093;856.7386946981168;866.8439680857443;873.0832625742976;874.3486102853351;859.6905114158898;860.4149178558578;862.4006315610653;863.2187869977649;865.2861389353808;628.8710814283061;632.6804963493453;635.8887194740902;636.2015670333748;636.5162476517834;15691;15801.051936883823;15865.682686346325;15876.586533895268;15881.761773573406;15062.849371506254;15653.807527617808;15692.607684807857;15698.529044128694;15975.840241597667;11929.701757456047;12036.759264814742;12041.518339266418;12092.032637389077;12726.618201453972;3971.1462035662184;4009.7794621295816;4012.0972781124015;4055.087605288816;4147.4815648044;76747;76858;77681.22318776853;78157;78192.60903695502;11593.362365070003;11972.221805582609;12009.519619215309;12038.217515861616;12089.093318001185;22990.770092299197;23075.307740767803;23167.073317067465;23167.768322316897;23506.88246558756;8146.837063258702;8642.265407440438;8747.65009399617;8772.78068048304;8788.252998495072;4608.331791890158;4635.304704294383;4657.394538709946;4657.953420465819;4718.834840780556;3440.9655903441144;3567.500549923013;3568.839402226906;3704.7406681532034;3887.183691424776;654.4306453385585;669.0399277037369;672.1027428383163;678.9694463749144;684.7945616315086;639.6769631336145;687.3573209049555;687.621808005595;688.2016860441863;700.1178515071047;9367.859482107773;9882.4564648945;10047.648332308334;10101.19190464761;10184.185265178769;716.8602122586045;722.0973782771536;722.151472020374;727.1673933346289;762.268222506389;4646.465656449484;4776.737279449663;4941.950580494221;4948.38145231846;5004.799808007639;126573;126983.365083174;127770;130779;131222;77793.2220677786;80319.19680803118;104851.4757426208;109184;111361;78740.60629696815;79735;80541;82236.17763822405;83146.58426707827;9403.388779729295;9816;9924.702258932244;10002;10087.747806304607;45784.7710761444;46109;47031;47749.283760742925;49090.08664184461;64422;68119.3188068113;69294;69415.65292173506;72913.6354318225;12260.448279827251;12555.183913045623;12585;13074.28091454979;13168.670783230496;14213.21827299467;14578.198199098728;14600.26998650042;14762.409503619734;15436.382544698086;13666.93166534161;14322.856771432153;14399.280035998368;14600;14709.852901470847;13812.447502100205;14153.08004979673;14525.201113938412;14528.273586320853;14785.260736963324;13456.596302110953;13660.93169534146;14351.784723229368;14433.422663093359;14453.638659033608;10550.841737373792;10841.837372439262;10923.945380273048;11066.502007409525;11140.777184456427;10147.289689721649;10527.78609198855;11333.979941804948;11486.94256528712;11564.363959982282 16:38:56 INFO - PROCESS | 14903 | __end_tp_report 16:38:56 INFO - PROCESS | 14903 | __start_cc_report 16:38:56 INFO - PROCESS | 14903 | _x_x_mozilla_cycle_collect,313 16:38:56 INFO - PROCESS | 14903 | __end_cc_report 16:38:56 INFO - PROCESS | 14903 | __startTimestamp1472513936490__endTimestamp 16:38:56 INFO - PROCESS | 14903 | 16:38:56 INFO - PROCESS | 14903 | ------- Summary: start ------- 16:38:56 INFO - PROCESS | 14903 | Number of tests: 6 16:38:56 INFO - PROCESS | 14903 | 16:38:56 INFO - PROCESS | 14903 | [#0] dojo.html Cycles:165 Average:5477.09 Median:5679.94 stddev:611.10 (10.8%) stddev-sans-first:584.85 16:38:56 INFO - PROCESS | 14903 | Values: 3140.8 3151.9 3173.5 3189.8 3193.9 5345.9 5473.8 5486.5 5493.1 5540.7 5405.4 5413.5 5456.5 5465.6 5567.7 4874.8 4966.5 5003.3 5019.6 5062.2 5034.3 5086.8 5137.0 5137.1 5194.2 4901.9 4973.4 4982.6 5065.4 5079.4 5002.3 5004.9 5007.9 5028.7 5063.3 4961.9 4970.8 4981.7 4987.7 5055.4 5411.7 5432.2 5512.0 5532.6 5599.0 5880.3 5884.5 5890.2 5894.9 5902.7 5910.1 5912.2 5918.2 5927.1 5928.4 5396.0 5478.9 5533.7 5543.4 5625.4 6039.6 6067.8 6068.5 6082.8 6092.9 5820.2 5830.7 5843.6 5846.3 5848.9 5699.1 5807.9 5809.4 5872.2 5920.3 5794.9 5885.8 5910.1 5911.7 5915.2 5875.2 5906.6 5911.2 5925.8 5932.2 4552.6 4562.6 4562.6 4569.6 4584.0 4086.2 4097.3 4107.8 4143.5 4166.2 5600.2 5609.4 5618.9 5667.5 5672.2 5703.5 5949.1 5998.0 6004.5 6010.2 5562.8 5587.7 5593.0 5623.4 5679.9 5074.9 5080.4 5081.3 5083.2 5160.0 5840.3 6119.9 6127.4 6138.4 6157.0 5810.0 5850.5 5871.7 5882.8 5955.2 5981.2 6000.5 6021.6 6022.5 6045.7 5643.2 5761.3 5770.0 5772.9 5774.4 5863.9 5921.4 5930.9 5941.4 6008.5 5737.9 5754.1 5769.2 5773.7 5803.3 5527.5 5672.5 5712.5 5728.2 5732.4 5699.9 5709.1 5767.5 5772.5 5783.2 5782.6 5785.8 5800.7 5806.7 5826.2 5383.2 5642.0 5642.2 5643.7 5643.8 16:38:56 INFO - PROCESS | 14903 | 16:38:56 INFO - PROCESS | 14903 | [#1] ext.html Cycles:180 Average:61369.50 Median:41418.48 stddev:123763.61 (298.8%) stddev-sans-first:124026.58 16:38:56 INFO - PROCESS | 14903 | Values: 556.5 594.1 594.1 611.4 633.9 37952.4 42510.4 42730.0 42904.8 42941.0 42544.4 42784.6 43388.7 43393.6 43428.3 8793.2 8969.5 8970.1 8976.5 8986.0 8678.2 8796.9 8823.1 8850.6 8870.2 8922.7 8935.7 8936.2 8969.3 9003.5 8941.2 8954.0 8981.4 8985.8 8999.9 8815.5 8818.7 8850.5 8870.9 8881.1 41728.0 41787.6 41876.4 42030.6 42100.6 3484.5 3609.7 3620.5 3624.6 3722.9 32796.7 32958.0 33408.3 33435.3 33485.7 3998.4 4015.6 4063.7 4098.1 4116.5 365445.6 365653.0 366184.2 366759.0 369091.0 56771.7 56788.4 56789.0 56814.7 57065.0 36682.8 37263.8 37690.6 39291.6 39346.4 16528.3 16701.9 16725.3 16762.8 16824.3 12424.0 12512.2 12515.9 12615.3 12629.9 19159.5 19337.3 19348.6 19389.7 19522.7 6821.2 7045.3 7171.8 7349.3 7508.2 943.3 1058.7 1146.7 1172.5 1172.8 33204.5 33530.7 33663.5 34089.8 34092.3 1060.8 1129.1 1147.7 1159.7 1177.2 15480.2 17204.9 17297.6 17319.7 17335.1 563788.0 564750.0 570931.0 572562.0 572739.0 59819.7 60316.7 60360.1 60577.7 60623.1 1306.2 1343.1 1353.7 1371.6 1373.3 30590.4 31150.5 31761.7 32166.6 32510.3 50632.7 50914.5 51307.0 51420.0 51599.5 437363.0 438560.0 440721.0 441697.0 442322.0 29309.3 29351.0 29408.6 29718.6 29824.0 47874.8 49166.0 49374.5 49479.8 49618.5 41021.8 41175.6 42625.8 42770.4 43762.8 41265.8 41322.6 42519.8 43328.8 43901.8 40883.2 41111.0 41514.4 41553.0 44477.3 34704.8 37675.6 38465.0 40578.6 41044.4 28716.1 28750.0 28774.7 29231.7 29250.7 16:38:56 INFO - PROCESS | 14903 | 16:38:56 INFO - PROCESS | 14903 | [#2] jquery.html Cycles:180 Average:29117.34 Median:23074.83 stddev:80418.81 (348.5%) stddev-sans-first:80615.50 16:38:56 INFO - PROCESS | 14903 | Values: 401.0 404.1 416.1 416.5 430.5 17896.5 19568.5 19644.6 19651.4 19989.3 19207.9 19280.7 19306.3 19328.2 19580.2 5480.6 5534.9 5651.6 5680.3 5693.1 5675.8 5677.1 5722.9 5736.3 5741.8 5506.2 5664.3 5670.1 5681.1 5690.3 5456.2 5632.7 5636.9 5672.9 5678.5 4941.4 4967.4 4984.8 5018.7 5020.4 22876.9 22987.8 23161.9 23203.1 23217.5 2358.3 2430.8 2447.4 2452.4 2554.2 14277.6 14728.4 14732.6 14806.3 15352.3 1863.8 1867.6 1871.2 1879.8 1956.7 78507.6 78840.6 79255.6 79662.0 80701.0 10288.4 10305.4 10331.5 10443.6 10449.8 14675.8 14740.1 14743.0 14765.2 14924.6 8001.8 8090.9 8220.6 8267.6 8300.1 7632.7 7736.0 7736.7 7913.2 7936.9 6286.2 6335.2 6484.0 6486.0 6713.8 1881.9 1918.7 1952.3 1986.6 1988.2 913.8 998.7 1009.1 1034.3 1106.8 19136.5 20185.8 20224.5 20320.4 20377.5 1010.8 1014.2 1031.4 1072.7 1080.2 10319.2 11527.9 11642.4 11644.1 11704.8 472015.0 483569.0 484243.0 492861.0 505413.0 86832.6 87819.2 91235.0 96411.5 100614.0 1032.7 1056.2 1057.8 1068.4 1071.0 17560.0 17684.7 18410.2 18538.0 18608.4 42205.0 42440.4 42547.8 42603.6 42818.0 58217.4 58773.4 59938.7 60763.0 61625.4 8480.7 8513.4 8547.8 8563.0 8787.4 11359.6 12773.2 12778.7 13088.8 13791.6 11138.6 11246.2 11602.3 11841.9 11925.2 10905.3 10950.3 11279.0 11379.1 11565.5 10332.2 11511.3 11561.2 11768.9 11968.8 7571.6 7743.8 7849.4 8152.3 8211.6 11535.8 11580.7 11823.8 11831.3 11904.5 16:38:56 INFO - PROCESS | 14903 | 16:38:56 INFO - PROCESS | 14903 | [#3] mootools.html Cycles:180 Average:5881.93 Median:2697.36 stddev:3280.66 (121.6%) stddev-sans-first:3273.31 16:38:56 INFO - PROCESS | 14903 | Values: 1495.9 1517.3 1698.2 1751.1 1758.9 7860.1 8399.1 8583.7 9066.6 9082.4 8841.3 8936.5 8943.4 8949.1 8974.7 2467.1 2490.1 2498.0 2501.1 2508.7 2390.5 2462.5 2479.2 2482.6 2485.5 2408.3 2426.1 2438.7 2442.3 2445.9 2373.0 2381.0 2388.1 2394.8 2410.8 2369.2 2388.1 2394.7 2402.5 2405.8 8941.0 9038.9 9041.7 9055.4 9070.0 5185.1 5449.5 5501.0 5519.3 5535.2 3443.0 3591.7 3659.0 3667.3 3671.4 1180.5 1223.9 1226.7 1232.9 1240.8 12217.3 12264.7 12342.4 12354.0 12452.0 4453.4 4717.2 4814.6 4838.3 4860.1 10427.9 10476.4 10497.6 10498.6 10514.9 5434.6 5500.3 5503.4 5514.4 5516.4 4354.6 4903.8 5011.0 5016.4 5081.0 4081.5 4089.4 4119.2 4123.5 4181.1 1388.4 1389.1 1408.4 1413.9 1416.8 936.9 969.6 977.3 991.0 1011.8 5821.3 5880.5 5930.9 5937.2 6191.3 488.3 490.9 494.3 499.7 501.0 4312.6 4314.5 4341.8 4467.8 4607.9 10382.5 10901.9 10908.3 10931.2 10943.7 10751.8 10883.7 10884.3 10914.6 10919.7 7867.8 8182.7 8193.7 8237.5 8333.3 6057.2 6094.3 6106.7 6277.8 6430.0 9838.1 9981.2 10062.5 10145.8 10186.1 9884.8 10033.8 10084.0 10111.7 10132.4 7537.8 8168.9 8271.0 8281.3 8451.7 8643.3 8743.6 8744.6 8751.2 8777.7 7558.3 7609.4 7642.5 7774.5 8089.1 7219.0 7397.3 7405.2 7620.1 7649.8 6817.8 6919.1 6935.0 6943.8 6948.8 5221.5 5304.2 5308.0 5320.7 5531.5 5329.2 5364.5 5388.8 5431.9 5473.8 16:38:56 INFO - PROCESS | 14903 | 16:38:56 INFO - PROCESS | 14903 | [#4] prototype.html Cycles:180 Average:4669.67 Median:5119.63 stddev:1347.79 (26.3%) stddev-sans-first:1311.74 16:38:56 INFO - PROCESS | 14903 | Values: 336.2 339.9 348.1 353.6 353.7 5328.3 5460.3 5526.2 5535.4 5562.4 5467.5 5495.3 5495.9 5539.1 5543.9 4284.5 4288.0 4302.9 4317.8 4345.2 4181.6 4294.9 4304.3 4310.2 4336.2 4281.0 4287.4 4293.8 4319.6 4326.3 4300.7 4301.2 4322.7 4335.8 4378.8 3667.8 3843.9 3854.6 3859.6 3869.2 5390.6 5394.2 5400.3 5420.1 5430.5 4868.7 4869.7 4874.5 4878.6 4878.7 5560.8 5736.9 5772.8 5779.2 5789.1 4160.5 4163.5 4169.9 4176.3 4192.8 6068.5 6113.8 6122.5 6123.8 6128.6 3977.4 4184.1 4292.0 4313.6 4322.1 4198.5 4221.8 4239.4 4248.2 4252.0 4868.5 4878.4 4897.8 4906.5 4937.4 5614.6 5787.3 5830.4 5867.3 5929.4 1468.7 1483.8 1491.6 1493.8 1497.8 1004.1 1013.8 1036.4 1039.0 1046.0 4877.7 4884.5 4886.9 4915.6 4936.2 5207.7 5209.0 5244.3 5245.8 5247.9 4666.9 4877.3 4910.2 4910.6 4911.6 2760.4 2777.5 2783.9 2788.3 2813.3 5246.3 5294.8 5300.7 5333.0 5394.0 5110.0 5169.8 5250.3 5267.5 5317.0 5293.3 5301.5 5319.0 5361.9 5436.2 5148.7 5178.0 5201.0 5251.7 5284.8 4907.5 5047.7 5074.2 5086.0 5129.3 5258.9 5300.3 5349.3 5377.7 5384.6 3814.9 3832.5 3833.8 3836.0 3879.8 5008.9 5142.3 5143.5 5806.1 6001.1 5889.9 5895.2 5913.2 5949.8 5958.0 5867.1 5877.3 5893.8 5912.0 5916.2 5679.4 5811.9 5839.1 5842.2 5846.2 5875.6 5936.6 5944.8 5980.4 5982.8 5527.9 5728.0 5746.1 5748.1 5750.1 16:38:56 INFO - PROCESS | 14903 | 16:38:56 INFO - PROCESS | 14903 | [#5] yui.html Cycles:180 Average:20962.20 Median:4033.59 stddev:30467.35 (755.3%) stddev-sans-first:30514.89 16:38:56 INFO - PROCESS | 14903 | Values: 717.2 730.9 779.2 810.8 811.5 15553.5 16008.9 16525.2 16632.6 16806.0 15140.5 15224.5 15374.2 15421.6 15441.0 657.8 783.3 795.9 814.6 815.3 815.9 829.8 830.7 831.0 832.7 856.1 856.7 866.8 873.1 874.3 859.7 860.4 862.4 863.2 865.3 628.9 632.7 635.9 636.2 636.5 15691.0 15801.1 15865.7 15876.6 15881.8 15062.8 15653.8 15692.6 15698.5 15975.8 11929.7 12036.8 12041.5 12092.0 12726.6 3971.1 4009.8 4012.1 4055.1 4147.5 76747.0 76858.0 77681.2 78157.0 78192.6 11593.4 11972.2 12009.5 12038.2 12089.1 22990.8 23075.3 23167.1 23167.8 23506.9 8146.8 8642.3 8747.7 8772.8 8788.3 4608.3 4635.3 4657.4 4658.0 4718.8 3441.0 3567.5 3568.8 3704.7 3887.2 654.4 669.0 672.1 679.0 684.8 639.7 687.4 687.6 688.2 700.1 9367.9 9882.5 10047.6 10101.2 10184.2 716.9 722.1 722.2 727.2 762.3 4646.5 4776.7 4942.0 4948.4 5004.8 126573.0 126983.4 127770.0 130779.0 131222.0 77793.2 80319.2 104851.5 109184.0 111361.0 78740.6 79735.0 80541.0 82236.2 83146.6 9403.4 9816.0 9924.7 10002.0 10087.7 45784.8 46109.0 47031.0 47749.3 49090.1 64422.0 68119.3 69294.0 69415.7 72913.6 12260.4 12555.2 12585.0 13074.3 13168.7 14213.2 14578.2 14600.3 14762.4 15436.4 13666.9 14322.9 14399.3 14600.0 14709.9 13812.4 14153.1 14525.2 14528.3 14785.3 13456.6 13660.9 14351.8 14433.4 14453.6 10550.8 10841.8 10923.9 11066.5 11140.8 10147.3 10527.8 11334.0 11486.9 11564.4 16:38:56 INFO - PROCESS | 14903 | -------- Summary: end -------- 16:38:56 INFO - PROCESS | 14903 | 16:38:57 INFO - TEST-INFO | 14903: exit 0 16:38:57 INFO - TEST-OK | dromaeo_css | took 1114293ms 16:38:57 INFO - TEST-START | kraken 16:38:57 INFO - operating with platform_type : linux_ 16:38:57 INFO - Initialising browser for kraken test... 16:38:57 INFO - TEST-INFO | started process 15262 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT5NVM7/profile http://localhost:36070/getInfo.html) 16:39:02 INFO - PROCESS | 15262 | __metrics Screen width/height:1600/1200 16:39:02 INFO - PROCESS | 15262 | colorDepth:24 16:39:02 INFO - PROCESS | 15262 | Browser inner width/height: 1024/697 16:39:02 INFO - PROCESS | 15262 | __metrics 16:39:02 ERROR - PROCESS | 15262 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 16:39:03 INFO - TEST-INFO | 15262: exit 0 16:39:03 INFO - Browser initialized. 16:39:03 INFO - Running cycle 1/1 for kraken test... 16:39:03 INFO - TEST-INFO | started process 15383 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT5NVM7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:39:15 INFO - PROCESS | 15383 | RSS: Main: 191836160 16:39:15 INFO - PROCESS | 15383 | 16:39:18 INFO - PROCESS | 15383 | Cycle 1(1): loaded http://localhost:36070/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36070/tests/kraken/driver.html?testName=audio-beat-detection) 16:39:19 INFO - PROCESS | 15383 | RSS: Main: 204984320 16:39:19 INFO - PROCESS | 15383 | 16:39:22 INFO - PROCESS | 15383 | Cycle 1(1): loaded http://localhost:36070/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36070/tests/kraken/driver.html?testName=audio-dft) 16:39:22 INFO - PROCESS | 15383 | RSS: Main: 203583488 16:39:22 INFO - PROCESS | 15383 | 16:39:25 INFO - PROCESS | 15383 | Cycle 1(1): loaded http://localhost:36070/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36070/tests/kraken/driver.html?testName=audio-fft) 16:39:26 INFO - PROCESS | 15383 | RSS: Main: 195072000 16:39:26 INFO - PROCESS | 15383 | 16:39:28 INFO - PROCESS | 15383 | Cycle 1(1): loaded http://localhost:36070/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36070/tests/kraken/driver.html?testName=audio-oscillator) 16:39:28 INFO - PROCESS | 15383 | RSS: Main: 195391488 16:39:28 INFO - PROCESS | 15383 | 16:39:31 INFO - PROCESS | 15383 | Cycle 1(1): loaded http://localhost:36070/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36070/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:39:31 INFO - PROCESS | 15383 | RSS: Main: 195678208 16:39:31 INFO - PROCESS | 15383 | 16:39:34 INFO - PROCESS | 15383 | Cycle 1(1): loaded http://localhost:36070/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36070/tests/kraken/driver.html?testName=imaging-darkroom) 16:39:35 INFO - PROCESS | 15383 | RSS: Main: 196280320 16:39:35 INFO - PROCESS | 15383 | 16:39:38 INFO - PROCESS | 15383 | Cycle 1(1): loaded http://localhost:36070/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36070/tests/kraken/driver.html?testName=imaging-desaturate) 16:39:39 INFO - PROCESS | 15383 | RSS: Main: 193273856 16:39:39 INFO - PROCESS | 15383 | 16:39:42 INFO - PROCESS | 15383 | Cycle 1(1): loaded http://localhost:36070/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36070/tests/kraken/driver.html?testName=json-parse-financial) 16:39:42 INFO - PROCESS | 15383 | RSS: Main: 195297280 16:39:42 INFO - PROCESS | 15383 | 16:39:44 INFO - PROCESS | 15383 | Cycle 1(1): loaded http://localhost:36070/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36070/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:39:45 INFO - PROCESS | 15383 | RSS: Main: 195403776 16:39:45 INFO - PROCESS | 15383 | 16:39:46 INFO - PROCESS | 15383 | Cycle 1(1): loaded http://localhost:36070/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36070/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:39:47 INFO - PROCESS | 15383 | RSS: Main: 195735552 16:39:47 INFO - PROCESS | 15383 | 16:39:49 INFO - PROCESS | 15383 | Cycle 1(1): loaded http://localhost:36070/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36070/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:39:50 INFO - PROCESS | 15383 | RSS: Main: 196214784 16:39:50 INFO - PROCESS | 15383 | 16:39:53 INFO - PROCESS | 15383 | Cycle 1(1): loaded http://localhost:36070/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36070/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:39:53 INFO - PROCESS | 15383 | RSS: Main: 195960832 16:39:53 INFO - PROCESS | 15383 | 16:39:56 INFO - PROCESS | 15383 | Cycle 1(1): loaded http://localhost:36070/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36070/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:39:57 INFO - PROCESS | 15383 | RSS: Main: 196362240 16:39:57 INFO - PROCESS | 15383 | 16:39:58 INFO - PROCESS | 15383 | Cycle 1(1): loaded http://localhost:36070/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36070/tests/kraken/driver.html?testName=ai-astar) 16:39:59 INFO - PROCESS | 15383 | RSS: Main: 198008832 16:39:59 INFO - PROCESS | 15383 | 16:39:59 INFO - PROCESS | 15383 | __start_tp_report 16:39:59 INFO - PROCESS | 15383 | _x_x_mozilla_page_load 16:39:59 INFO - PROCESS | 15383 | _x_x_mozilla_page_load_details 16:39:59 INFO - PROCESS | 15383 | |i|pagename|runs| 16:39:59 INFO - PROCESS | 15383 | |0;ai-astar;108;114;113;116;114;116;116;115;112;132 16:39:59 INFO - PROCESS | 15383 | |1;audio-beat-detection;149;125;150;191;118;146;151;120;175;120 16:39:59 INFO - PROCESS | 15383 | |2;audio-dft;163;164;167;175;161;162;161;163;161;167 16:39:59 INFO - PROCESS | 15383 | |3;audio-fft;75;77;77;181;76;77;75;75;165;77 16:39:59 INFO - PROCESS | 15383 | |4;audio-oscillator;83;81;145;83;82;82;148;89;81;146 16:39:59 INFO - PROCESS | 15383 | |5;imaging-gaussian-blur;118;118;119;118;117;117;117;117;117;117 16:39:59 INFO - PROCESS | 15383 | |6;imaging-darkroom;147;147;147;146;148;148;148;148;146;147 16:39:59 INFO - PROCESS | 15383 | |7;imaging-desaturate;96;96;95;95;95;95;95;95;97;96 16:39:59 INFO - PROCESS | 15383 | |8;json-parse-financial;52;54;54;55;53;54;55;53;54;54 16:39:59 INFO - PROCESS | 15383 | |9;json-stringify-tinderbox;69;63;63;64;63;63;64;64;63;63 16:39:59 INFO - PROCESS | 15383 | |10;stanford-crypto-aes;80;83;85;80;80;81;81;81;80;80 16:39:59 INFO - PROCESS | 15383 | |11;stanford-crypto-ccm;126;128;139;141;147;133;129;126;165;140 16:39:59 INFO - PROCESS | 15383 | |12;stanford-crypto-pbkdf2;168;164;169;164;168;164;163;168;168;169 16:39:59 INFO - PROCESS | 15383 | |13;stanford-crypto-sha256-iterative;67;67;66;66;64;65;65;65;67;65 16:39:59 INFO - PROCESS | 15383 | __end_tp_report 16:39:59 INFO - PROCESS | 15383 | __start_cc_report 16:39:59 INFO - PROCESS | 15383 | _x_x_mozilla_cycle_collect,849 16:39:59 INFO - PROCESS | 15383 | __end_cc_report 16:39:59 INFO - PROCESS | 15383 | __startTimestamp1472513999101__endTimestamp 16:39:59 INFO - PROCESS | 15383 | 16:39:59 INFO - PROCESS | 15383 | ------- Summary: start ------- 16:39:59 INFO - PROCESS | 15383 | Number of tests: 14 16:39:59 INFO - PROCESS | 15383 | 16:39:59 INFO - PROCESS | 15383 | [#0] ai-astar Cycles:10 Average:115.60 Median:115.50 stddev:6.26 (5.4%) stddev-sans-first:6.00 16:39:59 INFO - PROCESS | 15383 | Values: 108.0 114.0 113.0 116.0 114.0 116.0 116.0 115.0 112.0 132.0 16:39:59 INFO - PROCESS | 15383 | 16:39:59 INFO - PROCESS | 15383 | [#1] audio-beat-detection Cycles:10 Average:144.50 Median:149.50 stddev:24.65 (16.5%) stddev-sans-first:26.10 16:39:59 INFO - PROCESS | 15383 | Values: 149.0 125.0 150.0 191.0 118.0 146.0 151.0 120.0 175.0 120.0 16:39:59 INFO - PROCESS | 15383 | 16:39:59 INFO - PROCESS | 15383 | [#2] audio-dft Cycles:10 Average:164.40 Median:163.50 stddev:4.35 (2.7%) stddev-sans-first:4.59 16:39:59 INFO - PROCESS | 15383 | Values: 163.0 164.0 167.0 175.0 161.0 162.0 161.0 163.0 161.0 167.0 16:39:59 INFO - PROCESS | 15383 | 16:39:59 INFO - PROCESS | 15383 | [#3] audio-fft Cycles:10 Average:95.50 Median:76.50 stddev:41.03 (53.6%) stddev-sans-first:42.84 16:39:59 INFO - PROCESS | 15383 | Values: 75.0 77.0 77.0 181.0 76.0 77.0 75.0 75.0 165.0 77.0 16:39:59 INFO - PROCESS | 15383 | 16:39:59 INFO - PROCESS | 15383 | [#4] audio-oscillator Cycles:10 Average:102.00 Median:82.00 stddev:30.68 (37.4%) stddev-sans-first:31.77 16:39:59 INFO - PROCESS | 15383 | Values: 83.0 81.0 145.0 83.0 82.0 82.0 148.0 89.0 81.0 146.0 16:39:59 INFO - PROCESS | 15383 | 16:39:59 INFO - PROCESS | 15383 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 16:39:59 INFO - PROCESS | 15383 | Values: 118.0 118.0 119.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 16:39:59 INFO - PROCESS | 15383 | 16:39:59 INFO - PROCESS | 15383 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 16:39:59 INFO - PROCESS | 15383 | Values: 147.0 147.0 147.0 146.0 148.0 148.0 148.0 148.0 146.0 147.0 16:39:59 INFO - PROCESS | 15383 | 16:39:59 INFO - PROCESS | 15383 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 16:39:59 INFO - PROCESS | 15383 | Values: 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 97.0 96.0 16:39:59 INFO - PROCESS | 15383 | 16:39:59 INFO - PROCESS | 15383 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:0.92 (1.7%) stddev-sans-first:0.71 16:39:59 INFO - PROCESS | 15383 | Values: 52.0 54.0 54.0 55.0 53.0 54.0 55.0 53.0 54.0 54.0 16:39:59 INFO - PROCESS | 15383 | 16:39:59 INFO - PROCESS | 15383 | [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:63.50 stddev:1.85 (2.9%) stddev-sans-first:0.50 16:39:59 INFO - PROCESS | 15383 | Values: 69.0 63.0 63.0 64.0 63.0 63.0 64.0 64.0 63.0 63.0 16:39:59 INFO - PROCESS | 15383 | 16:39:59 INFO - PROCESS | 15383 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:81.00 stddev:1.66 (2.1%) stddev-sans-first:1.72 16:39:59 INFO - PROCESS | 15383 | Values: 80.0 83.0 85.0 80.0 80.0 81.0 81.0 81.0 80.0 80.0 16:39:59 INFO - PROCESS | 15383 | 16:39:59 INFO - PROCESS | 15383 | [#11] stanford-crypto-ccm Cycles:10 Average:137.40 Median:139.50 stddev:12.08 (8.7%) stddev-sans-first:12.09 16:39:59 INFO - PROCESS | 15383 | Values: 126.0 128.0 139.0 141.0 147.0 133.0 129.0 126.0 165.0 140.0 16:39:59 INFO - PROCESS | 15383 | 16:39:59 INFO - PROCESS | 15383 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.50 Median:168.00 stddev:2.42 (1.4%) stddev-sans-first:2.50 16:39:59 INFO - PROCESS | 15383 | Values: 168.0 164.0 169.0 164.0 168.0 164.0 163.0 168.0 168.0 169.0 16:39:59 INFO - PROCESS | 15383 | 16:39:59 INFO - PROCESS | 15383 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.00 stddev:1.06 (1.6%) stddev-sans-first:1.01 16:39:59 INFO - PROCESS | 15383 | Values: 67.0 67.0 66.0 66.0 64.0 65.0 65.0 65.0 67.0 65.0 16:39:59 INFO - PROCESS | 15383 | -------- Summary: end -------- 16:39:59 INFO - PROCESS | 15383 | 16:40:00 INFO - TEST-INFO | 15383: exit 0 16:40:00 INFO - TEST-OK | kraken | took 62705ms 16:40:00 INFO - SUITE-END | took 1176s 16:40:00 INFO - Completed test suite (00:19:37) 16:40:00 INFO - javascript benchmark 16:40:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7341.606484050857, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3140.7958482698623, 3151.9054428367144, 3173.5398367236753, 3189.8405079746008, 3193.8722451101958, 5345.866353341168, 5473.753681084351, 5486.451354864512, 5493.066178749612, 5540.722963851811, 5405.432429594885, 5413.485718856702, 5456.508914197721, 5465.644733092357, 5567.721613919308, 4874.829380971658, 4966.503349665023, 5003.324551185598, 5019.623528235397, 5062.190049592066, 5034.270030845543, 5086.821961231358, 5136.974315128419, 5137.101007323722, 5194.168932970725, 4901.901961960776, 4973.4280557735965, 4982.60139188864, 5065.366829146356, 5079.3650793650795, 5002.299678045077, 5004.874878128039, 5007.899842003139, 5028.673136246169, 5063.316452278932, 4961.8511444656715, 4970.82602108928, 4981.676191047571, 4987.6758010729545, 5055.3933527976515, 5411.675299482044, 5432.239486471897, 5512.007838589052, 5532.5573954083575, 5598.992181407345, 5880.323762767293, 5884.529237660977, 5890.234269544974, 5894.941050589482, 5902.704864756745, 5910.054391297372, 5912.17229587858, 5918.201042859245, 5927.081302398092, 5928.377520360344, 5395.973020134874, 5478.945210547883, 5533.667979921177, 5543.417941116125, 5625.437456254342, 6039.607425517327, 6067.75728970845, 6068.4538391544975, 6082.817515474543, 6092.939070609325, 5820.24336836217, 5830.7084645767545, 5843.649381037151, 5846.327672317653, 5848.853778655568, 5699.116636921284, 5807.941920580824, 5809.3609702932645, 5872.236609240771, 5920.259967504062, 5794.88410231793, 5885.764569417175, 5910.113482977587, 5911.733971971272, 5915.1718759373725, 5875.236219291465, 5906.645601263938, 5911.231539899785, 5925.822225333247, 5932.19915311436, 4552.635789136861, 4562.589366956923, 4562.61217796491, 4569.565891240327, 4583.977080114645, 4086.223617512663, 4097.303458412077, 4107.835686572564, 4143.461350024538, 4166.229247589205, 5600.159976003632, 5609.411011843697, 5618.887622247532, 5667.546596272288, 5672.234248376416, 5703.486686198262, 5949.137375080589, 5998.0, 6004.459598636144, 6010.218671572755, 5562.833115006556, 5587.664740115606, 5593.0, 5623.381428042912, 5679.943200567942, 5074.873128171751, 5080.364954380702, 5081.263216833612, 5083.186690129562, 5159.974200128975, 5840.269966254218, 6119.908201376983, 6127.417895299939, 6138.386161383826, 6157.0, 5809.970950145223, 5850.53195744348, 5871.6770577618645, 5882.823515294548, 5955.166276721349, 5981.162637230878, 6000.459958603747, 6021.608595441282, 6022.45797878193, 6045.667488288186, 5643.181738647955, 5761.279840019997, 5770.0, 5772.913406298825, 5774.39368866263, 5863.912041319299, 5921.437463440966, 5930.851728706817, 5941.376155503783, 6008.489278411384, 5737.942620573908, 5754.108113242454, 5769.221155144001, 5773.653580784999, 5803.303603567599, 5527.50252477279, 5672.546196304368, 5712.457316554921, 5728.169415434655, 5732.398098199629, 5699.886002279848, 5709.115087161496, 5767.480926716616, 5772.480476756944, 5783.19035335045, 5782.624129431573, 5785.82642520725, 5800.738966746591, 5806.709664516842, 5826.242588463472, 5383.219433182245, 5642.040853054908, 5642.153676948491, 5643.717814109196, 5643.830685079454], "value": 5436.412675976682, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.4896513756007, 594.064348650875, 594.0821430889275, 611.4222060153155, 633.9302676705564, 37952.43071353932, 42510.362344564855, 42730.0, 42904.785476072655, 42941.0, 42544.361834572504, 42784.572154278445, 43388.69833904988, 43393.56606433935, 43428.3485747714, 8793.208611224973, 8969.461832290051, 8970.147835955573, 8976.506292153928, 8986.0, 8678.175573320525, 8796.8680469793, 8823.07357727439, 8850.601722922484, 8870.201681848632, 8922.687705930293, 8935.687250946217, 8936.151065648786, 8969.282457403391, 9003.5048072356, 8941.239994600466, 8954.0, 8981.371304008722, 8985.820283594325, 8999.865002024975, 8815.471071735716, 8818.691345802867, 8850.495415779333, 8870.911290887074, 8881.111888811132, 41728.0, 41787.582124178676, 41876.37185442221, 42030.579694203276, 42100.57899420997, 3484.4773284007347, 3609.675129238381, 3620.475031120473, 3624.619414961444, 3722.8696995605296, 32796.6720332796, 32958.0, 33408.3318333632, 33435.33129337424, 33485.665143348495, 3998.3802510610903, 4015.6385925266572, 4063.7155399122075, 4098.139390727951, 4116.547179810218, 365445.5915806325, 365653.0, 366184.16907915554, 366759.0, 369091.0, 56771.71614141903, 56788.43211567831, 56789.0, 56814.71592642093, 57065.0, 36682.81658591743, 37263.81368093196, 37690.62309376926, 39291.60708392879, 39346.40980385296, 16528.25622846975, 16701.91649041747, 16725.330986760637, 16762.83237167637, 16824.327026919033, 12424.0, 12512.249265044127, 12515.937420313023, 12615.30615816139, 12629.936850315873, 19159.52101197481, 19337.323193688153, 19348.613027739368, 19389.709154362696, 19522.70715939262, 6821.249662537117, 7045.295470453017, 7171.812597157813, 7349.265073492715, 7508.249175082448, 943.306669597845, 1058.692979036071, 1146.6731981385265, 1172.4841069929205, 1172.806486929664, 33204.517390152505, 33530.66469335275, 33663.4950475743, 34089.82955085209, 34092.31815363679, 1060.8249638809664, 1129.0854407929603, 1147.74175810442, 1159.7448561316496, 1177.2289150606366, 15480.22598870052, 17204.913975430292, 17297.56756081083, 17319.740203896952, 17335.133243337783, 563788.0, 564750.0, 570931.0, 572562.0, 572739.0, 59819.700901496086, 60316.698416507636, 60360.094598581054, 60577.697111515045, 60623.09065364023, 1306.2097431054265, 1343.147101590497, 1353.7292541491545, 1371.6022353517567, 1373.3476598615578, 30590.388192236474, 31150.532742008436, 31761.682383175874, 32166.552505136857, 32510.34979300448, 50632.746836265585, 50914.490855090975, 51307.0, 51420.0, 51599.484005159466, 437363.0, 438560.0, 440721.0, 441697.0, 442322.0, 29309.26726831846, 29351.0, 29408.558871616515, 29718.554221687125, 29824.0, 47874.76062619664, 49166.0, 49374.50625493699, 49479.7526012382, 49618.534331910305, 41021.794891025354, 41175.58824411718, 42625.786871065444, 42770.35844462273, 43762.78118609514, 41265.79367103145, 41322.58677413307, 42519.7874010628, 43328.78335608302, 43901.78049109734, 40883.182336353704, 41111.0, 41514.37728434136, 41553.0, 44477.33284000678, 34704.826475867456, 37675.62324376721, 38465.0, 40578.59421405866, 41044.384334235605, 28716.13851584456, 28750.0, 28774.7122528772, 29231.707682922897, 29250.707492924797], "value": 20094.556088769594, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.9599040095991, 404.0807163702578, 416.1053734470887, 416.48564023431055, 430.4554738256107, 17896.463106106807, 19568.51078723031, 19644.607107857853, 19651.410457686256, 19989.300374486895, 19207.903960480176, 19280.710789338136, 19306.32427865025, 19328.22687092518, 19580.216791328367, 5480.6437581557075, 5534.889302213954, 5651.632643878155, 5680.3467601225975, 5693.089105743082, 5675.829725108253, 5677.120046392815, 5722.856928576777, 5736.311642602894, 5741.799037033684, 5506.182959623335, 5664.320281566218, 5670.149477578355, 5681.147827825818, 5690.2887139107615, 5456.154296084113, 5632.690202038886, 5636.887262254773, 5672.8865422691315, 5678.545716342683, 4941.382327209099, 4967.3542439483, 4984.800607975677, 5018.749062546858, 5020.397552293712, 22876.88561557198, 22987.77012229873, 23161.88419057911, 23203.071877124894, 23217.53564928709, 2358.25714899806, 2430.793382562484, 2447.3881529617597, 2452.448199155194, 2554.220962606404, 14277.571672849726, 14728.410863565445, 14732.631684207874, 14806.333714982851, 15352.309146088453, 1863.794982551918, 1867.6078023615057, 1871.23279455424, 1879.793222745497, 1956.6771482705337, 78507.60746196289, 78840.60579697123, 79255.60372198159, 79662.0, 80701.0, 10288.434136122436, 10305.433201174008, 10331.48342582868, 10443.634472793416, 10449.791004179873, 14675.77986330206, 14740.11559306445, 14743.0, 14765.187914664797, 14924.552263432115, 8001.8399632008195, 8090.919090809134, 8220.63007164679, 8267.586620668942, 8300.086990431048, 7632.694692212361, 7735.9613201933635, 7736.6518506667335, 7913.248241417056, 7936.880946785803, 6286.245650521967, 6335.176427064452, 6483.967580162163, 6486.0, 6713.765018224339, 1881.8870867747978, 1918.654642164396, 1952.2971730177126, 1986.5828176082896, 1988.2047181127375, 913.8355096082769, 998.6953979036464, 1009.0666133826328, 1034.2656713733334, 1106.80630889594, 19136.52158696016, 20185.798142018684, 20224.494387640425, 20320.390388288375, 20377.490562735755, 1010.802893435773, 1014.2089170447063, 1031.376017509411, 1072.6996440996534, 1080.1790639114329, 10319.226058045677, 11527.942360288313, 11642.35967021805, 11644.126690498246, 11704.765904681859, 472015.0, 483569.0, 484243.0, 492861.0, 505413.0, 86832.5658371704, 87819.18961199856, 91235.0, 96411.51794240985, 100614.0, 1032.695354870315, 1056.1761825775754, 1057.846612241236, 1068.3963560588243, 1070.9678709638724, 17560.0, 17684.734728979332, 18410.150052471607, 18538.0, 18608.44174674762, 42205.0, 42440.36339454973, 42547.787261063495, 42603.57396425996, 42818.0, 58217.41782582289, 58773.412265876796, 59938.70030649819, 60763.0, 61625.38374616196, 8480.74557763268, 8513.40406171562, 8547.786305342415, 8563.0, 8787.384883058381, 11359.602413915803, 12773.23360598367, 12778.68053298675, 13088.80366794518, 13791.586252412444, 11138.610148644759, 11246.1565382595, 11602.303861768321, 11841.940790295994, 11925.15160150178, 10905.34567925927, 10950.34297942126, 11279.0, 11379.146564007568, 11565.537378504765, 10332.173426126043, 11511.30932144074, 11561.248518846249, 11768.881956214145, 11968.76062478763, 7571.621418929141, 7743.7676869694, 7849.372050235853, 8152.347812174893, 8211.58942052907, 11535.826962595736, 11580.710482238012, 11823.76352472963, 11831.290122592673, 11904.464299106388], "value": 9370.926281819877, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1495.8578935001178, 1517.3475405575603, 1698.1763844535399, 1751.0806826416137, 1758.8680848936324, 7860.135385107634, 8399.076101628816, 8583.742487725363, 9066.592003359849, 9082.364234503579, 8841.292696584274, 8936.463812171274, 8943.41867778594, 8949.105089491048, 8974.685885993991, 2467.062516243829, 2490.1160088168713, 2498.038255271724, 2501.0871032073346, 2508.736582658822, 2390.486045500217, 2462.495188486365, 2479.2066538707622, 2482.577961746498, 2485.527749727546, 2408.3256688127267, 2426.0902161689364, 2438.719547252062, 2442.255112190781, 2445.8899349529315, 2373.038919237703, 2380.976190238093, 2388.0567175965484, 2394.832361734679, 2410.7950824179966, 2369.206315884181, 2388.10446082719, 2394.7126344838557, 2402.519496100787, 2405.8436201646837, 8941.0, 9038.86441703375, 9041.728748137566, 9055.411398259092, 9069.954650226706, 5185.066687996159, 5449.455054494559, 5501.037318469292, 5519.2824932758485, 5535.225068490415, 3443.0, 3591.712662986955, 3658.963410365889, 3667.303212389664, 3671.3575124353133, 1180.4982882275085, 1223.9143259971806, 1226.6626677663626, 1232.9075319350995, 1240.8138779183105, 12217.266963982189, 12264.693382665415, 12342.444589993473, 12354.0, 12452.0, 4453.354263631755, 4717.2216584263215, 4814.614830813526, 4838.274258861128, 4860.1008813369635, 10427.94786026065, 10476.423796691102, 10497.632582859716, 10498.580056797642, 10514.894851051391, 5434.619576629677, 5500.28496295487, 5503.367112782082, 5514.365847927459, 5516.420775818481, 4354.586314300136, 4903.779329930162, 5010.974945125251, 5016.423111342169, 5081.0, 4081.510218773766, 4089.3661482470266, 4119.237940980928, 4123.546409894909, 4181.121964387513, 1388.3891087921484, 1389.1387339849357, 1408.4225467558251, 1413.8656827601362, 1416.8016477693131, 936.9203617692436, 969.5588507229335, 977.2865807960087, 990.9554070066864, 1011.7622358745689, 5821.301443826768, 5880.470757631833, 5930.851728706817, 5937.228160339215, 6191.288001879841, 488.3334248750501, 490.93863267091615, 494.29316078008793, 499.66023104289434, 500.9974950125299, 4312.611864932172, 4314.460692413449, 4341.782910854445, 4467.809447877244, 4607.9308810367875, 10382.480875956171, 10901.890981090088, 10908.290961087503, 10931.18016148792, 10943.726406839733, 10751.83872241917, 10883.67348979532, 10884.292520986111, 10914.617988370368, 10919.727006824893, 7867.803304917423, 8182.713605023796, 8193.67225310981, 8237.50574965504, 8333.2916702081, 6057.1519987200945, 6094.299155596986, 6106.664133472702, 6277.843053923689, 6430.035494675836, 9838.114569688476, 9981.151602113901, 10062.49687515636, 10145.79708405813, 10186.08325250731, 9884.752881178028, 10033.799324013626, 10084.0, 10111.747206319607, 10132.44271565071, 7537.849243015218, 8168.877466838121, 8270.958645206736, 8281.254687078192, 8451.746447606582, 8643.308535317285, 8743.562821858754, 8744.562771861509, 8751.168638979287, 8777.736667899973, 7558.281963213486, 7609.391248700202, 7642.5032372895585, 7774.533527988338, 8089.110197878346, 7219.0, 7397.297256760599, 7405.185429602847, 7620.085589729268, 7649.770506884803, 6817.761378351734, 6919.065926099912, 6934.9653251735435, 6943.79168624942, 6948.756793512202, 5221.503957124067, 5304.177852432879, 5307.9734601326745, 5320.680759154463, 5531.529819965348, 5329.200619907045, 5364.544013758874, 5388.784448622011, 5431.918521222264, 5473.781048758005], "value": 4682.853823428965, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.2400973799213, 339.93261159957734, 348.1366211794749, 353.5933676272285, 353.7488383247894, 5328.254044433782, 5460.262864513299, 5526.226328314035, 5535.391106978229, 5562.443755624436, 5467.507924286813, 5495.313085864267, 5495.945040549594, 5539.14143307788, 5543.944560554393, 4284.528701842794, 4287.978560107211, 4302.870913872589, 4317.76252306123, 4345.174416860787, 4181.60274773896, 4294.871153865389, 4304.31131019037, 4310.159518893817, 4336.176126535948, 4281.0, 4287.378330142127, 4293.763842988635, 4319.632831209351, 4326.30779075348, 4300.741955482666, 4301.247281725717, 4322.697411181219, 4335.848245311399, 4378.759168245745, 3667.7615954963107, 3843.865464708722, 3854.614538546151, 3859.5754467008605, 3869.1681288522823, 5390.56875449967, 5394.190871369326, 5400.324959380077, 5420.051490989061, 5430.456954304577, 4868.683535570212, 4869.683470574401, 4874.46380898101, 4878.56092951636, 4878.682885612459, 5560.77756889724, 5736.942630573682, 5772.769089236425, 5779.219805326311, 5789.131630255453, 4160.521540022875, 4163.500379954395, 4169.937450938239, 4176.331786914109, 4192.769397683126, 6068.453839154453, 6113.816585502442, 6122.47958923492, 6123.785667501661, 6128.57100003, 3977.3835055566433, 4184.121334519724, 4291.957080429218, 4313.568643135662, 4322.113966636832, 4198.538160802309, 4221.78891055446, 4239.435141739265, 4248.196190514246, 4252.0, 4868.515102893581, 4878.414590249193, 4897.80003899047, 4906.484819094015, 4937.382827146606, 5614.63504872182, 5787.276590426197, 5830.4461076197695, 5867.266591676041, 5929.37741537141, 1468.6548661064642, 1483.8129496402835, 1491.6494623763406, 1493.7983372244826, 1497.7793098624586, 1004.1013293102778, 1013.7871047080196, 1036.4144258493927, 1039.0285083447002, 1046.0, 4877.731724755173, 4884.535969082932, 4886.926696099561, 4915.606751459946, 4936.234883593049, 5207.687538747611, 5209.01028804526, 5244.265802787613, 5245.790168393298, 5247.895042099137, 4666.859994200179, 4877.293102328242, 4910.183232204107, 4910.631702622318, 4911.557959783637, 2760.4127626614777, 2777.5417056185906, 2783.860806959644, 2788.288986308519, 2813.254487560798, 5246.344206974129, 5294.841154765363, 5300.681959082467, 5332.9733351333, 5393.973030134903, 5109.9744501277255, 5169.844904652867, 5250.291210686509, 5267.473252674702, 5316.973415132977, 5293.338332708411, 5301.496357845998, 5319.0, 5361.908855546262, 5436.20605200283, 5148.6910785353, 5177.974110129425, 5201.0, 5251.684898906078, 5284.7886084556185, 4907.515663878686, 5047.722375269395, 5074.238864170404, 5086.0, 5129.281900533853, 5258.8956319171875, 5300.316280185389, 5349.261490015839, 5377.650452720561, 5384.6230763847725, 3814.9127498662747, 3832.4826148470715, 3833.750806197588, 3835.9616403835603, 3879.84480620772, 5008.924866127084, 5142.280080788767, 5143.485651434827, 5806.071028635398, 6001.07965451069, 5889.882202355843, 5895.204147440212, 5913.201717768046, 5949.8215053548465, 5958.0, 5867.119932010232, 5877.265341832271, 5893.823185304448, 5911.970440147772, 5916.230889984447, 5679.432056794452, 5811.883762324645, 5839.0949402842625, 5842.211301474416, 5846.210761547137, 5875.5604876805455, 5936.584439089395, 5944.821655350346, 5980.37206093354, 5982.760689572542, 5527.871769368741, 5728.0, 5746.109353050284, 5748.137779333133, 5750.131207357709], "value": 4251.327456911875, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.2361435071645, 730.8757511223093, 779.1779672445567, 810.8175660476397, 811.5414790643284, 15553.533393998185, 16008.919955400235, 16525.173741312945, 16632.58418539537, 16806.0, 15140.545783626509, 15224.543263702079, 15374.154421506813, 15421.614459638515, 15441.0, 657.8355411147213, 783.2598194706005, 795.9363250939911, 814.645629151321, 815.2703330519182, 815.9388045896552, 829.8049958259804, 830.7383174300077, 830.9875351869727, 832.6877420967137, 856.0540602634093, 856.7386946981168, 866.8439680857443, 873.0832625742976, 874.3486102853351, 859.6905114158898, 860.4149178558578, 862.4006315610653, 863.2187869977649, 865.2861389353808, 628.8710814283061, 632.6804963493453, 635.8887194740902, 636.2015670333748, 636.5162476517834, 15691.0, 15801.051936883823, 15865.682686346325, 15876.586533895268, 15881.761773573406, 15062.849371506254, 15653.807527617808, 15692.607684807857, 15698.529044128694, 15975.840241597667, 11929.701757456047, 12036.759264814742, 12041.518339266418, 12092.032637389077, 12726.618201453972, 3971.1462035662184, 4009.7794621295816, 4012.0972781124015, 4055.087605288816, 4147.4815648044, 76747.0, 76858.0, 77681.22318776853, 78157.0, 78192.60903695502, 11593.362365070003, 11972.221805582609, 12009.519619215309, 12038.217515861616, 12089.093318001185, 22990.770092299197, 23075.307740767803, 23167.073317067465, 23167.768322316897, 23506.88246558756, 8146.837063258702, 8642.265407440438, 8747.65009399617, 8772.78068048304, 8788.252998495072, 4608.331791890158, 4635.304704294383, 4657.394538709946, 4657.953420465819, 4718.834840780556, 3440.9655903441144, 3567.500549923013, 3568.839402226906, 3704.7406681532034, 3887.183691424776, 654.4306453385585, 669.0399277037369, 672.1027428383163, 678.9694463749144, 684.7945616315086, 639.6769631336145, 687.3573209049555, 687.621808005595, 688.2016860441863, 700.1178515071047, 9367.859482107773, 9882.4564648945, 10047.648332308334, 10101.19190464761, 10184.185265178769, 716.8602122586045, 722.0973782771536, 722.151472020374, 727.1673933346289, 762.268222506389, 4646.465656449484, 4776.737279449663, 4941.950580494221, 4948.38145231846, 5004.799808007639, 126573.0, 126983.365083174, 127770.0, 130779.0, 131222.0, 77793.2220677786, 80319.19680803118, 104851.4757426208, 109184.0, 111361.0, 78740.60629696815, 79735.0, 80541.0, 82236.17763822405, 83146.58426707827, 9403.388779729295, 9816.0, 9924.702258932244, 10002.0, 10087.747806304607, 45784.7710761444, 46109.0, 47031.0, 47749.283760742925, 49090.08664184461, 64422.0, 68119.3188068113, 69294.0, 69415.65292173506, 72913.6354318225, 12260.448279827251, 12555.183913045623, 12585.0, 13074.28091454979, 13168.670783230496, 14213.21827299467, 14578.198199098728, 14600.26998650042, 14762.409503619734, 15436.382544698086, 13666.93166534161, 14322.856771432153, 14399.280035998368, 14600.0, 14709.852901470847, 13812.447502100205, 14153.08004979673, 14525.201113938412, 14528.273586320853, 14785.260736963324, 13456.596302110953, 13660.93169534146, 14351.784723229368, 14433.422663093359, 14453.638659033608, 10550.841737373792, 10841.837372439262, 10923.945380273048, 11066.502007409525, 11140.777184456427, 10147.289689721649, 10527.78609198855, 11333.979941804948, 11486.94256528712, 11564.363959982282], "value": 7682.34438262026, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1550.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 114.0, 113.0, 116.0, 114.0, 116.0, 116.0, 115.0, 112.0, 132.0], "value": 115.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 125.0, 150.0, 191.0, 118.0, 146.0, 151.0, 120.0, 175.0, 120.0], "value": 144.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 167.0, 175.0, 161.0, 162.0, 161.0, 163.0, 161.0, 167.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 181.0, 76.0, 77.0, 75.0, 75.0, 165.0, 77.0], "value": 95.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 145.0, 83.0, 82.0, 82.0, 148.0, 89.0, 81.0, 146.0], "value": 102.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 119.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 148.0, 148.0, 148.0, 148.0, 146.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 97.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 54.0, 55.0, 53.0, 54.0, 55.0, 53.0, 54.0, 54.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 63.0, 63.0, 64.0, 63.0, 63.0, 64.0, 64.0, 63.0, 63.0], "value": 63.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 83.0, 85.0, 80.0, 80.0, 81.0, 81.0, 81.0, 80.0, 80.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 128.0, 139.0, 141.0, 147.0, 133.0, 129.0, 126.0, 165.0, 140.0], "value": 137.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 164.0, 169.0, 164.0, 168.0, 164.0, 163.0, 168.0, 168.0, 169.0], "value": 166.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 66.0, 64.0, 65.0, 65.0, 65.0, 67.0, 65.0], "value": 65.7, "unit": "score"}]}]} 16:40:00 INFO - Return code: 0 16:40:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:40:00 ERROR - # TBPL SUCCESS # 16:40:00 INFO - Running post-action listener: _resource_record_post_action 16:40:00 INFO - [mozharness: 2016-08-29 23:40:00.403235Z] Finished run-tests step (success) 16:40:00 INFO - Running post-run listener: _resource_record_post_run 16:40:00 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 339968; Write bytes: 418738176; Read time: 72; Write time: 330416 16:40:00 INFO - TinderboxPrint: CPU usage
13.5% 16:40:00 INFO - TinderboxPrint: I/O read bytes / time
339,968 / 72 16:40:00 INFO - TinderboxPrint: I/O write bytes / time
418,738,176 / 330,416 16:40:00 INFO - TinderboxPrint: CPU idle
8,238.4 (86.5%) 16:40:00 INFO - TinderboxPrint: CPU user
1,221.7 (12.8%) 16:40:00 INFO - TinderboxPrint: Swap in / out
0 / 0 16:40:00 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 128843776; Read time: 0; Write time: 92012 16:40:00 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 335872; Write bytes: 289894400; Read time: 56; Write time: 238404 16:40:01 INFO - Running post-run listener: _upload_blobber_files 16:40:01 INFO - Blob upload gear active. 16:40:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:40:01 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:40:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:40:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:40:01 INFO - (blobuploader) - INFO - Open directory for files ... 16:40:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:40:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:40:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:40:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:40:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:40:02 INFO - (blobuploader) - INFO - Done attempting. 16:40:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:40:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:40:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:40:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:40:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:40:03 INFO - (blobuploader) - INFO - Done attempting. 16:40:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:40:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:40:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:40:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:40:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:40:07 INFO - (blobuploader) - INFO - Done attempting. 16:40:07 INFO - (blobuploader) - INFO - Iteration through files over. 16:40:07 INFO - Return code: 0 16:40:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:40:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:40:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71edd12731159b1d4f04e8f8bafc14bad54795f0649cb94cd8bb93583036127e5aa33670ce1dc1d94a89424df11e16b9fd3fe874137a7405cbf93badffb3fce5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/173bcd63fac0a9293ba6728322248681ef42242d891f0cd63ac963b01ac0fdbc9a6547f7e5fd87e605629fb4415ad03f25fdf37e12fad335c53fa2d8493d2da0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/97ea81e73fc7bc074740d535359f78ef4d6605730e83584e9312ae7e078406d4d70514b40a23ae91498d730b1b51bf7168535685d49ff539d4744fdc122b6551"} 16:40:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:40:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:40:07 INFO - Contents: 16:40:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71edd12731159b1d4f04e8f8bafc14bad54795f0649cb94cd8bb93583036127e5aa33670ce1dc1d94a89424df11e16b9fd3fe874137a7405cbf93badffb3fce5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/173bcd63fac0a9293ba6728322248681ef42242d891f0cd63ac963b01ac0fdbc9a6547f7e5fd87e605629fb4415ad03f25fdf37e12fad335c53fa2d8493d2da0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/97ea81e73fc7bc074740d535359f78ef4d6605730e83584e9312ae7e078406d4d70514b40a23ae91498d730b1b51bf7168535685d49ff539d4744fdc122b6551"} 16:40:07 INFO - Running post-run listener: copy_logs_to_upload_dir 16:40:07 INFO - Copying logs to upload dir... 16:40:07 INFO - mkdir: /builds/slave/test/build/upload/logs 16:40:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.504793 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-29 16:40:07.020576) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 16:40:07.024223) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1472511567.404289-2083425281 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/71edd12731159b1d4f04e8f8bafc14bad54795f0649cb94cd8bb93583036127e5aa33670ce1dc1d94a89424df11e16b9fd3fe874137a7405cbf93badffb3fce5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/173bcd63fac0a9293ba6728322248681ef42242d891f0cd63ac963b01ac0fdbc9a6547f7e5fd87e605629fb4415ad03f25fdf37e12fad335c53fa2d8493d2da0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/97ea81e73fc7bc074740d535359f78ef4d6605730e83584e9312ae7e078406d4d70514b40a23ae91498d730b1b51bf7168535685d49ff539d4744fdc122b6551"} build_url:https://queue.taskcluster.net/v1/task/fVmFULvXTIqPMYfJkhKKBw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011373 build_url: 'https://queue.taskcluster.net/v1/task/fVmFULvXTIqPMYfJkhKKBw/artifacts/public/build/firefox-51.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/71edd12731159b1d4f04e8f8bafc14bad54795f0649cb94cd8bb93583036127e5aa33670ce1dc1d94a89424df11e16b9fd3fe874137a7405cbf93badffb3fce5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/173bcd63fac0a9293ba6728322248681ef42242d891f0cd63ac963b01ac0fdbc9a6547f7e5fd87e605629fb4415ad03f25fdf37e12fad335c53fa2d8493d2da0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/97ea81e73fc7bc074740d535359f78ef4d6605730e83584e9312ae7e078406d4d70514b40a23ae91498d730b1b51bf7168535685d49ff539d4744fdc122b6551"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 16:40:07.050363) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 16:40:07.050768) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1472511567.404289-2083425281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 16:40:07.135325) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 16:40:07.135767) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 16:40:07.136243) ========= ========= Total master_lag: 0.19 =========