builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-027 starttime: 1451463984.92 results: success (0) buildid: 20151229215656 builduid: a5e4892cef934b8fb5fcc64f348147ad revision: 77420c71e0d4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:24.922946) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:24.923454) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:24.923814) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=447a3abc0420b6a47dd38cba000001bf-1451457774.699220-419188759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006415 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:24.971399) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:24.971689) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:25.010176) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:25.010433) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=447a3abc0420b6a47dd38cba000001bf-1451457774.699220-419188759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004698 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:25.069326) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:25.069681) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:25.070086) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:25.070358) ========= 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-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=447a3abc0420b6a47dd38cba000001bf-1451457774.699220-419188759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-30 00:26:25-- 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% 60.8M=0s 2015-12-30 00:26:25 (60.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.167238 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:25.250425) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:25.250745) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=447a3abc0420b6a47dd38cba000001bf-1451457774.699220-419188759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017045 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:25.300160) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:25.300493) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 77420c71e0d4 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 77420c71e0d4 --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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=447a3abc0420b6a47dd38cba000001bf-1451457774.699220-419188759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-30 00:26:25,634 Setting DEBUG logging. 2015-12-30 00:26:25,634 attempt 1/10 2015-12-30 00:26:25,635 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/77420c71e0d4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-30 00:26:25,878 unpacking tar archive at: fx-team-77420c71e0d4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.525272 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:25.839479) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:25.839812) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:25.849801) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:25.850101) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 00:26:25.850483) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-30 00:26:25.850781) ========= /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-pgo/. (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-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=447a3abc0420b6a47dd38cba000001bf-1451457774.699220-419188759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:26:26 INFO - MultiFileLogger online at 20151230 00:26:26 in /builds/slave/test-pgo 00:26:26 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 00:26:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 00:26:26 INFO - {'append_to_log': False, 00:26:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 00:26:26 INFO - 'blob_upload_branch': 'Fx-Team', 00:26:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 00:26:26 INFO - 'branch': 'Fx-Team', 00:26:26 INFO - 'buildbot_json_path': 'buildprops.json', 00:26:26 INFO - 'config_files': ('talos/linux_config.py',), 00:26:26 INFO - 'default_actions': ('clobber', 00:26:26 INFO - 'read-buildbot-config', 00:26:26 INFO - 'download-and-extract', 00:26:26 INFO - 'populate-webroot', 00:26:26 INFO - 'create-virtualenv', 00:26:26 INFO - 'install', 00:26:26 INFO - 'run-tests'), 00:26:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:26:26 INFO - 'download_minidump_stackwalk': True, 00:26:26 INFO - 'download_symbols': 'ondemand', 00:26:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:26:26 INFO - 'tooltool.py': '/tools/tooltool.py', 00:26:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:26:26 INFO - '/tools/misc-python/virtualenv.py')}, 00:26:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:26:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:26:26 INFO - 'installer_path': 'installer.exe', 00:26:26 INFO - 'log_level': 'info', 00:26:26 INFO - 'log_name': 'talos', 00:26:26 INFO - 'log_to_console': True, 00:26:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:26:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:26:26 INFO - 'opt_config_files': (), 00:26:26 INFO - 'pip_index': False, 00:26:26 INFO - 'sps_profile': False, 00:26:26 INFO - 'sps_profile_interval': 0, 00:26:26 INFO - 'suite': 'dromaeojs-e10s', 00:26:26 INFO - 'system_bits': '32', 00:26:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:26:26 INFO - 'title': 'talos-linux64-ix-027', 00:26:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:26:26 INFO - 'use_talos_json': True, 00:26:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 00:26:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:26:26 INFO - 'work_dir': 'build'} 00:26:26 INFO - ##### 00:26:26 INFO - ##### Running clobber step. 00:26:26 INFO - ##### 00:26:26 INFO - Running pre-action listener: _resource_record_pre_action 00:26:26 INFO - Running main action method: clobber 00:26:26 INFO - rmtree: /builds/slave/test-pgo/build 00:26:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 00:26:26 INFO - Running post-action listener: _resource_record_post_action 00:26:26 INFO - ##### 00:26:26 INFO - ##### Running read-buildbot-config step. 00:26:26 INFO - ##### 00:26:26 INFO - Running pre-action listener: _resource_record_pre_action 00:26:26 INFO - Running main action method: read_buildbot_config 00:26:26 INFO - Using buildbot properties: 00:26:26 INFO - { 00:26:26 INFO - "project": "", 00:26:26 INFO - "product": "firefox", 00:26:26 INFO - "script_repo_revision": "production", 00:26:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 00:26:26 INFO - "repository": "", 00:26:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 00:26:26 INFO - "buildid": "20151229215656", 00:26:26 INFO - "pgo_build": "True", 00:26:26 INFO - "basedir": "/builds/slave/test-pgo", 00:26:26 INFO - "buildnumber": 413, 00:26:26 INFO - "slavename": "talos-linux64-ix-027", 00:26:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:26:26 INFO - "platform": "ubuntu64_hw", 00:26:26 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 00:26:26 INFO - "branch": "fx-team", 00:26:26 INFO - "repo_path": "integration/fx-team", 00:26:26 INFO - "revision": "77420c71e0d4", 00:26:26 INFO - "stage_platform": "linux64-pgo", 00:26:26 INFO - "builduid": "a5e4892cef934b8fb5fcc64f348147ad", 00:26:26 INFO - "slavebuilddir": "test" 00:26:26 INFO - } 00:26:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 00:26:26 INFO - Running post-action listener: _resource_record_post_action 00:26:26 INFO - ##### 00:26:26 INFO - ##### Running download-and-extract step. 00:26:26 INFO - ##### 00:26:26 INFO - Running pre-action listener: _resource_record_pre_action 00:26:26 INFO - Running main action method: download_and_extract 00:26:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 00:26:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:26 INFO - https://queue.taskcluster.net/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 00:26:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/test_packages.json 00:26:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/test_packages.json 00:26:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 00:26:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 00:26:34 INFO - Downloaded 1302 bytes. 00:26:34 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 00:26:34 INFO - Using the following test package requirements: 00:26:34 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 00:26:34 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:26:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:26:34 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:26:34 INFO - u'jsshell-linux-x86_64.zip'], 00:26:34 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:26:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:26:34 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 00:26:34 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:26:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:26:34 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:26:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:26:34 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:26:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:26:34 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 00:26:34 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:26:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:26:34 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:26:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:34 INFO - https://queue.taskcluster.net/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:26:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:26:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:26:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:26:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:26:42 INFO - Downloaded 23192440 bytes. 00:26:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 00:26:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:26:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 00:26:43 INFO - Return code: 0 00:26:43 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:26:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:43 INFO - https://queue.taskcluster.net/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:26:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:26:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:26:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:26:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:26:44 INFO - Downloaded 23192440 bytes. 00:26:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 00:26:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:26:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 00:26:45 INFO - Return code: 0 00:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:45 INFO - https://queue.taskcluster.net/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:26:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:26:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:26:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:26:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:26:46 INFO - Downloaded 11132285 bytes. 00:26:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 00:26:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:26:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 00:26:46 INFO - Return code: 0 00:26:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:47 INFO - https://queue.taskcluster.net/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:26:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:26:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:26:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:26:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:26:48 INFO - Downloaded 54896173 bytes. 00:26:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:26:48 INFO - mkdir: /builds/slave/test-pgo/properties 00:26:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 00:26:48 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 00:26:48 INFO - Contents: 00:26:48 INFO - build_url:https://queue.taskcluster.net/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:26:48 INFO - Running post-action listener: _resource_record_post_action 00:26:48 INFO - Running post-action listener: set_extra_try_arguments 00:26:48 INFO - ##### 00:26:48 INFO - ##### Running populate-webroot step. 00:26:48 INFO - ##### 00:26:48 INFO - Running pre-action listener: _resource_record_pre_action 00:26:48 INFO - Running main action method: populate_webroot 00:26:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:26:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:26:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:26:48 INFO - '--tppagecycles', 00:26:48 INFO - '7'], 00:26:48 INFO - 'tests': ['tsvgm']}}, 00:26:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:26:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:26:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:26:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:26:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:26:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:26:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:26:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:48 INFO - 'talos_options': ['--e10s'], 00:26:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:26:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:48 INFO - 'tests': ['damp', 'tps']}, 00:26:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:48 INFO - 'talos_options': ['--e10s'], 00:26:48 INFO - 'tests': ['damp', 'tps']}, 00:26:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:26:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:26:48 INFO - 'other': {'tests': ['a11yr', 00:26:48 INFO - 'ts_paint', 00:26:48 INFO - 'tpaint', 00:26:48 INFO - 'sessionrestore', 00:26:48 INFO - 'sessionrestore_no_auto_restore']}, 00:26:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:26:48 INFO - 'tests': ['a11yr', 00:26:48 INFO - 'ts_paint', 00:26:48 INFO - 'tpaint', 00:26:48 INFO - 'sessionrestore', 00:26:48 INFO - 'sessionrestore_no_auto_restore']}, 00:26:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:26:48 INFO - 'tests': ['a11yr', 00:26:48 INFO - 'ts_paint', 00:26:48 INFO - 'tpaint', 00:26:48 INFO - 'sessionrestore', 00:26:48 INFO - 'sessionrestore_no_auto_restore']}, 00:26:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:26:48 INFO - 'tests': ['a11yr', 00:26:48 INFO - 'ts_paint', 00:26:48 INFO - 'tpaint', 00:26:48 INFO - 'sessionrestore', 00:26:48 INFO - 'sessionrestore_no_auto_restore']}, 00:26:48 INFO - 'other_l64': {'tests': ['a11yr', 00:26:48 INFO - 'ts_paint', 00:26:48 INFO - 'tpaint', 00:26:48 INFO - 'sessionrestore', 00:26:48 INFO - 'sessionrestore_no_auto_restore']}, 00:26:48 INFO - 'other_nol64': {'tests': ['a11yr', 00:26:48 INFO - 'ts_paint', 00:26:48 INFO - 'tpaint', 00:26:48 INFO - 'sessionrestore', 00:26:48 INFO - 'sessionrestore_no_auto_restore']}, 00:26:48 INFO - 'svgr': {'tests': ['tsvgx', 00:26:48 INFO - 'tsvgr_opacity', 00:26:48 INFO - 'tart', 00:26:48 INFO - 'tscrollx', 00:26:48 INFO - 'cart']}, 00:26:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:26:48 INFO - 'tests': ['tsvgx', 00:26:48 INFO - 'tsvgr_opacity', 00:26:48 INFO - 'tart', 00:26:48 INFO - 'tscrollx', 00:26:48 INFO - 'cart']}, 00:26:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:48 INFO - 'tests': ['tp5o']}, 00:26:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:48 INFO - 'talos_options': ['--e10s'], 00:26:48 INFO - 'tests': ['tp5o']}, 00:26:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:48 INFO - 'talos_options': ['--xperf_path', 00:26:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:26:48 INFO - 'tests': ['tp5n']}, 00:26:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:48 INFO - 'talos_options': ['--e10s', 00:26:48 INFO - '--xperf_path', 00:26:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:26:48 INFO - 'tests': ['tp5n']}}, 00:26:48 INFO - 'talos.zip': {'path': '', 00:26:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:26:48 INFO - Running post-action listener: _resource_record_post_action 00:26:48 INFO - ##### 00:26:48 INFO - ##### Running create-virtualenv step. 00:26:48 INFO - ##### 00:26:48 INFO - Running pre-action listener: _resource_record_pre_action 00:26:48 INFO - Running main action method: create_virtualenv 00:26:48 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 00:26:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 00:26:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 00:26:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:26:48 INFO - Using real prefix '/usr' 00:26:48 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 00:26:48 INFO - Installing distribute.............................................................................................................................................................................................done. 00:26:50 INFO - Installing pip.................done. 00:26:50 INFO - Return code: 0 00:26:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 00:26:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:26:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:26:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7ffd6daa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1059630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea840>, '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 0x10576b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451457774.699220-419188759', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 00:26:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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-pgo/build 00:26:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 00:26:50 INFO - Using env: {'DISPLAY': ':0', 00:26:50 INFO - 'HOME': '/home/cltbld', 00:26:50 INFO - 'LANG': 'en_US.UTF-8', 00:26:50 INFO - 'LANGUAGE': 'en_US:en', 00:26:50 INFO - 'LOGNAME': 'cltbld', 00:26:50 INFO - 'MAIL': '/var/mail/cltbld', 00:26:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:50 INFO - 'MOZ_NO_REMOTE': '1', 00:26:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:26:50 INFO - 'NO_EM_RESTART': '1', 00:26:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:26:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:26:50 INFO - 'PWD': '/builds/slave/test-pgo', 00:26:50 INFO - 'SHELL': '/bin/bash', 00:26:50 INFO - 'SHLVL': '1', 00:26:50 INFO - 'TERM': 'linux', 00:26:50 INFO - 'TMOUT': '86400', 00:26:50 INFO - 'USER': 'cltbld', 00:26:50 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451457774.699220-419188759', 00:26:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:50 INFO - '_': '/tools/buildbot/bin/python'} 00:26:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:26:51 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 00:26:51 INFO - Cleaning up... 00:26:51 INFO - Return code: 0 00:26:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 00:26:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:26:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:26:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd6daa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1059630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea840>, '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 0x10576b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451457774.699220-419188759', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 00:26:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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>=0.7.1'] in /builds/slave/test-pgo/build 00:26:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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>=0.7.1 00:26:51 INFO - Using env: {'DISPLAY': ':0', 00:26:51 INFO - 'HOME': '/home/cltbld', 00:26:51 INFO - 'LANG': 'en_US.UTF-8', 00:26:51 INFO - 'LANGUAGE': 'en_US:en', 00:26:51 INFO - 'LOGNAME': 'cltbld', 00:26:51 INFO - 'MAIL': '/var/mail/cltbld', 00:26:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:51 INFO - 'MOZ_NO_REMOTE': '1', 00:26:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:26:51 INFO - 'NO_EM_RESTART': '1', 00:26:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:26:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:26:51 INFO - 'PWD': '/builds/slave/test-pgo', 00:26:51 INFO - 'SHELL': '/bin/bash', 00:26:51 INFO - 'SHLVL': '1', 00:26:51 INFO - 'TERM': 'linux', 00:26:51 INFO - 'TMOUT': '86400', 00:26:51 INFO - 'USER': 'cltbld', 00:26:51 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451457774.699220-419188759', 00:26:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:51 INFO - '_': '/tools/buildbot/bin/python'} 00:26:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:26:51 INFO - Downloading/unpacking psutil>=0.7.1 00:26:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:26:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:26:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:26:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:26:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:26:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:26:52 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 00:26:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 00:26:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 00:26:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:26:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:26:53 INFO - Installing collected packages: psutil 00:26:53 INFO - Running setup.py install for psutil 00:26:53 INFO - building 'psutil._psutil_linux' extension 00:26:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 00:26:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 00:26:53 INFO - building 'psutil._psutil_posix' extension 00:26:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 00:26:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 00:26:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:26:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:26:53 INFO - Successfully installed psutil 00:26:53 INFO - Cleaning up... 00:26:53 INFO - Return code: 0 00:26:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 00:26:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:26:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:26:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd6daa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1059630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea840>, '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 0x10576b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451457774.699220-419188759', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 00:26:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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.0.0'] in /builds/slave/test-pgo/build 00:26:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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.0.0 00:26:53 INFO - Using env: {'DISPLAY': ':0', 00:26:53 INFO - 'HOME': '/home/cltbld', 00:26:53 INFO - 'LANG': 'en_US.UTF-8', 00:26:53 INFO - 'LANGUAGE': 'en_US:en', 00:26:53 INFO - 'LOGNAME': 'cltbld', 00:26:53 INFO - 'MAIL': '/var/mail/cltbld', 00:26:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:53 INFO - 'MOZ_NO_REMOTE': '1', 00:26:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:26:53 INFO - 'NO_EM_RESTART': '1', 00:26:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:26:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:26:53 INFO - 'PWD': '/builds/slave/test-pgo', 00:26:53 INFO - 'SHELL': '/bin/bash', 00:26:53 INFO - 'SHLVL': '1', 00:26:53 INFO - 'TERM': 'linux', 00:26:53 INFO - 'TMOUT': '86400', 00:26:53 INFO - 'USER': 'cltbld', 00:26:53 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451457774.699220-419188759', 00:26:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:53 INFO - '_': '/tools/buildbot/bin/python'} 00:26:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:26:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:26: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 00:26: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 00:26: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 00:26: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 00:26: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 00:26: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 00:26:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:26:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 00:26:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:26:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:26:55 INFO - Installing collected packages: mozsystemmonitor 00:26:55 INFO - Running setup.py install for mozsystemmonitor 00:26:55 INFO - Successfully installed mozsystemmonitor 00:26:55 INFO - Cleaning up... 00:26:55 INFO - Return code: 0 00:26:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 00:26:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:26:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:26:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7ffd6daa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1059630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea840>, '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 0x10576b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451457774.699220-419188759', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 00:26:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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-pgo/build 00:26:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 00:26:55 INFO - Using env: {'DISPLAY': ':0', 00:26:55 INFO - 'HOME': '/home/cltbld', 00:26:55 INFO - 'LANG': 'en_US.UTF-8', 00:26:55 INFO - 'LANGUAGE': 'en_US:en', 00:26:55 INFO - 'LOGNAME': 'cltbld', 00:26:55 INFO - 'MAIL': '/var/mail/cltbld', 00:26:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:55 INFO - 'MOZ_NO_REMOTE': '1', 00:26:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:26:55 INFO - 'NO_EM_RESTART': '1', 00:26:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:26:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:26:55 INFO - 'PWD': '/builds/slave/test-pgo', 00:26:55 INFO - 'SHELL': '/bin/bash', 00:26:55 INFO - 'SHLVL': '1', 00:26:55 INFO - 'TERM': 'linux', 00:26:55 INFO - 'TMOUT': '86400', 00:26:55 INFO - 'USER': 'cltbld', 00:26:55 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451457774.699220-419188759', 00:26:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:55 INFO - '_': '/tools/buildbot/bin/python'} 00:26:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:26:55 INFO - Downloading/unpacking blobuploader==1.2.4 00:26:55 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 00:26:55 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 00:26:55 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 00:26:55 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 00:26:55 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 00:26:55 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 00:26:57 INFO - Downloading blobuploader-1.2.4.tar.gz 00:26:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 00:26:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:26:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:26: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 00:26: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 00:26: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 00:26: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 00:26: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 00:26: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 00:26:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 00:26:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 00:26:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:26:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:26:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:26:58 INFO - Downloading docopt-0.6.1.tar.gz 00:26:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 00:26:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 00:26:58 INFO - Installing collected packages: blobuploader, requests, docopt 00:26:58 INFO - Running setup.py install for blobuploader 00:26:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:26:58 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 00:26:58 INFO - Running setup.py install for requests 00:26:58 INFO - Running setup.py install for docopt 00:26:59 INFO - Successfully installed blobuploader requests docopt 00:26:59 INFO - Cleaning up... 00:26:59 INFO - Return code: 0 00:26:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:26:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:26:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:26:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7ffd6daa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1059630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea840>, '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 0x10576b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451457774.699220-419188759', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 00:26:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/config 00:26:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/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 00:26:59 INFO - Using env: {'DISPLAY': ':0', 00:26:59 INFO - 'HOME': '/home/cltbld', 00:26:59 INFO - 'LANG': 'en_US.UTF-8', 00:26:59 INFO - 'LANGUAGE': 'en_US:en', 00:26:59 INFO - 'LOGNAME': 'cltbld', 00:26:59 INFO - 'MAIL': '/var/mail/cltbld', 00:26:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:59 INFO - 'MOZ_NO_REMOTE': '1', 00:26:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:26:59 INFO - 'NO_EM_RESTART': '1', 00:26:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:26:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:26:59 INFO - 'PWD': '/builds/slave/test-pgo', 00:26:59 INFO - 'SHELL': '/bin/bash', 00:26:59 INFO - 'SHLVL': '1', 00:26:59 INFO - 'TERM': 'linux', 00:26:59 INFO - 'TMOUT': '86400', 00:26:59 INFO - 'USER': 'cltbld', 00:26:59 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451457774.699220-419188759', 00:26:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:59 INFO - '_': '/tools/buildbot/bin/python'} 00:26:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:26:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:26:59 INFO - Running setup.py (path:/tmp/pip-jt0DcR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:26:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:26:59 INFO - Running setup.py (path:/tmp/pip-i0p51T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:26:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:26:59 INFO - Running setup.py (path:/tmp/pip-6H7Aim-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:26:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:26:59 INFO - Running setup.py (path:/tmp/pip-G1LRLa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:26:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:26:59 INFO - Running setup.py (path:/tmp/pip-w1ZtWh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:26:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:26:59 INFO - Running setup.py (path:/tmp/pip-cTDeIR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:26:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:26:59 INFO - Running setup.py (path:/tmp/pip-kLImv4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:26:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:26:59 INFO - Running setup.py (path:/tmp/pip-62jc52-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:26:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:26:59 INFO - Running setup.py (path:/tmp/pip-8yvPxA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:26:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:26:59 INFO - Running setup.py (path:/tmp/pip-P2d4GH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:27:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:27:00 INFO - Running setup.py (path:/tmp/pip-q_PsBU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:27:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:27:00 INFO - Running setup.py (path:/tmp/pip-2PAxuc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:27:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:27:00 INFO - Running setup.py (path:/tmp/pip-qTIE9L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:27:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:27:00 INFO - Running setup.py (path:/tmp/pip-wdQFCB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:27:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:27:00 INFO - Running setup.py (path:/tmp/pip-I1lX_F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:27:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:27:00 INFO - Running setup.py (path:/tmp/pip-EhD7TN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:27:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:27:00 INFO - Running setup.py (path:/tmp/pip-5iqJCo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:27:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:27:00 INFO - Running setup.py install for manifestparser 00:27:00 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 00:27:00 INFO - Running setup.py install for mozcrash 00:27:00 INFO - Running setup.py install for mozdebug 00:27:00 INFO - Running setup.py install for mozdevice 00:27:00 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 00:27:00 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 00:27:01 INFO - Running setup.py install for mozfile 00:27:01 INFO - Running setup.py install for mozhttpd 00:27:01 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 00:27:01 INFO - Running setup.py install for mozinfo 00:27:01 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 00:27:01 INFO - Running setup.py install for mozInstall 00:27:01 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 00:27:01 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 00:27:01 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 00:27:01 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 00:27:01 INFO - Running setup.py install for mozleak 00:27:01 INFO - Running setup.py install for mozlog 00:27:01 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 00:27:01 INFO - Running setup.py install for moznetwork 00:27:01 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 00:27:01 INFO - Running setup.py install for mozprocess 00:27:01 INFO - Running setup.py install for mozprofile 00:27:01 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 00:27:01 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 00:27:01 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 00:27:01 INFO - Running setup.py install for mozrunner 00:27:02 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 00:27:02 INFO - Running setup.py install for mozscreenshot 00:27:02 INFO - Running setup.py install for moztest 00:27:02 INFO - Running setup.py install for mozversion 00:27:02 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 00:27:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:27:02 INFO - Cleaning up... 00:27:02 INFO - Return code: 0 00:27:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:27:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:27:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:27:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:27:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7ffd6daa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1059630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea840>, '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 0x10576b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451457774.699220-419188759', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 00:27:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/config 00:27:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/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 00:27:02 INFO - Using env: {'DISPLAY': ':0', 00:27:02 INFO - 'HOME': '/home/cltbld', 00:27:02 INFO - 'LANG': 'en_US.UTF-8', 00:27:02 INFO - 'LANGUAGE': 'en_US:en', 00:27:02 INFO - 'LOGNAME': 'cltbld', 00:27:02 INFO - 'MAIL': '/var/mail/cltbld', 00:27:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:27:02 INFO - 'MOZ_NO_REMOTE': '1', 00:27:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:27:02 INFO - 'NO_EM_RESTART': '1', 00:27:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:27:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:27:02 INFO - 'PWD': '/builds/slave/test-pgo', 00:27:02 INFO - 'SHELL': '/bin/bash', 00:27:02 INFO - 'SHLVL': '1', 00:27:02 INFO - 'TERM': 'linux', 00:27:02 INFO - 'TMOUT': '86400', 00:27:02 INFO - 'USER': 'cltbld', 00:27:02 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451457774.699220-419188759', 00:27:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:27:02 INFO - '_': '/tools/buildbot/bin/python'} 00:27:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:27:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:27:02 INFO - Running setup.py (path:/tmp/pip-_UHNWN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 00:27:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:27:02 INFO - Running setup.py (path:/tmp/pip-2DmNCH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 00:27:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:27:02 INFO - Running setup.py (path:/tmp/pip-dyDH9O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 00:27:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:27:02 INFO - Running setup.py (path:/tmp/pip-oRDmz4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 00:27:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:27:02 INFO - Running setup.py (path:/tmp/pip-rA75YI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 00:27:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:27:02 INFO - Running setup.py (path:/tmp/pip-B4rYcE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 00:27:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:27:03 INFO - Running setup.py (path:/tmp/pip-9wJNPi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 00:27:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:27:03 INFO - Running setup.py (path:/tmp/pip-q9lPV9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 00:27:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:27:03 INFO - Running setup.py (path:/tmp/pip-348WPb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 00:27:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:27:03 INFO - Running setup.py (path:/tmp/pip-qURAm_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 00:27:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:27:03 INFO - Running setup.py (path:/tmp/pip-YsoQ3S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 00:27:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:27:03 INFO - Running setup.py (path:/tmp/pip-AWVcOP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 00:27:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:27:03 INFO - Running setup.py (path:/tmp/pip-4Agt3I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 00:27:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:27:03 INFO - Running setup.py (path:/tmp/pip-uDP00m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 00:27:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:27:03 INFO - Running setup.py (path:/tmp/pip-llix56-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 00:27:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:27:03 INFO - Running setup.py (path:/tmp/pip-AN1vUR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 00:27:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:27:03 INFO - Running setup.py (path:/tmp/pip-CyuubJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 00:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 00:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 00:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 00:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 00:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 00:27:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 00:27:03 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 00:27:03 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 00:27:03 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 00:27:03 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 00:27:03 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 00:27:03 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 00:27:05 INFO - Downloading blessings-1.5.1.tar.gz 00:27:05 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 00:27:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 00:27:05 INFO - Installing collected packages: blessings 00:27:05 INFO - Running setup.py install for blessings 00:27:05 INFO - Successfully installed blessings 00:27:05 INFO - Cleaning up... 00:27:05 INFO - Return code: 0 00:27:05 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 00:27:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:27:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:27:05 INFO - Reading from file tmpfile_stdout 00:27:05 INFO - Current package versions: 00:27:05 INFO - argparse == 1.2.1 00:27:05 INFO - blessings == 1.5.1 00:27:05 INFO - blobuploader == 1.2.4 00:27:05 INFO - docopt == 0.6.1 00:27:05 INFO - manifestparser == 1.1 00:27:05 INFO - mozInstall == 1.12 00:27:05 INFO - mozcrash == 0.16 00:27:05 INFO - mozdebug == 0.1 00:27:05 INFO - mozdevice == 0.47 00:27:05 INFO - mozfile == 1.2 00:27:05 INFO - mozhttpd == 0.7 00:27:05 INFO - mozinfo == 0.9 00:27:05 INFO - mozleak == 0.1 00:27:05 INFO - mozlog == 3.1 00:27:05 INFO - moznetwork == 0.27 00:27:05 INFO - mozprocess == 0.22 00:27:05 INFO - mozprofile == 0.28 00:27:05 INFO - mozrunner == 6.11 00:27:05 INFO - mozscreenshot == 0.1 00:27:05 INFO - mozsystemmonitor == 0.0 00:27:05 INFO - moztest == 0.7 00:27:05 INFO - mozversion == 1.4 00:27:05 INFO - psutil == 3.1.1 00:27:05 INFO - requests == 1.2.3 00:27:05 INFO - wsgiref == 0.1.2 00:27:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:27:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:27:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:27:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:27:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7ffd6daa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1059630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea840>, '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 0x10576b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451457774.699220-419188759', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 00:27:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/talos 00:27:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/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 00:27:05 INFO - Using env: {'DISPLAY': ':0', 00:27:05 INFO - 'HOME': '/home/cltbld', 00:27:05 INFO - 'LANG': 'en_US.UTF-8', 00:27:05 INFO - 'LANGUAGE': 'en_US:en', 00:27:05 INFO - 'LOGNAME': 'cltbld', 00:27:05 INFO - 'MAIL': '/var/mail/cltbld', 00:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:27:05 INFO - 'MOZ_NO_REMOTE': '1', 00:27:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:27:05 INFO - 'NO_EM_RESTART': '1', 00:27:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:27:05 INFO - 'PWD': '/builds/slave/test-pgo', 00:27:05 INFO - 'SHELL': '/bin/bash', 00:27:05 INFO - 'SHLVL': '1', 00:27:05 INFO - 'TERM': 'linux', 00:27:05 INFO - 'TMOUT': '86400', 00:27:05 INFO - 'USER': 'cltbld', 00:27:05 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451457774.699220-419188759', 00:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:27:05 INFO - '_': '/tools/buildbot/bin/python'} 00:27:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 00:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 00:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 00:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 00:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 00:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 00:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 00:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 00:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 00:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 00:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 00:27:06 INFO - Cleaning up... 00:27:06 INFO - Return code: 0 00:27:06 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 00:27:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:27:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:27:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:27:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7ffd6daa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1059630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea840>, '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 0x10576b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451457774.699220-419188759', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 00:27:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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-pgo/build 00:27:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 00:27:06 INFO - Using env: {'DISPLAY': ':0', 00:27:06 INFO - 'HOME': '/home/cltbld', 00:27:06 INFO - 'LANG': 'en_US.UTF-8', 00:27:06 INFO - 'LANGUAGE': 'en_US:en', 00:27:06 INFO - 'LOGNAME': 'cltbld', 00:27:06 INFO - 'MAIL': '/var/mail/cltbld', 00:27:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:27:06 INFO - 'MOZ_NO_REMOTE': '1', 00:27:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:27:06 INFO - 'NO_EM_RESTART': '1', 00:27:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:27:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:27:06 INFO - 'PWD': '/builds/slave/test-pgo', 00:27:06 INFO - 'SHELL': '/bin/bash', 00:27:06 INFO - 'SHLVL': '1', 00:27:06 INFO - 'TERM': 'linux', 00:27:06 INFO - 'TMOUT': '86400', 00:27:06 INFO - 'USER': 'cltbld', 00:27:06 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451457774.699220-419188759', 00:27:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:27:06 INFO - '_': '/tools/buildbot/bin/python'} 00:27:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:27:06 INFO - Downloading/unpacking jsonschema 00:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:27:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:27:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:27:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 00:27:08 INFO - Downloading/unpacking functools32 (from jsonschema) 00:27:08 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 00:27:08 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 00:27:08 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 00:27:08 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 00:27:08 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 00:27:08 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 00:27:08 INFO - Downloading functools32-3.2.3-2.tar.gz 00:27:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 00:27:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 00:27:08 INFO - warning: no files found matching '*.txt' 00:27:08 INFO - no previously-included directories found matching 'build' 00:27:08 INFO - no previously-included directories found matching 'dist' 00:27:08 INFO - no previously-included directories found matching '.git*' 00:27:08 INFO - Installing collected packages: jsonschema, functools32 00:27:08 INFO - Running setup.py install for functools32 00:27:08 INFO - warning: no files found matching '*.txt' 00:27:08 INFO - no previously-included directories found matching 'build' 00:27:08 INFO - no previously-included directories found matching 'dist' 00:27:08 INFO - no previously-included directories found matching '.git*' 00:27:08 INFO - Successfully installed jsonschema functools32 00:27:08 INFO - Cleaning up... 00:27:08 INFO - Return code: 0 00:27:08 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 00:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:27:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:27:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:27:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:27:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd6daa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1059630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea840>, '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 0x10576b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451457774.699220-419188759', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 00:27:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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', 'flake8'] in /builds/slave/test-pgo/build 00:27:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 flake8 00:27:08 INFO - Using env: {'DISPLAY': ':0', 00:27:08 INFO - 'HOME': '/home/cltbld', 00:27:08 INFO - 'LANG': 'en_US.UTF-8', 00:27:08 INFO - 'LANGUAGE': 'en_US:en', 00:27:08 INFO - 'LOGNAME': 'cltbld', 00:27:08 INFO - 'MAIL': '/var/mail/cltbld', 00:27:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:27:08 INFO - 'MOZ_NO_REMOTE': '1', 00:27:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:27:08 INFO - 'NO_EM_RESTART': '1', 00:27:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:27:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:27:08 INFO - 'PWD': '/builds/slave/test-pgo', 00:27:08 INFO - 'SHELL': '/bin/bash', 00:27:08 INFO - 'SHLVL': '1', 00:27:08 INFO - 'TERM': 'linux', 00:27:08 INFO - 'TMOUT': '86400', 00:27:08 INFO - 'USER': 'cltbld', 00:27:08 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451457774.699220-419188759', 00:27:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:27:08 INFO - '_': '/tools/buildbot/bin/python'} 00:27:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:27:08 INFO - Downloading/unpacking flake8 00:27:08 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 00:27:08 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 00:27:08 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 00:27:08 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 00:27:08 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 00:27:08 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 00:27:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:27:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 00:27:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:27:10 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 00:27:10 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 00:27:10 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 00:27:10 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 00:27:10 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 00:27:10 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 00:27:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:27:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 00:27:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:27:10 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 00:27:10 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 00:27:10 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 00:27:10 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 00:27:10 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 00:27:10 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 00:27:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 00:27:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:27:10 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 00:27:10 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 00:27:10 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 00:27:10 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 00:27:10 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 00:27:10 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 00:27:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 00:27:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 00:27:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:27:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:27:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:27:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:27:11 INFO - no previously-included directories found matching 'docs/_build' 00:27:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:27:11 INFO - Running setup.py install for pep8 00:27:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:27:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:27:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:27:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:27:11 INFO - no previously-included directories found matching 'docs/_build' 00:27:11 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 00:27:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:27:11 INFO - Cleaning up... 00:27:11 INFO - Return code: 0 00:27:11 INFO - Running post-action listener: _resource_record_post_action 00:27:11 INFO - Running post-action listener: _start_resource_monitoring 00:27:11 INFO - Starting resource monitoring. 00:27:11 INFO - ##### 00:27:11 INFO - ##### Running install step. 00:27:11 INFO - ##### 00:27:11 INFO - Running pre-action listener: _resource_record_pre_action 00:27:11 INFO - Running main action method: install 00:27:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:27:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:27:11 INFO - Reading from file tmpfile_stdout 00:27:11 INFO - Detecting whether we're running mozinstall >=1.0... 00:27:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 00:27:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 00:27:11 INFO - Reading from file tmpfile_stdout 00:27:11 INFO - Output received: 00:27:11 INFO - Usage: mozinstall [options] installer 00:27:11 INFO - Options: 00:27:11 INFO - -h, --help show this help message and exit 00:27:11 INFO - -d DEST, --destination=DEST 00:27:11 INFO - Directory to install application into. [default: 00:27:11 INFO - "/builds/slave/test-pgo"] 00:27:11 INFO - --app=APP Application being installed. [default: firefox] 00:27:11 INFO - mkdir: /builds/slave/test-pgo/build/application 00:27:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 00:27:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 00:27:27 INFO - Reading from file tmpfile_stdout 00:27:27 INFO - Output received: 00:27:27 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 00:27:27 INFO - Running post-action listener: _resource_record_post_action 00:27:27 INFO - ##### 00:27:27 INFO - ##### Running run-tests step. 00:27:27 INFO - ##### 00:27:27 INFO - Running pre-action listener: _resource_record_pre_action 00:27:27 INFO - Running main action method: run_tests 00:27:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 00:27:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 00:27:27 INFO - Python 2.7.3 00:27:27 INFO - Return code: 0 00:27:27 INFO - grabbing minidump binary from tooltool 00:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:27:27 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-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea840>, '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 0x10576b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1057b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 00:27:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 00:27:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 00:27:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:27:27 INFO - Return code: 0 00:27:27 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 00:27:27 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 00:27:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 00:27:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 00:27:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 00:27:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 00:27:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 00:27:28 INFO - Return code: 0 00:27:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 00:27:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 00:27:28 INFO - Using env: {'DISPLAY': ':0', 00:27:28 INFO - 'HOME': '/home/cltbld', 00:27:28 INFO - 'LANG': 'en_US.UTF-8', 00:27:28 INFO - 'LANGUAGE': 'en_US:en', 00:27:28 INFO - 'LOGNAME': 'cltbld', 00:27:28 INFO - 'MAIL': '/var/mail/cltbld', 00:27:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:27:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 00:27:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:27:28 INFO - 'MOZ_NO_REMOTE': '1', 00:27:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:27:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:27:28 INFO - 'NO_EM_RESTART': '1', 00:27:28 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:27:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:27:28 INFO - 'PWD': '/builds/slave/test-pgo', 00:27:28 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 00:27:28 INFO - 'SHELL': '/bin/bash', 00:27:28 INFO - 'SHLVL': '1', 00:27:28 INFO - 'TERM': 'linux', 00:27:28 INFO - 'TMOUT': '86400', 00:27:28 INFO - 'USER': 'cltbld', 00:27:28 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451457774.699220-419188759', 00:27:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:27:28 INFO - '_': '/tools/buildbot/bin/python'} 00:27:28 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 00:27:28 INFO - mozversion application_buildid: 20151229215656 00:27:28 INFO - mozversion application_changeset: 77420c71e0d49620c056cbd4a74cb1e41a891ac5 00:27:28 INFO - mozversion application_display_name: Nightly 00:27:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:27:28 INFO - mozversion application_name: Firefox 00:27:28 INFO - mozversion application_remotingname: firefox 00:27:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:27:28 INFO - mozversion application_vendor: Mozilla 00:27:28 INFO - mozversion application_version: 46.0a1 00:27:28 INFO - mozversion platform_buildid: 20151229215656 00:27:28 INFO - mozversion platform_changeset: 77420c71e0d49620c056cbd4a74cb1e41a891ac5 00:27:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:27:28 INFO - mozversion platform_version: 46.0a1 00:27:28 INFO - using testdate: 1451464048 00:27:28 INFO - actual date: 1451464048 00:27:28 INFO - starting webserver on 'localhost:58832' 00:27:28 INFO - SUITE-START | Running 3 tests 00:27:28 INFO - TEST-START | dromaeo_css 00:27:28 INFO - operating with platform_type : linux_ 00:27:28 INFO - Initialising browser for dromaeo_css test... 00:27:28 INFO - TEST-INFO | started process 15275 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpntyD7U/profile http://localhost:58832/getInfo.html) 00:27:33 INFO - PROCESS | 15275 | __metrics Screen width/height:1600/1200 00:27:33 INFO - PROCESS | 15275 | colorDepth:24 00:27:33 INFO - PROCESS | 15275 | Browser inner width/height: 1024/697 00:27:33 INFO - PROCESS | 15275 | __metrics 00:27:33 INFO - PROCESS | 15275 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 00:27:34 INFO - TEST-INFO | 15275: exit 0 00:27:34 INFO - Browser initialized. 00:27:34 INFO - Running cycle 1/1 for dromaeo_css test... 00:27:34 INFO - TEST-INFO | started process 15409 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpntyD7U/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:27:45 INFO - PROCESS | 15409 | RSS: Main: 150245376 00:27:45 INFO - PROCESS | 15409 | 00:28:35 INFO - PROCESS | 15409 | 1451464115545 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] 00:30:44 INFO - PROCESS | 15409 | Cycle 1(1): loaded http://localhost:58832/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58832/tests/dromaeo/cssquery-ext.html) 00:30:45 INFO - PROCESS | 15409 | RSS: Main: 157827072 00:30:45 INFO - PROCESS | 15409 | 00:33:47 INFO - PROCESS | 15409 | Cycle 1(1): loaded http://localhost:58832/tests/dromaeo/cssquery-ext.html (next: http://localhost:58832/tests/dromaeo/cssquery-jquery.html) 00:33:48 INFO - PROCESS | 15409 | RSS: Main: 153255936 00:33:48 INFO - PROCESS | 15409 | 00:36:50 INFO - PROCESS | 15409 | Cycle 1(1): loaded http://localhost:58832/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58832/tests/dromaeo/cssquery-mootools.html) 00:36:50 INFO - PROCESS | 15409 | RSS: Main: 151453696 00:36:50 INFO - PROCESS | 15409 | 00:39:52 INFO - PROCESS | 15409 | Cycle 1(1): loaded http://localhost:58832/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58832/tests/dromaeo/cssquery-prototype.html) 00:39:53 INFO - PROCESS | 15409 | RSS: Main: 152825856 00:39:53 INFO - PROCESS | 15409 | 00:42:55 INFO - PROCESS | 15409 | Cycle 1(1): loaded http://localhost:58832/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58832/tests/dromaeo/cssquery-yui.html) 00:42:56 INFO - PROCESS | 15409 | RSS: Main: 150499328 00:42:56 INFO - PROCESS | 15409 | 00:45:58 INFO - PROCESS | 15409 | Cycle 1(1): loaded http://localhost:58832/tests/dromaeo/cssquery-yui.html (next: http://localhost:58832/tests/dromaeo/cssquery-dojo.html) 00:45:58 INFO - PROCESS | 15409 | RSS: Main: 152477696 00:45:58 INFO - PROCESS | 15409 | 00:45:58 INFO - PROCESS | 15409 | __start_tp_report 00:45:58 INFO - PROCESS | 15409 | _x_x_mozilla_page_load 00:45:58 INFO - PROCESS | 15409 | _x_x_mozilla_page_load_details 00:45:58 INFO - PROCESS | 15409 | |i|pagename|runs| 00:45:58 INFO - PROCESS | 15409 | |0;dojo.html;3183.3792410479955;3245.902622921312;3277.6394596594387;3298.521714351419;3298.5711857458527;5218.8695282617955;5294.761735721897;5352.304200453946;5357.91963120553;5366.70483123428;5279.63042587019;5334.1732031535175;5406.945930540694;5437.619366644337;5452.073147564914;4578.496365399803;4821.734804585755;5004.449510553836;5013.674111182761;5021.924671129936;4810.158222311099;4920.040592084545;4921.064997650453;4989.65072444929;4999.900001999958;4817.662763606567;4879.170541008037;4899.7550122494085;4919.11455937931;4950.950490495121;4890.175718849848;4902.975485122587;4912.852614421573;4929.112759703252;4946.851594452172;4746.240601503778;4825.879353016203;4889.926651100236;4909.607231421478;4918.877028074291;5160.225966105077;5187.818426355059;5231.058409486291;5236.7905283788605;5296.443873393316;5757.798477053283;5811.157382179603;5821.912671309934;5829.562782791308;5831.446012628793;5637.900609381172;5755.223044888929;5811.3316968548315;5846.649201047951;5847.26909136358;5444.428335024844;5493.450654934474;5497.147942068986;5501.284832971728;5506.256655351516;5952.642841429528;5973.104034394789;5988.610740301953;5989.431004054608;6008;5575.191597218381;5678.063119585222;5739.827805165852;5753.165790960371;5890.263717035371;5803.82588522345;5810.767569297181;5814.069748840166;5817.040188368872;5819.679917604488;5732.369439361667;5782.3639399666;5788.45009724084;5791.913121303184;5803.593748437569;5662.433756624305;5752.28096487939;5757.0788673811985;5799.9130013049835;5839.9124013139835;4453.51011388747;4464.910701785946;4484.955150448519;4487.6185524230805;4488.932666010012;3993.0815912340327;4013.13717550728;4016.879493615196;4022.235775202702;4049.8582549610624;5390.757415916293;5397.082495975694;5409.377921539073;5409.7295135243085;5450.645708028966;5738.971305143447;5792.362840087587;5799.8550036249435;5813.447722466359;5826.359100498942;5279.656822306614;5334.813281535127;5449.782008719607;5453.045716999509;5462.453754624506;5015.824446144367;5082.517160869711;5091.694498330112;5098.362704661918;5113.360829896263;6021.096835474714;6030.216071910711;6047.425494578096;6047.879042419215;6055.788047418319;5703.657780533182;5795.681237531976;5811.53507719373;5816.156657284755;5844.94155058461;5971.581989260884;6038;6043.939560604338;6045.153678485103;6094.299155597163;5717.885642287214;5760.279965004374;5774.0184168690585;5781.884362312814;5783.942160578508;5648.745806438802;5744.224529688606;5841.678707670949;5876.294844618673;5877.059670452707;5676.9716151420635;5690.943090569207;5719.399463056319;5733.799317023884;5745.569082318926;5685;5713.22871412354;5714.3999880012;5714.79998200061;5715.485606295287;5485.945140548703;5575.888482230252;5578.414266501959;5582.218489411567;5594.440555944536;5608.07466767995;5637.069883469346;5638.971805140948;5689.175069614966;5698;5538.446155384429;5561.972190139023;5620.606557540933;5659.26429564154;5663.207150998781 00:45:58 INFO - PROCESS | 15409 | |1;ext.html;527.817902823526;529.4123522889593;540.9296791417115;547.3677902023163;560.834553806627;34386.14034649135;35631;35749;35822.64177358232;35975.64024359759;40642.187156256856;41479.37780933289;41483.585164148346;41554.58445415545;41662;8444.366672499556;8586.356023298247;8654.177853103945;8658;8672.739817805475;8375.581220938928;8499.065102838682;8504.829903401927;8507.787305317355;8515.48907065578;8595.097514760953;8720.258778003878;8746.518941458216;8785.38502304839;8791.428557143765;8657.393982421234;8694.130586941319;8709.695160669378;8716.956415217915;8736.650533978633;8540.871886921701;8556.61495232716;8591.6992905248;8611.698590549364;8662.913370866274;37134.25731485355;37580.81209593962;37788;37850.242995140215;37863.24273514514;3173.698498642625;3205.1506350817053;3283.540304357392;3363.6131844837914;3501.544799176116;29256.268593285124;29734.405311893643;30136;30540.54189187164;30774.38451230985;3633.5458067741533;3671.5777685566236;3690.6309369063147;3746.194568167857;3764.73646844721;263746;265442;266980;267112;267213;54072.18891716628;55296;57773;61337.38662613406;62821.37178628246;55774.442255577735;55814.16278755822;55815.44184558102;55817.441825582035;56314;14422.783658245135;14457.204853732936;14517.419303227964;14590.489332873298;14645.780313295309;9863.852042219372;9935.65225217114;9951.154151897024;9956.751081223027;9968.40189588627;20351.79648203499;20567.588648226953;20667.483312916997;20672.793272067087;20740.688889666668;7558.659860306299;7729.806754831062;7775.3390961767755;7795.298423141944;7885.6594378955715;911.444019148319;918.7106061590578;1015.1675625986768;1079.2391364088298;1130.214500921868;26597.73402265991;26950.5957410639;27056;28800;30410.69589304123;1022.3610243597751;1034.384541197986;1049.1292227451197;1051.6371851711147;1072.1155047086186;14030.649233769238;14287.142571485745;14362.044451096228;14476.638084047772;14546.272686365639;326497;330148;331265;332581;333590;50913.745431273346;50973;51076.23385649218;51083.23375149376;51210.74394628003;1352.7294541091821;1358.9252591107584;1363.3047145955634;1365.3651052260548;1366.4397596985189;27075.86462067677;27083.59374609343;27633.171004869888;27678.44643107167;27845;48459.75770121127;49987.50012499828;50080.749596251786;50262.497375025785;50313.49686503088;209874;211768;211799;212802;213125;30593;31696.683033169375;32178.35643287168;32227.516587250742;32264;37725.245495090494;37895.81052094832;37984.62015379811;38207.42688859725;38848;30749.077527674206;31221.37557248797;32540;34844.477332840535;35347.293054139285;33772.49341259834;34854.65145348514;34924.30151397009;35019.124521887155;35153.47269791007;35563.466548001285;35661.82169089138;36095;36263;36618.45072323864;28153.859230703714;28317.57523637106;30133.849330753204;30432.239194020327;30550.388992220476;23515.647265290692;25166.49667006613;25471.617925731498;25658.48683026292;25703.357416064748 00:45:58 INFO - PROCESS | 15409 | |2;jquery.html;350.42705177035543;350.84562792371355;352.8782570013346;353.07318289490087;354.6240984556372;16668.416605418814;17150.914245428772;17240.56898577533;17976.370827021055;18108;11144.721381965455;12137.757244855098;16897.915510422463;16910.06994615296;16983.405580804676;4817.445993710716;5055.620828437864;5068.569171620398;5072.9746351268195;5092.949070509285;5018.548330650241;5046.3187469691675;5055.115354812911;5057.721825299607;5068.366454193226;4940.3330550375595;5434.510894019538;5545.1682247662975;5702.942970570282;5752.252207213057;5521.806736764194;5619.6066275360745;5648.858778530549;5662.17898404729;6041.426064523863;5339.733013349317;5380.784768609251;5404.756785944642;5405.324334458192;5408.161734931092;12432.75134497305;16109.516714498584;19650.80349196504;20456;20766.37700868961;2045.0183911722456;2131.8294536437047;2146.9355919322447;2155.9784402155933;2165.231342873273;9367.859482107773;9374.250059995184;9562.18721408681;9705.126538611488;9832.950835245778;1755.10489650278;1828.3692126216433;1843.382466873599;1851.629674065179;1870.803565625617;58953.705231474;61168.694156529375;61201;61393.46516337083;61597.38402616006;9844.753881153028;10132.392056476636;10313.84529232062;10323.638672646572;10383.598214241132;13278.800817987545;13319.533816316383;13324.800127998087;13363.665908352368;13370.39833207508;7326.157491888394;7349.853002939912;7386.815329616803;7489.176190619028;7585.393168546503;6978;6994.825129371807;7010.369066784014;7030.2969703029285;7049.506534542636;4390.604845563851;4480.238359478896;4481.820727170942;4484.798184081724;4514.052049069732;1720.1571230097163;1787.0707232239163;1810.4116162247321;1838.411708253346;1849.6393203325492;906.1527471813876;922.1424075609614;947.0955237747934;1021.5760459409262;1024.8360262358135;15249.390024399121;15984.36062557508;16053.117078560557;16196.433124840574;16283.592910177103;891.5809569502323;920.089111779347;927.3740225347864;952.5618215620754;1004.4626125023077;9287.746154269087;9429.57566909477;9571.473568953636;9614.134727874385;9785.804283914424;554053;565178;566757;570032;572940;43740.56259437365;65882.6823463528;78296;81134.59432702798;85060.57469712613;1124.5886412552195;1142.7600203957095;1145.4101137913815;1147.036489348951;1153.1236260442124;15228.923855380652;15370.615734606725;15485.458008970083;15596.064236145867;15941.043537387794;35547.28905421929;36133.457998129525;36256.45615315825;36424.08939776527;36568.08579785527;41580.792096039324;42484.362734559625;42597;43364.566354337316;43882;9275.72172834816;9801.950990245003;9810.803783924139;9824.214062875095;9844.064813842673;17342.393016244874;17404.651906962044;17498.9125054379;17670.116494175498;18173;13905;13925.79111313311;14032.438702451787;14276.57170284893;14581.416743330572;13574.117682350616;13870.682285182891;14286.857131428553;14288.714225715636;14406;14235.217063061631;14288.214148221532;14378.35297411598;14440.133591984515;14897.776533351791;9086.409383390059;9266.814663706553;9483.952580237055;9606.903930960601;9640.373375730836;9361.297902657465;9603.675138362238;9743;10608.787824243625;10849.240553161202 00:45:58 INFO - PROCESS | 15409 | |3;mootools.html;1407.5355132806178;1409.3376113226784;1536.7464368379217;1719.4239929623575;1738.113562083338;7027.5080744347915;7070.363667269945;7174.2108368079535;7214.386777123944;7237.31245531675;7096.077509923703;7127.750528731495;7133.894246391805;7170.032045673833;7174.1032370953635;2232.754397016327;2234.530748542808;2257.345369842744;2261.592913275618;2267.954640907181;2245.2702871566726;2248.055816557042;2288.2563166970717;2289.599320118981;2289.6794448777187;2218.223621732389;2227.7438094619083;2247.505548779266;2248.5615305015526;2292.8165746740306;2218.3344996500987;2227.6658501224783;2258.6386178211487;2259.20927675314;2266.512699769541;2252.3805953362794;2284.314705588317;2286.8856557172076;2288.8741119238434;2290;7106.680199391039;7130.322619351154;7147.285271472863;7155.463340249502;7210.783676489714;4411.404460397837;4467.374567560544;4489;4490.932636010462;4495.2133376659285;2903.622529071228;2970.4207679502506;3001.2046807596003;3010.458117538842;3019;858.1675774498726;864.4957773474173;877.1316396767155;883.2492381475759;911.4258017448965;9544;9585.904140958572;9619.2785541084;9635.807283854283;9677.90322096784;3963.286608410456;3982.721209515364;3999.0002499375155;4013.538443079025;4026.255142798592;7941.166177551389;7972.2824945755165;7974.202579741979;8017.0379554452675;8028.558429286329;4424.513303536608;4454.888627784331;4463.642908567307;4484.865454036384;4492.348609451611;4002.69979751514;4087.7751723655483;4110.05468742191;4147.688923330762;4149.564295748964;3376.2403459221478;3422.401079811073;3422.418188907892;3424.143964008998;3458.429359155711;1033.6847261585137;1038.1383451735194;1039.9428031458342;1041.2034793383068;1044.9738756531146;1247.2703468470866;1251.2367455851922;1255.9434825432877;1261.0416083776397;1265.6962329040964;6675.132232809704;6698.531102822755;6739.0902228198565;6770.72917083321;6783.152105986752;489.2490027807299;492.7117636182873;494.8960718249208;496.95030496950017;497.6740235145985;5247.475252474798;5284.207368894619;5288.603354748409;5295.867603309948;5298.496642819003;8313.6674533018;8359.916400835913;8470.15298470148;8526.31789456842;8648.654053837776;8391.62237699305;8503.23470887623;8505.914940850636;8521.616527256288;8526.488410695378;6476.902846457307;6705.6982435790505;6802.65986700663;6855.760048398282;6888.484533402643;6685.39831415175;6789.15135608049;6827.897581536182;6835.897461537981;6852.040714300102;7574.545527268381;7679.193684663253;7768.7669369918995;7780.649870755717;7822.765317040498;7799.298063174341;7839.05931288249;7899.210078992055;8034.959825200836;8072.354211662935;6135.662538560422;6335.1447554579545;6343.619382837044;6369.14016607752;6384.9784034556105;6824;6841.076454678555;6841.863162736817;6866.828329291808;6896.27589103137;6324.272708638566;6386.616802991835;6413.583117097373;6512.413882750575;6612.966935165486;6392.552521323462;6397.4562162216735;6474.773382931575;6499.6750162492635;6525.7063432146615;6334.239891213084;6467.838304042437;6484.708188131451;6485.44873685742;6486.675666216576;6005.459508644243;6010.248718910137;6017.87964240704;6037.849053773691;6091.451769340781;6060.454559089703;6072.8785424292155;6093.817185484442;6095;6105.961986462401 00:45:58 INFO - PROCESS | 15409 | |4;prototype.html;327.07927184974295;331.31913916900777;336.62298225986893;337.1722421455327;341.8957218048496;6217.440430361266;6272.3100458949475;6272.498200143989;6348.555601107919;6395.456386207166;6235.657038862861;6273.937260627404;6274.247090349165;6277.309495955441;6294.118823364733;4698.506656801038;4707;4709;4711.481737008926;4715.08055929094;4676.181668208067;4708.882277943045;4711.199096153645;4720.881977950545;4732.574068333849;4533.184026875161;4574.062317224961;4609.53904609538;4632.629389648837;4655.976720116395;4616.884577885579;4631.907361852761;4643.257078867382;4643.396358473411;4645.326427667969;3992;3995.880123596297;4036.9503928978384;4042.393640953851;4054.209429161315;5922.052471604566;5929.347771745104;5930.406959304079;5959.344472108065;6012.368701286389;5321.228421878806;5466.808661696821;5470.152126420411;5502.80740174096;5518.475744804237;6600.108985286973;6613.93386066138;6620.834479138012;6627.966860165717;6630.767923122716;4474.485434175079;4514.8194072237075;4521.59305662492;4524.6606504511965;4537.9773101134615;6794.45644348451;6919.100516932817;6991.510594258404;7000.789976300668;7002.824929376756;4632.513586073481;4653.395058642423;4666.136764698542;4667.416572928384;4669.439667239885;4672.43930728308;4696.694714843593;4701.78841952113;4719.2921061841;4726.574608285202;5478.835634930959;5490.258815059996;5492.176173573996;5493.670379777146;5512.200730893998;6453.354664533603;6648.634325112069;6669.1330127083165;6673.299303573152;6710;1589.745640697483;1598.5044636162827;1599.7120518306817;1603.3987254779458;1603.4708546179734;1068.8931106889404;1083.9566417343217;1085.3108276244484;1090.138790355626;1103.1560855945208;6355.332690067568;6386.2975072741965;6402.943514320178;6421.133147025185;6421.486281097501;6909.412699920463;6926.272741362084;6926.896096558556;6929.826754331081;6934.7226110955;6290.433860952537;6408.070829729663;6411.358864113551;6470.158879345655;6493.155889734304;3769.3780526212868;3790.6019867914024;3792.563855156692;3804.980975095162;3813.370793819044;7281.4538909582;7300.890486642598;7324.780256592311;7357.301056399633;7359.37445317154;7015.158181018209;7166.140063192451;7168.17565979919;7202.783916482514;7204.56772593646;7237.095363079615;7265.745698900513;7288.08898887639;7298.817529561803;7326.194118646945;6939.583624982517;6968.756093536702;6969.745445819801;6977.511574189961;6987.545809522365;6646.202455705346;6840.315968403319;6858.794236172923;6882.965585172042;6896.344847239504;7238;7240.52936559122;7260;7303.488755787044;7342.265773422829;4475.865724028285;4482.529334419969;4500.257457519473;4525.570070843265;4533.365328853897;6809.89785153233;6916.273791251846;6925.965370173117;6973.163220413583;6975.686094125675;6769.1876974763345;6776.966115169393;6780.321967803377;6782.152230971129;6783;6570.178727659043;6690.330966903271;6717.529772915849;6728.05807187004;6760.763373282109;6645.235797883305;6649.135612370555;6650.035744817072;6650.501212408992;6677.599344039373;6792.694328755119;6801.081853949653;6818.8636227276165;6827.931720682928;6848.6918088687125;6532.477401807939;6639.4688424924925;6655.467562594884;6668.599884006975;6680.465562755066 00:45:58 INFO - PROCESS | 15409 | |5;yui.html;709.2234003765875;737.9704811807528;780.7969927818765;788.7949133225361;829.9998501805321;13016.349182540871;13286.33568321585;13305.06864519484;13308.733825323488;13316.866831331683;12504.249745015282;12529.874701252984;12633.242005479678;12646.873531264684;12991.675208119801;796.6176235407008;809.9996504317163;811.0551207842856;811.0875265326507;813.2355585749406;807.0799288810761;821.8479581277453;823.0781524692353;823.9299659528947;826.3554427546524;837.9120192379804;846.4455781463151;851.4380508864151;855.4439614250756;857.237059017475;844.2950136635916;849.6516428264413;849.8300339932007;850.0309647002422;850.3579797253096;624.753222477119;625.8967270400424;626.5394934722975;628.0140179917531;629.8110566829932;12627.684307892285;12674.683132921658;12719;12727;12747;11652.417379131095;11936.70158246042;12085.879141208563;12296.815547766791;12529.874701253053;9872.851907221397;9884.209263258994;9953.452560109263;9994.350367226107;10127.645532406405;3608.4767708682357;3615.4215325547784;3619.2942376236642;3656.3784156693428;3738.5887552369218;48645.75677121627;48696.51303486991;49115.75442122802;49418.75290623524;49513;9316.161545460942;9333.3933294337;9497.5726092326;9657.22742180624;9675.03249675027;17619.119044047748;17627;17636.911815441097;17643.117844107743;17684.29262829498;7809.101953275446;7833.451658383859;7956.880646790303;7969.442139050211;8060.166596751953;3981.9402708959387;4088.325426304686;4127.711060225755;4202.810873510699;4211.452511173589;3043.1174959261566;3049.161480592855;3071.324308652093;3078.0919628709585;3084.0901933929545;539.1212323911998;555.8110242517563;565.4910580477604;567.8381661226531;568.556525909791;490.5021403275678;506.35692670308504;511.98464046078675;518.6602775182187;539.9929132168478;6706.765263215764;8156.306713929263;8202.794930126674;8318.417710760188;8450.323974082181;518.7535920437838;519.9740012999334;581.8021872563348;623.5416968528128;630.7290809019829;3801.0994502748626;3929.390944403622;3989.960100399017;4075.4701888754867;4086.468759061303;58600.706996464745;58821;58834;58908.1163782535;59257.40742592519;49212;49352.50647493551;50244.74877625588;50297.74851125721;50346.49653503418;47169.05661886743;47772.76113619479;47875.28187077196;48125.75937120292;48700.5129948703;8014.479058861155;8089.635966381409;8151.63317650719;8258.42191046621;8336.708215212439;36639.63360366469;37451;37454.81272593619;37559.43660845144;38162.80918595389;42756;42940.570594293655;46579;47239;47463;9883.901160988586;10199.898001019896;10818;10860.728481788019;10997.450127493754;11194.880511949066;11280.830787538029;11294.94352528265;11731.296122232694;12112.878871211175;10569.682909512727;10636.627718029831;11041.889581104086;11068.889311106786;11396.886031139582;11227.15796315296;11427.542898283975;11443.313401195956;11809.05527557776;12209.877901221229;10992.725181870517;11031.282966607145;11242.60650877248;11364.659060228207;11606.724198134318;8672;8739.169778870997;8766.430182038148;9004.59479323419;9107.408018478778;7994.760157195294;8049.678012879419;8546.145385461652;8674.609642566225;8843.955780221315 00:45:58 INFO - PROCESS | 15409 | __end_tp_report 00:45:58 INFO - PROCESS | 15409 | __start_cc_report 00:45:58 INFO - PROCESS | 15409 | _x_x_mozilla_cycle_collect,307 00:45:58 INFO - PROCESS | 15409 | __end_cc_report 00:45:58 INFO - PROCESS | 15409 | __startTimestamp1451465158567__endTimestamp 00:45:58 INFO - PROCESS | 15409 | 00:45:58 INFO - PROCESS | 15409 | ------- Summary: start ------- 00:45:58 INFO - PROCESS | 15409 | Number of tests: 6 00:45:58 INFO - PROCESS | 15409 | 00:45:58 INFO - PROCESS | 15409 | [#0] dojo.html Cycles:165 Average:5383.97 Median:5594.44 stddev:599.81 (10.7%) stddev-sans-first:576.27 00:45:58 INFO - PROCESS | 15409 | Values: 3183.4 3245.9 3277.6 3298.5 3298.6 5218.9 5294.8 5352.3 5357.9 5366.7 5279.6 5334.2 5406.9 5437.6 5452.1 4578.5 4821.7 5004.4 5013.7 5021.9 4810.2 4920.0 4921.1 4989.7 4999.9 4817.7 4879.2 4899.8 4919.1 4951.0 4890.2 4903.0 4912.9 4929.1 4946.9 4746.2 4825.9 4889.9 4909.6 4918.9 5160.2 5187.8 5231.1 5236.8 5296.4 5757.8 5811.2 5821.9 5829.6 5831.4 5637.9 5755.2 5811.3 5846.6 5847.3 5444.4 5493.5 5497.1 5501.3 5506.3 5952.6 5973.1 5988.6 5989.4 6008.0 5575.2 5678.1 5739.8 5753.2 5890.3 5803.8 5810.8 5814.1 5817.0 5819.7 5732.4 5782.4 5788.5 5791.9 5803.6 5662.4 5752.3 5757.1 5799.9 5839.9 4453.5 4464.9 4485.0 4487.6 4488.9 3993.1 4013.1 4016.9 4022.2 4049.9 5390.8 5397.1 5409.4 5409.7 5450.6 5739.0 5792.4 5799.9 5813.4 5826.4 5279.7 5334.8 5449.8 5453.0 5462.5 5015.8 5082.5 5091.7 5098.4 5113.4 6021.1 6030.2 6047.4 6047.9 6055.8 5703.7 5795.7 5811.5 5816.2 5844.9 5971.6 6038.0 6043.9 6045.2 6094.3 5717.9 5760.3 5774.0 5781.9 5783.9 5648.7 5744.2 5841.7 5876.3 5877.1 5677.0 5690.9 5719.4 5733.8 5745.6 5685.0 5713.2 5714.4 5714.8 5715.5 5485.9 5575.9 5578.4 5582.2 5594.4 5608.1 5637.1 5639.0 5689.2 5698.0 5538.4 5562.0 5620.6 5659.3 5663.2 00:45:58 INFO - PROCESS | 15409 | 00:45:58 INFO - PROCESS | 15409 | [#1] ext.html Cycles:180 Average:43704.39 Median:35646.41 stddev:71652.98 (201.0%) stddev-sans-first:71780.65 00:45:58 INFO - PROCESS | 15409 | Values: 527.8 529.4 540.9 547.4 560.8 34386.1 35631.0 35749.0 35822.6 35975.6 40642.2 41479.4 41483.6 41554.6 41662.0 8444.4 8586.4 8654.2 8658.0 8672.7 8375.6 8499.1 8504.8 8507.8 8515.5 8595.1 8720.3 8746.5 8785.4 8791.4 8657.4 8694.1 8709.7 8717.0 8736.7 8540.9 8556.6 8591.7 8611.7 8662.9 37134.3 37580.8 37788.0 37850.2 37863.2 3173.7 3205.2 3283.5 3363.6 3501.5 29256.3 29734.4 30136.0 30540.5 30774.4 3633.5 3671.6 3690.6 3746.2 3764.7 263746.0 265442.0 266980.0 267112.0 267213.0 54072.2 55296.0 57773.0 61337.4 62821.4 55774.4 55814.2 55815.4 55817.4 56314.0 14422.8 14457.2 14517.4 14590.5 14645.8 9863.9 9935.7 9951.2 9956.8 9968.4 20351.8 20567.6 20667.5 20672.8 20740.7 7558.7 7729.8 7775.3 7795.3 7885.7 911.4 918.7 1015.2 1079.2 1130.2 26597.7 26950.6 27056.0 28800.0 30410.7 1022.4 1034.4 1049.1 1051.6 1072.1 14030.6 14287.1 14362.0 14476.6 14546.3 326497.0 330148.0 331265.0 332581.0 333590.0 50913.7 50973.0 51076.2 51083.2 51210.7 1352.7 1358.9 1363.3 1365.4 1366.4 27075.9 27083.6 27633.2 27678.4 27845.0 48459.8 49987.5 50080.7 50262.5 50313.5 209874.0 211768.0 211799.0 212802.0 213125.0 30593.0 31696.7 32178.4 32227.5 32264.0 37725.2 37895.8 37984.6 38207.4 38848.0 30749.1 31221.4 32540.0 34844.5 35347.3 33772.5 34854.7 34924.3 35019.1 35153.5 35563.5 35661.8 36095.0 36263.0 36618.5 28153.9 28317.6 30133.8 30432.2 30550.4 23515.6 25166.5 25471.6 25658.5 25703.4 00:45:58 INFO - PROCESS | 15409 | 00:45:58 INFO - PROCESS | 15409 | [#2] jquery.html Cycles:180 Average:29023.47 Median:42540.68 stddev:92335.73 (217.1%) stddev-sans-first:92569.65 00:45:58 INFO - PROCESS | 15409 | Values: 350.4 350.8 352.9 353.1 354.6 16668.4 17150.9 17240.6 17976.4 18108.0 11144.7 12137.8 16897.9 16910.1 16983.4 4817.4 5055.6 5068.6 5073.0 5092.9 5018.5 5046.3 5055.1 5057.7 5068.4 4940.3 5434.5 5545.2 5702.9 5752.3 5521.8 5619.6 5648.9 5662.2 6041.4 5339.7 5380.8 5404.8 5405.3 5408.2 12432.8 16109.5 19650.8 20456.0 20766.4 2045.0 2131.8 2146.9 2156.0 2165.2 9367.9 9374.3 9562.2 9705.1 9833.0 1755.1 1828.4 1843.4 1851.6 1870.8 58953.7 61168.7 61201.0 61393.5 61597.4 9844.8 10132.4 10313.8 10323.6 10383.6 13278.8 13319.5 13324.8 13363.7 13370.4 7326.2 7349.9 7386.8 7489.2 7585.4 6978.0 6994.8 7010.4 7030.3 7049.5 4390.6 4480.2 4481.8 4484.8 4514.1 1720.2 1787.1 1810.4 1838.4 1849.6 906.2 922.1 947.1 1021.6 1024.8 15249.4 15984.4 16053.1 16196.4 16283.6 891.6 920.1 927.4 952.6 1004.5 9287.7 9429.6 9571.5 9614.1 9785.8 554053.0 565178.0 566757.0 570032.0 572940.0 43740.6 65882.7 78296.0 81134.6 85060.6 1124.6 1142.8 1145.4 1147.0 1153.1 15228.9 15370.6 15485.5 15596.1 15941.0 35547.3 36133.5 36256.5 36424.1 36568.1 41580.8 42484.4 42597.0 43364.6 43882.0 9275.7 9802.0 9810.8 9824.2 9844.1 17342.4 17404.7 17498.9 17670.1 18173.0 13905.0 13925.8 14032.4 14276.6 14581.4 13574.1 13870.7 14286.9 14288.7 14406.0 14235.2 14288.2 14378.4 14440.1 14897.8 9086.4 9266.8 9484.0 9606.9 9640.4 9361.3 9603.7 9743.0 10608.8 10849.2 00:45:58 INFO - PROCESS | 15409 | 00:45:58 INFO - PROCESS | 15409 | [#3] mootools.html Cycles:180 Average:5050.25 Median:6229.97 stddev:2549.23 (40.9%) stddev-sans-first:2541.68 00:45:58 INFO - PROCESS | 15409 | Values: 1407.5 1409.3 1536.7 1719.4 1738.1 7027.5 7070.4 7174.2 7214.4 7237.3 7096.1 7127.8 7133.9 7170.0 7174.1 2232.8 2234.5 2257.3 2261.6 2268.0 2245.3 2248.1 2288.3 2289.6 2289.7 2218.2 2227.7 2247.5 2248.6 2292.8 2218.3 2227.7 2258.6 2259.2 2266.5 2252.4 2284.3 2286.9 2288.9 2290.0 7106.7 7130.3 7147.3 7155.5 7210.8 4411.4 4467.4 4489.0 4490.9 4495.2 2903.6 2970.4 3001.2 3010.5 3019.0 858.2 864.5 877.1 883.2 911.4 9544.0 9585.9 9619.3 9635.8 9677.9 3963.3 3982.7 3999.0 4013.5 4026.3 7941.2 7972.3 7974.2 8017.0 8028.6 4424.5 4454.9 4463.6 4484.9 4492.3 4002.7 4087.8 4110.1 4147.7 4149.6 3376.2 3422.4 3422.4 3424.1 3458.4 1033.7 1038.1 1039.9 1041.2 1045.0 1247.3 1251.2 1255.9 1261.0 1265.7 6675.1 6698.5 6739.1 6770.7 6783.2 489.2 492.7 494.9 497.0 497.7 5247.5 5284.2 5288.6 5295.9 5298.5 8313.7 8359.9 8470.2 8526.3 8648.7 8391.6 8503.2 8505.9 8521.6 8526.5 6476.9 6705.7 6802.7 6855.8 6888.5 6685.4 6789.2 6827.9 6835.9 6852.0 7574.5 7679.2 7768.8 7780.6 7822.8 7799.3 7839.1 7899.2 8035.0 8072.4 6135.7 6335.1 6343.6 6369.1 6385.0 6824.0 6841.1 6841.9 6866.8 6896.3 6324.3 6386.6 6413.6 6512.4 6613.0 6392.6 6397.5 6474.8 6499.7 6525.7 6334.2 6467.8 6484.7 6485.4 6486.7 6005.5 6010.2 6017.9 6037.8 6091.5 6060.5 6072.9 6093.8 6095.0 6106.0 00:45:58 INFO - PROCESS | 15409 | 00:45:58 INFO - PROCESS | 15409 | [#4] prototype.html Cycles:180 Average:5572.33 Median:6370.82 stddev:1736.23 (27.3%) stddev-sans-first:1695.88 00:45:58 INFO - PROCESS | 15409 | Values: 327.1 331.3 336.6 337.2 341.9 6217.4 6272.3 6272.5 6348.6 6395.5 6235.7 6273.9 6274.2 6277.3 6294.1 4698.5 4707.0 4709.0 4711.5 4715.1 4676.2 4708.9 4711.2 4720.9 4732.6 4533.2 4574.1 4609.5 4632.6 4656.0 4616.9 4631.9 4643.3 4643.4 4645.3 3992.0 3995.9 4037.0 4042.4 4054.2 5922.1 5929.3 5930.4 5959.3 6012.4 5321.2 5466.8 5470.2 5502.8 5518.5 6600.1 6613.9 6620.8 6628.0 6630.8 4474.5 4514.8 4521.6 4524.7 4538.0 6794.5 6919.1 6991.5 7000.8 7002.8 4632.5 4653.4 4666.1 4667.4 4669.4 4672.4 4696.7 4701.8 4719.3 4726.6 5478.8 5490.3 5492.2 5493.7 5512.2 6453.4 6648.6 6669.1 6673.3 6710.0 1589.7 1598.5 1599.7 1603.4 1603.5 1068.9 1084.0 1085.3 1090.1 1103.2 6355.3 6386.3 6402.9 6421.1 6421.5 6909.4 6926.3 6926.9 6929.8 6934.7 6290.4 6408.1 6411.4 6470.2 6493.2 3769.4 3790.6 3792.6 3805.0 3813.4 7281.5 7300.9 7324.8 7357.3 7359.4 7015.2 7166.1 7168.2 7202.8 7204.6 7237.1 7265.7 7288.1 7298.8 7326.2 6939.6 6968.8 6969.7 6977.5 6987.5 6646.2 6840.3 6858.8 6883.0 6896.3 7238.0 7240.5 7260.0 7303.5 7342.3 4475.9 4482.5 4500.3 4525.6 4533.4 6809.9 6916.3 6926.0 6973.2 6975.7 6769.2 6777.0 6780.3 6782.2 6783.0 6570.2 6690.3 6717.5 6728.1 6760.8 6645.2 6649.1 6650.0 6650.5 6677.6 6792.7 6801.1 6818.9 6827.9 6848.7 6532.5 6639.5 6655.5 6668.6 6680.5 00:45:58 INFO - PROCESS | 15409 | 00:45:58 INFO - PROCESS | 15409 | [#5] yui.html Cycles:180 Average:13746.03 Median:49385.63 stddev:16292.02 (33.0%) stddev-sans-first:16308.31 00:45:58 INFO - PROCESS | 15409 | Values: 709.2 738.0 780.8 788.8 830.0 13016.3 13286.3 13305.1 13308.7 13316.9 12504.2 12529.9 12633.2 12646.9 12991.7 796.6 810.0 811.1 811.1 813.2 807.1 821.8 823.1 823.9 826.4 837.9 846.4 851.4 855.4 857.2 844.3 849.7 849.8 850.0 850.4 624.8 625.9 626.5 628.0 629.8 12627.7 12674.7 12719.0 12727.0 12747.0 11652.4 11936.7 12085.9 12296.8 12529.9 9872.9 9884.2 9953.5 9994.4 10127.6 3608.5 3615.4 3619.3 3656.4 3738.6 48645.8 48696.5 49115.8 49418.8 49513.0 9316.2 9333.4 9497.6 9657.2 9675.0 17619.1 17627.0 17636.9 17643.1 17684.3 7809.1 7833.5 7956.9 7969.4 8060.2 3981.9 4088.3 4127.7 4202.8 4211.5 3043.1 3049.2 3071.3 3078.1 3084.1 539.1 555.8 565.5 567.8 568.6 490.5 506.4 512.0 518.7 540.0 6706.8 8156.3 8202.8 8318.4 8450.3 518.8 520.0 581.8 623.5 630.7 3801.1 3929.4 3990.0 4075.5 4086.5 58600.7 58821.0 58834.0 58908.1 59257.4 49212.0 49352.5 50244.7 50297.7 50346.5 47169.1 47772.8 47875.3 48125.8 48700.5 8014.5 8089.6 8151.6 8258.4 8336.7 36639.6 37451.0 37454.8 37559.4 38162.8 42756.0 42940.6 46579.0 47239.0 47463.0 9883.9 10199.9 10818.0 10860.7 10997.5 11194.9 11280.8 11294.9 11731.3 12112.9 10569.7 10636.6 11041.9 11068.9 11396.9 11227.2 11427.5 11443.3 11809.1 12209.9 10992.7 11031.3 11242.6 11364.7 11606.7 8672.0 8739.2 8766.4 9004.6 9107.4 7994.8 8049.7 8546.1 8674.6 8844.0 00:45:58 INFO - PROCESS | 15409 | -------- Summary: end -------- 00:45:58 INFO - PROCESS | 15409 | 00:45:59 INFO - TEST-INFO | 15409: exit 0 00:45:59 INFO - TEST-OK | dromaeo_css | took 1110652ms 00:45:59 INFO - TEST-START | kraken 00:45:59 INFO - operating with platform_type : linux_ 00:45:59 INFO - Initialising browser for kraken test... 00:45:59 INFO - TEST-INFO | started process 15648 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpb0zypf/profile http://localhost:58832/getInfo.html) 00:46:03 INFO - PROCESS | 15648 | __metrics Screen width/height:1600/1200 00:46:03 INFO - PROCESS | 15648 | colorDepth:24 00:46:03 INFO - PROCESS | 15648 | Browser inner width/height: 1024/697 00:46:03 INFO - PROCESS | 15648 | __metrics 00:46:04 INFO - PROCESS | 15648 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 00:46:04 INFO - TEST-INFO | 15648: exit 0 00:46:04 INFO - Browser initialized. 00:46:04 INFO - Running cycle 1/1 for kraken test... 00:46:04 INFO - TEST-INFO | started process 15766 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpb0zypf/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:46:16 INFO - PROCESS | 15766 | RSS: Main: 150138880 00:46:16 INFO - PROCESS | 15766 | 00:46:19 INFO - PROCESS | 15766 | Cycle 1(1): loaded http://localhost:58832/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58832/tests/kraken/driver.html?testName=audio-beat-detection) 00:46:19 INFO - PROCESS | 15766 | RSS: Main: 150761472 00:46:19 INFO - PROCESS | 15766 | 00:46:22 INFO - PROCESS | 15766 | Cycle 1(1): loaded http://localhost:58832/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58832/tests/kraken/driver.html?testName=audio-dft) 00:46:23 INFO - PROCESS | 15766 | RSS: Main: 151339008 00:46:23 INFO - PROCESS | 15766 | 00:46:26 INFO - PROCESS | 15766 | Cycle 1(1): loaded http://localhost:58832/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58832/tests/kraken/driver.html?testName=audio-fft) 00:46:26 INFO - PROCESS | 15766 | RSS: Main: 145129472 00:46:26 INFO - PROCESS | 15766 | 00:46:28 INFO - PROCESS | 15766 | Cycle 1(1): loaded http://localhost:58832/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58832/tests/kraken/driver.html?testName=audio-oscillator) 00:46:29 INFO - PROCESS | 15766 | RSS: Main: 145522688 00:46:29 INFO - PROCESS | 15766 | 00:46:31 INFO - PROCESS | 15766 | Cycle 1(1): loaded http://localhost:58832/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58832/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:46:32 INFO - PROCESS | 15766 | RSS: Main: 146137088 00:46:32 INFO - PROCESS | 15766 | 00:46:35 INFO - PROCESS | 15766 | Cycle 1(1): loaded http://localhost:58832/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58832/tests/kraken/driver.html?testName=imaging-darkroom) 00:46:35 INFO - PROCESS | 15766 | RSS: Main: 146599936 00:46:35 INFO - PROCESS | 15766 | 00:46:39 INFO - PROCESS | 15766 | Cycle 1(1): loaded http://localhost:58832/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58832/tests/kraken/driver.html?testName=imaging-desaturate) 00:46:39 INFO - PROCESS | 15766 | RSS: Main: 147857408 00:46:39 INFO - PROCESS | 15766 | 00:46:42 INFO - PROCESS | 15766 | Cycle 1(1): loaded http://localhost:58832/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58832/tests/kraken/driver.html?testName=json-parse-financial) 00:46:43 INFO - PROCESS | 15766 | RSS: Main: 148312064 00:46:43 INFO - PROCESS | 15766 | 00:46:44 INFO - PROCESS | 15766 | Cycle 1(1): loaded http://localhost:58832/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58832/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:46:45 INFO - PROCESS | 15766 | RSS: Main: 148578304 00:46:45 INFO - PROCESS | 15766 | 00:46:47 INFO - PROCESS | 15766 | Cycle 1(1): loaded http://localhost:58832/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58832/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:46:47 INFO - PROCESS | 15766 | RSS: Main: 147660800 00:46:47 INFO - PROCESS | 15766 | 00:46:50 INFO - PROCESS | 15766 | Cycle 1(1): loaded http://localhost:58832/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58832/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:46:50 INFO - PROCESS | 15766 | RSS: Main: 149327872 00:46:50 INFO - PROCESS | 15766 | 00:46:53 INFO - PROCESS | 15766 | Cycle 1(1): loaded http://localhost:58832/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58832/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:46:53 INFO - PROCESS | 15766 | RSS: Main: 148529152 00:46:53 INFO - PROCESS | 15766 | 00:46:56 INFO - PROCESS | 15766 | Cycle 1(1): loaded http://localhost:58832/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58832/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:46:56 INFO - PROCESS | 15766 | RSS: Main: 147886080 00:46:56 INFO - PROCESS | 15766 | 00:46:58 INFO - PROCESS | 15766 | Cycle 1(1): loaded http://localhost:58832/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58832/tests/kraken/driver.html?testName=ai-astar) 00:46:58 INFO - PROCESS | 15766 | RSS: Main: 148201472 00:46:58 INFO - PROCESS | 15766 | 00:46:58 INFO - PROCESS | 15766 | __start_tp_report 00:46:58 INFO - PROCESS | 15766 | _x_x_mozilla_page_load 00:46:58 INFO - PROCESS | 15766 | _x_x_mozilla_page_load_details 00:46:58 INFO - PROCESS | 15766 | |i|pagename|runs| 00:46:58 INFO - PROCESS | 15766 | |0;ai-astar;110;106;111;110;112;123;110;111;111;111 00:46:58 INFO - PROCESS | 15766 | |1;audio-beat-detection;148;127;152;160;123;149;160;130;170;123 00:46:58 INFO - PROCESS | 15766 | |2;audio-dft;162;164;161;164;163;163;161;168;167;161 00:46:58 INFO - PROCESS | 15766 | |3;audio-fft;72;75;71;71;71;71;140;75;71;74 00:46:58 INFO - PROCESS | 15766 | |4;audio-oscillator;95;96;146;96;96;95;147;97;96;137 00:46:58 INFO - PROCESS | 15766 | |5;imaging-gaussian-blur;111;110;110;110;110;110;109;110;110;109 00:46:58 INFO - PROCESS | 15766 | |6;imaging-darkroom;146;147;146;146;147;147;146;146;145;147 00:46:58 INFO - PROCESS | 15766 | |7;imaging-desaturate;96;96;96;108;96;96;96;96;97;100 00:46:58 INFO - PROCESS | 15766 | |8;json-parse-financial;62;59;58;60;59;61;58;58;62;58 00:46:58 INFO - PROCESS | 15766 | |9;json-stringify-tinderbox;68;70;69;68;69;69;67;68;68;69 00:46:58 INFO - PROCESS | 15766 | |10;stanford-crypto-aes;85;87;85;94;88;94;86;88;87;87 00:46:58 INFO - PROCESS | 15766 | |11;stanford-crypto-ccm;129;129;120;118;118;123;117;119;131;122 00:46:58 INFO - PROCESS | 15766 | |12;stanford-crypto-pbkdf2;145;151;151;147;150;152;156;150;151;138 00:46:58 INFO - PROCESS | 15766 | |13;stanford-crypto-sha256-iterative;69;67;70;70;69;72;67;68;68;67 00:46:58 INFO - PROCESS | 15766 | __end_tp_report 00:46:58 INFO - PROCESS | 15766 | __start_cc_report 00:46:58 INFO - PROCESS | 15766 | _x_x_mozilla_cycle_collect,761 00:46:58 INFO - PROCESS | 15766 | __end_cc_report 00:46:58 INFO - PROCESS | 15766 | __startTimestamp1451465218753__endTimestamp 00:46:58 INFO - PROCESS | 15766 | 00:46:58 INFO - PROCESS | 15766 | ------- Summary: start ------- 00:46:58 INFO - PROCESS | 15766 | Number of tests: 14 00:46:58 INFO - PROCESS | 15766 | 00:46:58 INFO - PROCESS | 15766 | [#0] ai-astar Cycles:10 Average:111.50 Median:111.00 stddev:4.35 (3.9%) stddev-sans-first:4.58 00:46:58 INFO - PROCESS | 15766 | Values: 110.0 106.0 111.0 110.0 112.0 123.0 110.0 111.0 111.0 111.0 00:46:58 INFO - PROCESS | 15766 | 00:46:58 INFO - PROCESS | 15766 | [#1] audio-beat-detection Cycles:10 Average:144.20 Median:150.50 stddev:17.19 (11.4%) stddev-sans-first:18.18 00:46:58 INFO - PROCESS | 15766 | Values: 148.0 127.0 152.0 160.0 123.0 149.0 160.0 130.0 170.0 123.0 00:46:58 INFO - PROCESS | 15766 | 00:46:58 INFO - PROCESS | 15766 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.50 stddev:2.46 (1.5%) stddev-sans-first:2.55 00:46:58 INFO - PROCESS | 15766 | Values: 162.0 164.0 161.0 164.0 163.0 163.0 161.0 168.0 167.0 161.0 00:46:58 INFO - PROCESS | 15766 | 00:46:58 INFO - PROCESS | 15766 | [#3] audio-fft Cycles:10 Average:79.10 Median:71.50 stddev:21.47 (30.0%) stddev-sans-first:22.61 00:46:58 INFO - PROCESS | 15766 | Values: 72.0 75.0 71.0 71.0 71.0 71.0 140.0 75.0 71.0 74.0 00:46:58 INFO - PROCESS | 15766 | 00:46:58 INFO - PROCESS | 15766 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:96.00 stddev:23.09 (24.0%) stddev-sans-first:23.83 00:46:58 INFO - PROCESS | 15766 | Values: 95.0 96.0 146.0 96.0 96.0 95.0 147.0 97.0 96.0 137.0 00:46:58 INFO - PROCESS | 15766 | 00:46:58 INFO - PROCESS | 15766 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 00:46:58 INFO - PROCESS | 15766 | Values: 111.0 110.0 110.0 110.0 110.0 110.0 109.0 110.0 110.0 109.0 00:46:58 INFO - PROCESS | 15766 | 00:46:58 INFO - PROCESS | 15766 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 00:46:58 INFO - PROCESS | 15766 | Values: 146.0 147.0 146.0 146.0 147.0 147.0 146.0 146.0 145.0 147.0 00:46:58 INFO - PROCESS | 15766 | 00:46:58 INFO - PROCESS | 15766 | [#7] imaging-desaturate Cycles:10 Average:97.70 Median:96.00 stddev:3.83 (4.0%) stddev-sans-first:4.01 00:46:58 INFO - PROCESS | 15766 | Values: 96.0 96.0 96.0 108.0 96.0 96.0 96.0 96.0 97.0 100.0 00:46:58 INFO - PROCESS | 15766 | 00:46:58 INFO - PROCESS | 15766 | [#8] json-parse-financial Cycles:10 Average:59.50 Median:59.50 stddev:1.65 (2.8%) stddev-sans-first:1.48 00:46:58 INFO - PROCESS | 15766 | Values: 62.0 59.0 58.0 60.0 59.0 61.0 58.0 58.0 62.0 58.0 00:46:58 INFO - PROCESS | 15766 | 00:46:58 INFO - PROCESS | 15766 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:0.85 (1.2%) stddev-sans-first:0.88 00:46:58 INFO - PROCESS | 15766 | Values: 68.0 70.0 69.0 68.0 69.0 69.0 67.0 68.0 68.0 69.0 00:46:58 INFO - PROCESS | 15766 | 00:46:58 INFO - PROCESS | 15766 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:87.50 stddev:3.28 (3.8%) stddev-sans-first:3.28 00:46:58 INFO - PROCESS | 15766 | Values: 85.0 87.0 85.0 94.0 88.0 94.0 86.0 88.0 87.0 87.0 00:46:58 INFO - PROCESS | 15766 | 00:46:58 INFO - PROCESS | 15766 | [#11] stanford-crypto-ccm Cycles:10 Average:122.60 Median:122.50 stddev:5.23 (4.3%) stddev-sans-first:5.01 00:46:58 INFO - PROCESS | 15766 | Values: 129.0 129.0 120.0 118.0 118.0 123.0 117.0 119.0 131.0 122.0 00:46:58 INFO - PROCESS | 15766 | 00:46:58 INFO - PROCESS | 15766 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.10 Median:151.00 stddev:4.86 (3.2%) stddev-sans-first:4.93 00:46:58 INFO - PROCESS | 15766 | Values: 145.0 151.0 151.0 147.0 150.0 152.0 156.0 150.0 151.0 138.0 00:46:58 INFO - PROCESS | 15766 | 00:46:58 INFO - PROCESS | 15766 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.64 (2.4%) stddev-sans-first:1.73 00:46:58 INFO - PROCESS | 15766 | Values: 69.0 67.0 70.0 70.0 69.0 72.0 67.0 68.0 68.0 67.0 00:46:58 INFO - PROCESS | 15766 | -------- Summary: end -------- 00:46:58 INFO - PROCESS | 15766 | 00:46:59 INFO - TEST-INFO | 15766: exit 0 00:46:59 INFO - TEST-OK | kraken | took 60330ms 00:46:59 INFO - TEST-START | v8_7 00:46:59 INFO - operating with platform_type : linux_ 00:46:59 INFO - Initialising browser for v8_7 test... 00:46:59 INFO - TEST-INFO | started process 16057 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpD4paod/profile http://localhost:58832/getInfo.html) 00:47:04 INFO - PROCESS | 16057 | __metrics Screen width/height:1600/1200 00:47:04 INFO - PROCESS | 16057 | colorDepth:24 00:47:04 INFO - PROCESS | 16057 | Browser inner width/height: 1024/697 00:47:04 INFO - PROCESS | 16057 | __metrics 00:47:04 INFO - PROCESS | 16057 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 00:47:05 INFO - TEST-INFO | 16057: exit 0 00:47:05 INFO - Browser initialized. 00:47:05 INFO - Running cycle 1/1 for v8_7 test... 00:47:05 INFO - TEST-INFO | started process 16178 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpD4paod/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:47:16 INFO - PROCESS | 16178 | RSS: Main: 150663168 00:47:16 INFO - PROCESS | 16178 | 00:47:38 INFO - PROCESS | 16178 | Cycle 1(1): loaded http://localhost:58832/tests/v8_7/run.html (next: http://localhost:58832/tests/v8_7/run.html) 00:47:38 INFO - PROCESS | 16178 | RSS: Main: 146534400 00:47:38 INFO - PROCESS | 16178 | 00:47:38 INFO - PROCESS | 16178 | __start_tp_report 00:47:38 INFO - PROCESS | 16178 | _x_x_mozilla_page_load 00:47:38 INFO - PROCESS | 16178 | _x_x_mozilla_page_load_details 00:47:38 INFO - PROCESS | 16178 | |i|pagename|runs| 00:47:38 INFO - PROCESS | 16178 | |0;Richards;167.1402306535183 00:47:38 INFO - PROCESS | 16178 | |1;DeltaBlue;189.14318138831095 00:47:38 INFO - PROCESS | 16178 | |2;Encrypt;281.37310073157005 00:47:38 INFO - PROCESS | 16178 | |3;Decrypt;5218.75 00:47:38 INFO - PROCESS | 16178 | |4;RayTrace;1059.322033898305 00:47:38 INFO - PROCESS | 16178 | |5;Earley;710.2272727272727 00:47:38 INFO - PROCESS | 16178 | |6;Boyer;12358.024691358025 00:47:38 INFO - PROCESS | 16178 | |7;RegExp;25225 00:47:38 INFO - PROCESS | 16178 | |8;Splay;683.6803223640027 00:47:38 INFO - PROCESS | 16178 | |9;NavierStokes;4830.917874396136 00:47:38 INFO - PROCESS | 16178 | __end_tp_report 00:47:38 INFO - PROCESS | 16178 | __startTimestamp1451465258645__endTimestamp 00:47:38 INFO - PROCESS | 16178 | 00:47:38 INFO - PROCESS | 16178 | ------- Summary: start ------- 00:47:38 INFO - PROCESS | 16178 | Number of tests: 10 00:47:38 INFO - PROCESS | 16178 | 00:47:38 INFO - PROCESS | 16178 | [#0] Richards Cycles:1 Average:167.14 Median:167.14 stddev:0.00 (0.0%) 00:47:38 INFO - PROCESS | 16178 | Values: 167.1 00:47:38 INFO - PROCESS | 16178 | 00:47:38 INFO - PROCESS | 16178 | [#1] DeltaBlue Cycles:1 Average:189.14 Median:189.14 stddev:0.00 (0.0%) 00:47:38 INFO - PROCESS | 16178 | Values: 189.1 00:47:38 INFO - PROCESS | 16178 | 00:47:38 INFO - PROCESS | 16178 | [#2] Encrypt Cycles:1 Average:281.37 Median:281.37 stddev:0.00 (0.0%) 00:47:38 INFO - PROCESS | 16178 | Values: 281.4 00:47:38 INFO - PROCESS | 16178 | 00:47:38 INFO - PROCESS | 16178 | [#3] Decrypt Cycles:1 Average:5218.75 Median:5218.75 stddev:0.00 (0.0%) 00:47:38 INFO - PROCESS | 16178 | Values: 5218.8 00:47:38 INFO - PROCESS | 16178 | 00:47:38 INFO - PROCESS | 16178 | [#4] RayTrace Cycles:1 Average:1059.32 Median:1059.32 stddev:0.00 (0.0%) 00:47:38 INFO - PROCESS | 16178 | Values: 1059.3 00:47:38 INFO - PROCESS | 16178 | 00:47:38 INFO - PROCESS | 16178 | [#5] Earley Cycles:1 Average:710.23 Median:710.23 stddev:0.00 (0.0%) 00:47:38 INFO - PROCESS | 16178 | Values: 710.2 00:47:38 INFO - PROCESS | 16178 | 00:47:38 INFO - PROCESS | 16178 | [#6] Boyer Cycles:1 Average:12358.02 Median:12358.02 stddev:0.00 (0.0%) 00:47:38 INFO - PROCESS | 16178 | Values: 12358.0 00:47:38 INFO - PROCESS | 16178 | 00:47:38 INFO - PROCESS | 16178 | [#7] RegExp Cycles:1 Average:25225.00 Median:25225.00 stddev:0.00 (0.0%) 00:47:38 INFO - PROCESS | 16178 | Values: 25225.0 00:47:38 INFO - PROCESS | 16178 | 00:47:38 INFO - PROCESS | 16178 | [#8] Splay Cycles:1 Average:683.68 Median:683.68 stddev:0.00 (0.0%) 00:47:38 INFO - PROCESS | 16178 | Values: 683.7 00:47:38 INFO - PROCESS | 16178 | 00:47:38 INFO - PROCESS | 16178 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 00:47:38 INFO - PROCESS | 16178 | Values: 4830.9 00:47:38 INFO - PROCESS | 16178 | -------- Summary: end -------- 00:47:38 INFO - PROCESS | 16178 | 00:47:39 INFO - TEST-INFO | 16178: exit 0 00:47:39 INFO - TEST-OK | v8_7 | took 39841ms 00:47:39 INFO - SUITE-END | took 1210s 00:47:39 INFO - Completed test suite (00:20:10) 00:47:39 INFO - Working with test: dromaeo_css 00:47:39 INFO - Generating results file: dromaeo_css 00:47:39 INFO - Working with test: kraken 00:47:39 INFO - Generating results file: kraken 00:47:39 INFO - javascript benchmark 00:47:39 INFO - Working with test: v8_7 00:47:39 INFO - Generating results file: v8_7 00:47:39 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:47:39 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 00:47:39 INFO - process_Request line: dromaeo_css 6868.60 graph.html#tests=[[72,64,43]] 00:47:39 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:47:39 INFO - process_Request line: kraken 1518.70 graph.html#tests=[[232,64,43]] 00:47:39 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:47:39 INFO - process_Request line: v8_7 21081.88 graph.html#tests=[[230,64,43]] 00:47:39 INFO - RETURN: dromaeo_css: 6868.60 00:47:39 INFO - RETURN: kraken: 1518.70 00:47:39 INFO - RETURN: v8_7: 21081.88 00:47:39 INFO - javascript benchmark 00:47:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3183.3792410479955, 3245.902622921312, 3277.6394596594387, 3298.521714351419, 3298.5711857458527, 5218.8695282617955, 5294.761735721897, 5352.304200453946, 5357.91963120553, 5366.70483123428, 5279.63042587019, 5334.1732031535175, 5406.945930540694, 5437.619366644337, 5452.073147564914, 4578.496365399803, 4821.734804585755, 5004.449510553836, 5013.674111182761, 5021.924671129936, 4810.158222311099, 4920.040592084545, 4921.064997650453, 4989.65072444929, 4999.900001999958, 4817.662763606567, 4879.170541008037, 4899.7550122494085, 4919.11455937931, 4950.950490495121, 4890.175718849848, 4902.975485122587, 4912.852614421573, 4929.112759703252, 4946.851594452172, 4746.240601503778, 4825.879353016203, 4889.926651100236, 4909.607231421478, 4918.877028074291, 5160.225966105077, 5187.818426355059, 5231.058409486291, 5236.7905283788605, 5296.443873393316, 5757.798477053283, 5811.157382179603, 5821.912671309934, 5829.562782791308, 5831.446012628793, 5637.900609381172, 5755.223044888929, 5811.3316968548315, 5846.649201047951, 5847.26909136358, 5444.428335024844, 5493.450654934474, 5497.147942068986, 5501.284832971728, 5506.256655351516, 5952.642841429528, 5973.104034394789, 5988.610740301953, 5989.431004054608, 6008.0, 5575.191597218381, 5678.063119585222, 5739.827805165852, 5753.165790960371, 5890.263717035371, 5803.82588522345, 5810.767569297181, 5814.069748840166, 5817.040188368872, 5819.679917604488, 5732.369439361667, 5782.3639399666, 5788.45009724084, 5791.913121303184, 5803.593748437569, 5662.433756624305, 5752.28096487939, 5757.0788673811985, 5799.9130013049835, 5839.9124013139835, 4453.51011388747, 4464.910701785946, 4484.955150448519, 4487.6185524230805, 4488.932666010012, 3993.0815912340327, 4013.13717550728, 4016.879493615196, 4022.235775202702, 4049.8582549610624, 5390.757415916293, 5397.082495975694, 5409.377921539073, 5409.7295135243085, 5450.645708028966, 5738.971305143447, 5792.362840087587, 5799.8550036249435, 5813.447722466359, 5826.359100498942, 5279.656822306614, 5334.813281535127, 5449.782008719607, 5453.045716999509, 5462.453754624506, 5015.824446144367, 5082.517160869711, 5091.694498330112, 5098.362704661918, 5113.360829896263, 6021.096835474714, 6030.216071910711, 6047.425494578096, 6047.879042419215, 6055.788047418319, 5703.657780533182, 5795.681237531976, 5811.53507719373, 5816.156657284755, 5844.94155058461, 5971.581989260884, 6038.0, 6043.939560604338, 6045.153678485103, 6094.299155597163, 5717.885642287214, 5760.279965004374, 5774.0184168690585, 5781.884362312814, 5783.942160578508, 5648.745806438802, 5744.224529688606, 5841.678707670949, 5876.294844618673, 5877.059670452707, 5676.9716151420635, 5690.943090569207, 5719.399463056319, 5733.799317023884, 5745.569082318926, 5685.0, 5713.22871412354, 5714.3999880012, 5714.79998200061, 5715.485606295287, 5485.945140548703, 5575.888482230252, 5578.414266501959, 5582.218489411567, 5594.440555944536, 5608.07466767995, 5637.069883469346, 5638.971805140948, 5689.175069614966, 5698.0, 5538.446155384429, 5561.972190139023, 5620.606557540933, 5659.26429564154, 5663.207150998781], "unit": "score", "name": "dojo.html", "value": 5345.2727354987255}, {"lowerIsBetter": false, "replicates": [527.817902823526, 529.4123522889593, 540.9296791417115, 547.3677902023163, 560.834553806627, 34386.14034649135, 35631.0, 35749.0, 35822.64177358232, 35975.64024359759, 40642.187156256856, 41479.37780933289, 41483.585164148346, 41554.58445415545, 41662.0, 8444.366672499556, 8586.356023298247, 8654.177853103945, 8658.0, 8672.739817805475, 8375.581220938928, 8499.065102838682, 8504.829903401927, 8507.787305317355, 8515.48907065578, 8595.097514760953, 8720.258778003878, 8746.518941458216, 8785.38502304839, 8791.428557143765, 8657.393982421234, 8694.130586941319, 8709.695160669378, 8716.956415217915, 8736.650533978633, 8540.871886921701, 8556.61495232716, 8591.6992905248, 8611.698590549364, 8662.913370866274, 37134.25731485355, 37580.81209593962, 37788.0, 37850.242995140215, 37863.24273514514, 3173.698498642625, 3205.1506350817053, 3283.540304357392, 3363.6131844837914, 3501.544799176116, 29256.268593285124, 29734.405311893643, 30136.0, 30540.54189187164, 30774.38451230985, 3633.5458067741533, 3671.5777685566236, 3690.6309369063147, 3746.194568167857, 3764.73646844721, 263746.0, 265442.0, 266980.0, 267112.0, 267213.0, 54072.18891716628, 55296.0, 57773.0, 61337.38662613406, 62821.37178628246, 55774.442255577735, 55814.16278755822, 55815.44184558102, 55817.441825582035, 56314.0, 14422.783658245135, 14457.204853732936, 14517.419303227964, 14590.489332873298, 14645.780313295309, 9863.852042219372, 9935.65225217114, 9951.154151897024, 9956.751081223027, 9968.40189588627, 20351.79648203499, 20567.588648226953, 20667.483312916997, 20672.793272067087, 20740.688889666668, 7558.659860306299, 7729.806754831062, 7775.3390961767755, 7795.298423141944, 7885.6594378955715, 911.444019148319, 918.7106061590578, 1015.1675625986768, 1079.2391364088298, 1130.214500921868, 26597.73402265991, 26950.5957410639, 27056.0, 28800.0, 30410.69589304123, 1022.3610243597751, 1034.384541197986, 1049.1292227451197, 1051.6371851711147, 1072.1155047086186, 14030.649233769238, 14287.142571485745, 14362.044451096228, 14476.638084047772, 14546.272686365639, 326497.0, 330148.0, 331265.0, 332581.0, 333590.0, 50913.745431273346, 50973.0, 51076.23385649218, 51083.23375149376, 51210.74394628003, 1352.7294541091821, 1358.9252591107584, 1363.3047145955634, 1365.3651052260548, 1366.4397596985189, 27075.86462067677, 27083.59374609343, 27633.171004869888, 27678.44643107167, 27845.0, 48459.75770121127, 49987.50012499828, 50080.749596251786, 50262.497375025785, 50313.49686503088, 209874.0, 211768.0, 211799.0, 212802.0, 213125.0, 30593.0, 31696.683033169375, 32178.35643287168, 32227.516587250742, 32264.0, 37725.245495090494, 37895.81052094832, 37984.62015379811, 38207.42688859725, 38848.0, 30749.077527674206, 31221.37557248797, 32540.0, 34844.477332840535, 35347.293054139285, 33772.49341259834, 34854.65145348514, 34924.30151397009, 35019.124521887155, 35153.47269791007, 35563.466548001285, 35661.82169089138, 36095.0, 36263.0, 36618.45072323864, 28153.859230703714, 28317.57523637106, 30133.849330753204, 30432.239194020327, 30550.388992220476, 23515.647265290692, 25166.49667006613, 25471.617925731498, 25658.48683026292, 25703.357416064748], "unit": "score", "name": "ext.html", "value": 17830.881583541446}, {"lowerIsBetter": false, "replicates": [350.42705177035543, 350.84562792371355, 352.8782570013346, 353.07318289490087, 354.6240984556372, 16668.416605418814, 17150.914245428772, 17240.56898577533, 17976.370827021055, 18108.0, 11144.721381965455, 12137.757244855098, 16897.915510422463, 16910.06994615296, 16983.405580804676, 4817.445993710716, 5055.620828437864, 5068.569171620398, 5072.9746351268195, 5092.949070509285, 5018.548330650241, 5046.3187469691675, 5055.115354812911, 5057.721825299607, 5068.366454193226, 4940.3330550375595, 5434.510894019538, 5545.1682247662975, 5702.942970570282, 5752.252207213057, 5521.806736764194, 5619.6066275360745, 5648.858778530549, 5662.17898404729, 6041.426064523863, 5339.733013349317, 5380.784768609251, 5404.756785944642, 5405.324334458192, 5408.161734931092, 12432.75134497305, 16109.516714498584, 19650.80349196504, 20456.0, 20766.37700868961, 2045.0183911722456, 2131.8294536437047, 2146.9355919322447, 2155.9784402155933, 2165.231342873273, 9367.859482107773, 9374.250059995184, 9562.18721408681, 9705.126538611488, 9832.950835245778, 1755.10489650278, 1828.3692126216433, 1843.382466873599, 1851.629674065179, 1870.803565625617, 58953.705231474, 61168.694156529375, 61201.0, 61393.46516337083, 61597.38402616006, 9844.753881153028, 10132.392056476636, 10313.84529232062, 10323.638672646572, 10383.598214241132, 13278.800817987545, 13319.533816316383, 13324.800127998087, 13363.665908352368, 13370.39833207508, 7326.157491888394, 7349.853002939912, 7386.815329616803, 7489.176190619028, 7585.393168546503, 6978.0, 6994.825129371807, 7010.369066784014, 7030.2969703029285, 7049.506534542636, 4390.604845563851, 4480.238359478896, 4481.820727170942, 4484.798184081724, 4514.052049069732, 1720.1571230097163, 1787.0707232239163, 1810.4116162247321, 1838.411708253346, 1849.6393203325492, 906.1527471813876, 922.1424075609614, 947.0955237747934, 1021.5760459409262, 1024.8360262358135, 15249.390024399121, 15984.36062557508, 16053.117078560557, 16196.433124840574, 16283.592910177103, 891.5809569502323, 920.089111779347, 927.3740225347864, 952.5618215620754, 1004.4626125023077, 9287.746154269087, 9429.57566909477, 9571.473568953636, 9614.134727874385, 9785.804283914424, 554053.0, 565178.0, 566757.0, 570032.0, 572940.0, 43740.56259437365, 65882.6823463528, 78296.0, 81134.59432702798, 85060.57469712613, 1124.5886412552195, 1142.7600203957095, 1145.4101137913815, 1147.036489348951, 1153.1236260442124, 15228.923855380652, 15370.615734606725, 15485.458008970083, 15596.064236145867, 15941.043537387794, 35547.28905421929, 36133.457998129525, 36256.45615315825, 36424.08939776527, 36568.08579785527, 41580.792096039324, 42484.362734559625, 42597.0, 43364.566354337316, 43882.0, 9275.72172834816, 9801.950990245003, 9810.803783924139, 9824.214062875095, 9844.064813842673, 17342.393016244874, 17404.651906962044, 17498.9125054379, 17670.116494175498, 18173.0, 13905.0, 13925.79111313311, 14032.438702451787, 14276.57170284893, 14581.416743330572, 13574.117682350616, 13870.682285182891, 14286.857131428553, 14288.714225715636, 14406.0, 14235.217063061631, 14288.214148221532, 14378.35297411598, 14440.133591984515, 14897.776533351791, 9086.409383390059, 9266.814663706553, 9483.952580237055, 9606.903930960601, 9640.373375730836, 9361.297902657465, 9603.675138362238, 9743.0, 10608.787824243625, 10849.240553161202], "unit": "score", "name": "jquery.html", "value": 8689.646576139223}, {"lowerIsBetter": false, "replicates": [1407.5355132806178, 1409.3376113226784, 1536.7464368379217, 1719.4239929623575, 1738.113562083338, 7027.5080744347915, 7070.363667269945, 7174.2108368079535, 7214.386777123944, 7237.31245531675, 7096.077509923703, 7127.750528731495, 7133.894246391805, 7170.032045673833, 7174.1032370953635, 2232.754397016327, 2234.530748542808, 2257.345369842744, 2261.592913275618, 2267.954640907181, 2245.2702871566726, 2248.055816557042, 2288.2563166970717, 2289.599320118981, 2289.6794448777187, 2218.223621732389, 2227.7438094619083, 2247.505548779266, 2248.5615305015526, 2292.8165746740306, 2218.3344996500987, 2227.6658501224783, 2258.6386178211487, 2259.20927675314, 2266.512699769541, 2252.3805953362794, 2284.314705588317, 2286.8856557172076, 2288.8741119238434, 2290.0, 7106.680199391039, 7130.322619351154, 7147.285271472863, 7155.463340249502, 7210.783676489714, 4411.404460397837, 4467.374567560544, 4489.0, 4490.932636010462, 4495.2133376659285, 2903.622529071228, 2970.4207679502506, 3001.2046807596003, 3010.458117538842, 3019.0, 858.1675774498726, 864.4957773474173, 877.1316396767155, 883.2492381475759, 911.4258017448965, 9544.0, 9585.904140958572, 9619.2785541084, 9635.807283854283, 9677.90322096784, 3963.286608410456, 3982.721209515364, 3999.0002499375155, 4013.538443079025, 4026.255142798592, 7941.166177551389, 7972.2824945755165, 7974.202579741979, 8017.0379554452675, 8028.558429286329, 4424.513303536608, 4454.888627784331, 4463.642908567307, 4484.865454036384, 4492.348609451611, 4002.69979751514, 4087.7751723655483, 4110.05468742191, 4147.688923330762, 4149.564295748964, 3376.2403459221478, 3422.401079811073, 3422.418188907892, 3424.143964008998, 3458.429359155711, 1033.6847261585137, 1038.1383451735194, 1039.9428031458342, 1041.2034793383068, 1044.9738756531146, 1247.2703468470866, 1251.2367455851922, 1255.9434825432877, 1261.0416083776397, 1265.6962329040964, 6675.132232809704, 6698.531102822755, 6739.0902228198565, 6770.72917083321, 6783.152105986752, 489.2490027807299, 492.7117636182873, 494.8960718249208, 496.95030496950017, 497.6740235145985, 5247.475252474798, 5284.207368894619, 5288.603354748409, 5295.867603309948, 5298.496642819003, 8313.6674533018, 8359.916400835913, 8470.15298470148, 8526.31789456842, 8648.654053837776, 8391.62237699305, 8503.23470887623, 8505.914940850636, 8521.616527256288, 8526.488410695378, 6476.902846457307, 6705.6982435790505, 6802.65986700663, 6855.760048398282, 6888.484533402643, 6685.39831415175, 6789.15135608049, 6827.897581536182, 6835.897461537981, 6852.040714300102, 7574.545527268381, 7679.193684663253, 7768.7669369918995, 7780.649870755717, 7822.765317040498, 7799.298063174341, 7839.05931288249, 7899.210078992055, 8034.959825200836, 8072.354211662935, 6135.662538560422, 6335.1447554579545, 6343.619382837044, 6369.14016607752, 6384.9784034556105, 6824.0, 6841.076454678555, 6841.863162736817, 6866.828329291808, 6896.27589103137, 6324.272708638566, 6386.616802991835, 6413.583117097373, 6512.413882750575, 6612.966935165486, 6392.552521323462, 6397.4562162216735, 6474.773382931575, 6499.6750162492635, 6525.7063432146615, 6334.239891213084, 6467.838304042437, 6484.708188131451, 6485.44873685742, 6486.675666216576, 6005.459508644243, 6010.248718910137, 6017.87964240704, 6037.849053773691, 6091.451769340781, 6060.454559089703, 6072.8785424292155, 6093.817185484442, 6095.0, 6105.961986462401], "unit": "score", "name": "mootools.html", "value": 4130.40151409723}, {"lowerIsBetter": false, "replicates": [327.07927184974295, 331.31913916900777, 336.62298225986893, 337.1722421455327, 341.8957218048496, 6217.440430361266, 6272.3100458949475, 6272.498200143989, 6348.555601107919, 6395.456386207166, 6235.657038862861, 6273.937260627404, 6274.247090349165, 6277.309495955441, 6294.118823364733, 4698.506656801038, 4707.0, 4709.0, 4711.481737008926, 4715.08055929094, 4676.181668208067, 4708.882277943045, 4711.199096153645, 4720.881977950545, 4732.574068333849, 4533.184026875161, 4574.062317224961, 4609.53904609538, 4632.629389648837, 4655.976720116395, 4616.884577885579, 4631.907361852761, 4643.257078867382, 4643.396358473411, 4645.326427667969, 3992.0, 3995.880123596297, 4036.9503928978384, 4042.393640953851, 4054.209429161315, 5922.052471604566, 5929.347771745104, 5930.406959304079, 5959.344472108065, 6012.368701286389, 5321.228421878806, 5466.808661696821, 5470.152126420411, 5502.80740174096, 5518.475744804237, 6600.108985286973, 6613.93386066138, 6620.834479138012, 6627.966860165717, 6630.767923122716, 4474.485434175079, 4514.8194072237075, 4521.59305662492, 4524.6606504511965, 4537.9773101134615, 6794.45644348451, 6919.100516932817, 6991.510594258404, 7000.789976300668, 7002.824929376756, 4632.513586073481, 4653.395058642423, 4666.136764698542, 4667.416572928384, 4669.439667239885, 4672.43930728308, 4696.694714843593, 4701.78841952113, 4719.2921061841, 4726.574608285202, 5478.835634930959, 5490.258815059996, 5492.176173573996, 5493.670379777146, 5512.200730893998, 6453.354664533603, 6648.634325112069, 6669.1330127083165, 6673.299303573152, 6710.0, 1589.745640697483, 1598.5044636162827, 1599.7120518306817, 1603.3987254779458, 1603.4708546179734, 1068.8931106889404, 1083.9566417343217, 1085.3108276244484, 1090.138790355626, 1103.1560855945208, 6355.332690067568, 6386.2975072741965, 6402.943514320178, 6421.133147025185, 6421.486281097501, 6909.412699920463, 6926.272741362084, 6926.896096558556, 6929.826754331081, 6934.7226110955, 6290.433860952537, 6408.070829729663, 6411.358864113551, 6470.158879345655, 6493.155889734304, 3769.3780526212868, 3790.6019867914024, 3792.563855156692, 3804.980975095162, 3813.370793819044, 7281.4538909582, 7300.890486642598, 7324.780256592311, 7357.301056399633, 7359.37445317154, 7015.158181018209, 7166.140063192451, 7168.17565979919, 7202.783916482514, 7204.56772593646, 7237.095363079615, 7265.745698900513, 7288.08898887639, 7298.817529561803, 7326.194118646945, 6939.583624982517, 6968.756093536702, 6969.745445819801, 6977.511574189961, 6987.545809522365, 6646.202455705346, 6840.315968403319, 6858.794236172923, 6882.965585172042, 6896.344847239504, 7238.0, 7240.52936559122, 7260.0, 7303.488755787044, 7342.265773422829, 4475.865724028285, 4482.529334419969, 4500.257457519473, 4525.570070843265, 4533.365328853897, 6809.89785153233, 6916.273791251846, 6925.965370173117, 6973.163220413583, 6975.686094125675, 6769.1876974763345, 6776.966115169393, 6780.321967803377, 6782.152230971129, 6783.0, 6570.178727659043, 6690.330966903271, 6717.529772915849, 6728.05807187004, 6760.763373282109, 6645.235797883305, 6649.135612370555, 6650.035744817072, 6650.501212408992, 6677.599344039373, 6792.694328755119, 6801.081853949653, 6818.8636227276165, 6827.931720682928, 6848.6918088687125, 6532.477401807939, 6639.4688424924925, 6655.467562594884, 6668.599884006975, 6680.465562755066], "unit": "score", "name": "prototype.html", "value": 4997.489727452496}, {"lowerIsBetter": false, "replicates": [709.2234003765875, 737.9704811807528, 780.7969927818765, 788.7949133225361, 829.9998501805321, 13016.349182540871, 13286.33568321585, 13305.06864519484, 13308.733825323488, 13316.866831331683, 12504.249745015282, 12529.874701252984, 12633.242005479678, 12646.873531264684, 12991.675208119801, 796.6176235407008, 809.9996504317163, 811.0551207842856, 811.0875265326507, 813.2355585749406, 807.0799288810761, 821.8479581277453, 823.0781524692353, 823.9299659528947, 826.3554427546524, 837.9120192379804, 846.4455781463151, 851.4380508864151, 855.4439614250756, 857.237059017475, 844.2950136635916, 849.6516428264413, 849.8300339932007, 850.0309647002422, 850.3579797253096, 624.753222477119, 625.8967270400424, 626.5394934722975, 628.0140179917531, 629.8110566829932, 12627.684307892285, 12674.683132921658, 12719.0, 12727.0, 12747.0, 11652.417379131095, 11936.70158246042, 12085.879141208563, 12296.815547766791, 12529.874701253053, 9872.851907221397, 9884.209263258994, 9953.452560109263, 9994.350367226107, 10127.645532406405, 3608.4767708682357, 3615.4215325547784, 3619.2942376236642, 3656.3784156693428, 3738.5887552369218, 48645.75677121627, 48696.51303486991, 49115.75442122802, 49418.75290623524, 49513.0, 9316.161545460942, 9333.3933294337, 9497.5726092326, 9657.22742180624, 9675.03249675027, 17619.119044047748, 17627.0, 17636.911815441097, 17643.117844107743, 17684.29262829498, 7809.101953275446, 7833.451658383859, 7956.880646790303, 7969.442139050211, 8060.166596751953, 3981.9402708959387, 4088.325426304686, 4127.711060225755, 4202.810873510699, 4211.452511173589, 3043.1174959261566, 3049.161480592855, 3071.324308652093, 3078.0919628709585, 3084.0901933929545, 539.1212323911998, 555.8110242517563, 565.4910580477604, 567.8381661226531, 568.556525909791, 490.5021403275678, 506.35692670308504, 511.98464046078675, 518.6602775182187, 539.9929132168478, 6706.765263215764, 8156.306713929263, 8202.794930126674, 8318.417710760188, 8450.323974082181, 518.7535920437838, 519.9740012999334, 581.8021872563348, 623.5416968528128, 630.7290809019829, 3801.0994502748626, 3929.390944403622, 3989.960100399017, 4075.4701888754867, 4086.468759061303, 58600.706996464745, 58821.0, 58834.0, 58908.1163782535, 59257.40742592519, 49212.0, 49352.50647493551, 50244.74877625588, 50297.74851125721, 50346.49653503418, 47169.05661886743, 47772.76113619479, 47875.28187077196, 48125.75937120292, 48700.5129948703, 8014.479058861155, 8089.635966381409, 8151.63317650719, 8258.42191046621, 8336.708215212439, 36639.63360366469, 37451.0, 37454.81272593619, 37559.43660845144, 38162.80918595389, 42756.0, 42940.570594293655, 46579.0, 47239.0, 47463.0, 9883.901160988586, 10199.898001019896, 10818.0, 10860.728481788019, 10997.450127493754, 11194.880511949066, 11280.830787538029, 11294.94352528265, 11731.296122232694, 12112.878871211175, 10569.682909512727, 10636.627718029831, 11041.889581104086, 11068.889311106786, 11396.886031139582, 11227.15796315296, 11427.542898283975, 11443.313401195956, 11809.05527557776, 12209.877901221229, 10992.725181870517, 11031.282966607145, 11242.60650877248, 11364.659060228207, 11606.724198134318, 8672.0, 8739.169778870997, 8766.430182038148, 9004.59479323419, 9107.408018478778, 7994.760157195294, 8049.678012879419, 8546.145385461652, 8674.609642566225, 8843.955780221315], "unit": "score", "name": "yui.html", "value": 6141.576935499624}], "name": "dromaeo_css", "value": 6868.596003300885}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 106.0, 111.0, 110.0, 112.0, 123.0, 110.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [148.0, 127.0, 152.0, 160.0, 123.0, 149.0, 160.0, 130.0, 170.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 144.2}, {"lowerIsBetter": true, "replicates": [162.0, 164.0, 161.0, 164.0, 163.0, 163.0, 161.0, 168.0, 167.0, 161.0], "unit": "score", "name": "audio-dft", "value": 163.4}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 71.0, 71.0, 71.0, 71.0, 140.0, 75.0, 71.0, 74.0], "unit": "score", "name": "audio-fft", "value": 79.1}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 146.0, 96.0, 96.0, 95.0, 147.0, 97.0, 96.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 110.1}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 145.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 108.0, 96.0, 96.0, 96.0, 96.0, 97.0, 100.0], "unit": "score", "name": "imaging-desaturate", "value": 97.7}, {"lowerIsBetter": true, "replicates": [62.0, 59.0, 58.0, 60.0, 59.0, 61.0, 58.0, 58.0, 62.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 59.5}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 69.0, 68.0, 69.0, 69.0, 67.0, 68.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 85.0, 94.0, 88.0, 94.0, 86.0, 88.0, 87.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.1}, {"lowerIsBetter": true, "replicates": [129.0, 129.0, 120.0, 118.0, 118.0, 123.0, 117.0, 119.0, 131.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.6}, {"lowerIsBetter": true, "replicates": [145.0, 151.0, 151.0, 147.0, 150.0, 152.0, 156.0, 150.0, 151.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.1}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 70.0, 70.0, 69.0, 72.0, 67.0, 68.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1518.6999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.1402306535183], "unit": "score", "name": "Richards", "value": 211.21186599999996}, {"lowerIsBetter": false, "replicates": [189.14318138831095], "unit": "score", "name": "DeltaBlue", "value": 349.565866}, {"lowerIsBetter": false, "replicates": [281.37310073157005], "unit": "score", "name": "Encrypt", "value": 946.0072739999998}, {"lowerIsBetter": false, "replicates": [5218.75], "unit": "score", "name": "Decrypt", "value": 51.00474251497002}, {"lowerIsBetter": false, "replicates": [1059.322033898305], "unit": "score", "name": "RayTrace", "value": 698.549616}, {"lowerIsBetter": false, "replicates": [710.2272727272727], "unit": "score", "name": "Earley", "value": 938.3799039999997}, {"lowerIsBetter": false, "replicates": [12358.024691358025], "unit": "score", "name": "Boyer", "value": 53.929573426573455}, {"lowerIsBetter": false, "replicates": [25225.0], "unit": "score", "name": "RegExp", "value": 36.11437066402381}, {"lowerIsBetter": false, "replicates": [683.6803223640027], "unit": "score", "name": "Splay", "value": 119.1945962671905}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21081.876613852583}]} 00:47:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21081.88"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1518.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6868.60"}}} 00:47:40 INFO - Return code: 0 00:47:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 00:47:40 INFO - # TBPL SUCCESS # 00:47:40 INFO - Running post-action listener: _resource_record_post_action 00:47:40 INFO - Running post-run listener: _resource_record_post_run 00:47:41 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 553308160; Read time: 8; Write time: 548240 00:47:41 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 235347968; Read time: 0; Write time: 274428 00:47:41 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 317960192; Read time: 8; Write time: 273812 00:47:41 INFO - Running post-run listener: _upload_blobber_files 00:47:41 INFO - Blob upload gear active. 00:47:41 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 00:47:41 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 00:47:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 00:47:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 00:47:41 INFO - (blobuploader) - INFO - Open directory for files ... 00:47:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:47:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:47:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:47:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:47:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:47:43 INFO - (blobuploader) - INFO - Done attempting. 00:47:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:47:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:47:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:47:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:47:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:47:43 INFO - (blobuploader) - INFO - Done attempting. 00:47:43 INFO - (blobuploader) - INFO - Iteration through files over. 00:47:43 INFO - Return code: 0 00:47:43 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 00:47:43 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 00:47:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c8926035b893c4487aab878858234b9a73c0b41ac950b67a52ba954da7b35070267eee781e4fc3bc37730e59662d8fa47a87710afe5451ca79e715cefecaf93", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ae5131710cc990c91153e0f6c07211ebadd19f717c9dabe1ad133c406045b565214a44185f5988c64d4dbac484e5dbf983de644f91575a398b0267ab518c14ac"} 00:47:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 00:47:43 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 00:47:43 INFO - Contents: 00:47:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c8926035b893c4487aab878858234b9a73c0b41ac950b67a52ba954da7b35070267eee781e4fc3bc37730e59662d8fa47a87710afe5451ca79e715cefecaf93", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ae5131710cc990c91153e0f6c07211ebadd19f717c9dabe1ad133c406045b565214a44185f5988c64d4dbac484e5dbf983de644f91575a398b0267ab518c14ac"} 00:47:43 INFO - Copying logs to upload dir... 00:47:43 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1277.639494 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-30 00:47:43.506612) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 00:47:43.510547) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/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-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=447a3abc0420b6a47dd38cba000001bf-1451457774.699220-419188759 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/3c8926035b893c4487aab878858234b9a73c0b41ac950b67a52ba954da7b35070267eee781e4fc3bc37730e59662d8fa47a87710afe5451ca79e715cefecaf93", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ae5131710cc990c91153e0f6c07211ebadd19f717c9dabe1ad133c406045b565214a44185f5988c64d4dbac484e5dbf983de644f91575a398b0267ab518c14ac"} build_url:https://queue.taskcluster.net/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011492 build_url: 'https://queue.taskcluster.net/v1/task/DbUwuiBSSlCwV7tPSMUIpQ/artifacts/public/build/firefox-46.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/3c8926035b893c4487aab878858234b9a73c0b41ac950b67a52ba954da7b35070267eee781e4fc3bc37730e59662d8fa47a87710afe5451ca79e715cefecaf93", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ae5131710cc990c91153e0f6c07211ebadd19f717c9dabe1ad133c406045b565214a44185f5988c64d4dbac484e5dbf983de644f91575a398b0267ab518c14ac"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 00:47:43.535352) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 00:47:43.535694) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=447a3abc0420b6a47dd38cba000001bf-1451457774.699220-419188759 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 00:47:43.619871) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 00:47:43.620194) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 00:47:43.620495) ========= ========= Total master_lag: 0.26 =========