builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-006 starttime: 1452149244.72 results: success (0) buildid: 20160106203234 builduid: d86723d7a95f44afb1e1a5bf8de109ec revision: c91d6036456490a3bb20eb63e0dd02a5dd063561 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-06 22:47:24.722538) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-06 22:47:24.723003) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-06 22:47:24.723289) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1452148946.101408-1060205550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006224 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-06 22:47:24.794913) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-06 22:47:24.795188) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-06 22:47:24.837659) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 22:47:24.837958) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1452148946.101408-1060205550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004571 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 22:47:24.891806) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-06 22:47:24.892092) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-06 22:47:24.892520) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 22:47:24.892867) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1452148946.101408-1060205550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-06 22:47: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.7M=0s 2016-01-06 22:47:25 (43.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157249 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 22:47:25.073649) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 22:47:25.073983) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1452148946.101408-1060205550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015583 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 22:47:25.124870) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-06 22:47:25.125286) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c91d6036456490a3bb20eb63e0dd02a5dd063561 --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 c91d6036456490a3bb20eb63e0dd02a5dd063561 --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=e31afd3c0f0de4e86ebe4d94000001b5-1452148946.101408-1060205550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-06 22:47:25,739 truncating revision to first 12 chars 2016-01-06 22:47:25,739 Setting DEBUG logging. 2016-01-06 22:47:25,739 attempt 1/10 2016-01-06 22:47:25,739 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c91d60364564?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-06 22:47:26,688 unpacking tar archive at: fx-team-c91d60364564/testing/mozharness/ program finished with exit code 0 elapsedTime=1.531759 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-06 22:47:26.671235) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-06 22:47:26.671574) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-06 22:47:26.680935) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-06 22:47:26.681223) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-06 22:47:26.681629) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-06 22:47:26.681976) ========= /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=e31afd3c0f0de4e86ebe4d94000001b5-1452148946.101408-1060205550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:47:27 INFO - MultiFileLogger online at 20160106 22:47:27 in /builds/slave/test-pgo 22:47:27 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 22:47:27 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:47:27 INFO - {'append_to_log': False, 22:47:27 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:47:27 INFO - 'blob_upload_branch': 'Fx-Team', 22:47:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:47:27 INFO - 'branch': 'Fx-Team', 22:47:27 INFO - 'buildbot_json_path': 'buildprops.json', 22:47:27 INFO - 'config_files': ('talos/linux_config.py',), 22:47:27 INFO - 'default_actions': ('clobber', 22:47:27 INFO - 'read-buildbot-config', 22:47:27 INFO - 'download-and-extract', 22:47:27 INFO - 'populate-webroot', 22:47:27 INFO - 'create-virtualenv', 22:47:27 INFO - 'install', 22:47:27 INFO - 'run-tests'), 22:47:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:47:27 INFO - 'download_minidump_stackwalk': True, 22:47:27 INFO - 'download_symbols': 'ondemand', 22:47:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:47:27 INFO - 'tooltool.py': '/tools/tooltool.py', 22:47:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:47:27 INFO - '/tools/misc-python/virtualenv.py')}, 22:47:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:47:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:47:27 INFO - 'installer_path': 'installer.exe', 22:47:27 INFO - 'log_level': 'info', 22:47:27 INFO - 'log_name': 'talos', 22:47:27 INFO - 'log_to_console': True, 22:47:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:47:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:47:27 INFO - 'opt_config_files': (), 22:47:27 INFO - 'pip_index': False, 22:47:27 INFO - 'sps_profile': False, 22:47:27 INFO - 'sps_profile_interval': 0, 22:47:27 INFO - 'suite': 'dromaeojs-e10s', 22:47:27 INFO - 'system_bits': '32', 22:47:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:47:27 INFO - 'title': 'talos-linux64-ix-006', 22:47:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:47:27 INFO - 'use_talos_json': True, 22:47:27 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:47:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:47:27 INFO - 'work_dir': 'build'} 22:47:27 INFO - ##### 22:47:27 INFO - ##### Running clobber step. 22:47:27 INFO - ##### 22:47:27 INFO - Running pre-action listener: _resource_record_pre_action 22:47:27 INFO - Running main action method: clobber 22:47:27 INFO - rmtree: /builds/slave/test-pgo/build 22:47:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:47:27 INFO - Running post-action listener: _resource_record_post_action 22:47:27 INFO - ##### 22:47:27 INFO - ##### Running read-buildbot-config step. 22:47:27 INFO - ##### 22:47:27 INFO - Running pre-action listener: _resource_record_pre_action 22:47:27 INFO - Running main action method: read_buildbot_config 22:47:27 INFO - Using buildbot properties: 22:47:27 INFO - { 22:47:27 INFO - "project": "", 22:47:27 INFO - "product": "firefox", 22:47:27 INFO - "script_repo_revision": "production", 22:47:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:47:27 INFO - "repository": "", 22:47:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 22:47:27 INFO - "buildid": "20160106203234", 22:47:27 INFO - "pgo_build": "True", 22:47:27 INFO - "basedir": "/builds/slave/test-pgo", 22:47:27 INFO - "buildnumber": 428, 22:47:27 INFO - "slavename": "talos-linux64-ix-006", 22:47:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:47:27 INFO - "platform": "ubuntu64_hw", 22:47:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 22:47:27 INFO - "branch": "fx-team", 22:47:27 INFO - "repo_path": "integration/fx-team", 22:47:27 INFO - "revision": "c91d6036456490a3bb20eb63e0dd02a5dd063561", 22:47:27 INFO - "stage_platform": "linux64-pgo", 22:47:27 INFO - "builduid": "d86723d7a95f44afb1e1a5bf8de109ec", 22:47:27 INFO - "slavebuilddir": "test" 22:47:27 INFO - } 22:47:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 22:47:27 INFO - Running post-action listener: _resource_record_post_action 22:47:27 INFO - ##### 22:47:27 INFO - ##### Running download-and-extract step. 22:47:27 INFO - ##### 22:47:27 INFO - Running pre-action listener: _resource_record_pre_action 22:47:27 INFO - Running main action method: download_and_extract 22:47:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:47: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')]} 22:47:27 INFO - https://queue.taskcluster.net/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:47:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/test_packages.json 22:47:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/test_packages.json 22:47:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:47:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:47:35 INFO - Downloaded 1302 bytes. 22:47:35 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:47:35 INFO - Using the following test package requirements: 22:47:35 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:47:35 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:47:35 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:35 INFO - u'jsshell-linux-x86_64.zip'], 22:47:35 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:47:35 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:47:35 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:47:35 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:47:35 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:47:35 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:47:35 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:47:35 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:47:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:35 INFO - https://queue.taskcluster.net/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:47:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:47:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:47:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/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 22:47:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/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 22:47:40 INFO - Downloaded 24101983 bytes. 22:47:40 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 22:47:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:47:40 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 22:47:41 INFO - Return code: 0 22:47:41 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 22:47:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:41 INFO - https://queue.taskcluster.net/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:47:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:47:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:47:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/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 22:47:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/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 22:47:42 INFO - Downloaded 24101983 bytes. 22:47: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 22:47:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:47: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 22:47:43 INFO - Return code: 0 22:47: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')]} 22:47:43 INFO - https://queue.taskcluster.net/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:47:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:47:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:47:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/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 22:47:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/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 22:47:44 INFO - Downloaded 11132285 bytes. 22:47:44 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 22:47:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:47:44 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 22:47:44 INFO - Return code: 0 22:47:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:44 INFO - https://queue.taskcluster.net/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:47:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:47:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:47:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/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 22:47:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e_8pEUlMR2uvzRnhI2DTOA/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 22:47:47 INFO - Downloaded 55066784 bytes. 22:47:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:47:47 INFO - mkdir: /builds/slave/test-pgo/properties 22:47:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:47:47 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:47:47 INFO - Contents: 22:47:47 INFO - build_url:https://queue.taskcluster.net/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:47:47 INFO - Running post-action listener: _resource_record_post_action 22:47:47 INFO - Running post-action listener: set_extra_try_arguments 22:47:47 INFO - ##### 22:47:47 INFO - ##### Running populate-webroot step. 22:47:47 INFO - ##### 22:47:47 INFO - Running pre-action listener: _resource_record_pre_action 22:47:47 INFO - Running main action method: populate_webroot 22:47:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:47:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:47:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:47:47 INFO - '--tppagecycles', 22:47:47 INFO - '7'], 22:47:47 INFO - 'tests': ['tsvgm']}}, 22:47:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:47:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:47:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:47:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:47:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:47:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:47:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:47:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:47 INFO - 'talos_options': ['--e10s'], 22:47:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:47:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:47 INFO - 'tests': ['damp', 'tps']}, 22:47:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:47 INFO - 'talos_options': ['--e10s'], 22:47:47 INFO - 'tests': ['damp', 'tps']}, 22:47:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:47:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:47:47 INFO - 'other': {'tests': ['a11yr', 22:47:47 INFO - 'ts_paint', 22:47:47 INFO - 'tpaint', 22:47:47 INFO - 'sessionrestore', 22:47:47 INFO - 'sessionrestore_no_auto_restore']}, 22:47:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:47:47 INFO - 'tests': ['a11yr', 22:47:47 INFO - 'ts_paint', 22:47:47 INFO - 'tpaint', 22:47:47 INFO - 'sessionrestore', 22:47:47 INFO - 'sessionrestore_no_auto_restore']}, 22:47:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:47:47 INFO - 'tests': ['a11yr', 22:47:47 INFO - 'ts_paint', 22:47:47 INFO - 'tpaint', 22:47:47 INFO - 'sessionrestore', 22:47:47 INFO - 'sessionrestore_no_auto_restore']}, 22:47:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:47:47 INFO - 'tests': ['a11yr', 22:47:47 INFO - 'ts_paint', 22:47:47 INFO - 'tpaint', 22:47:47 INFO - 'sessionrestore', 22:47:47 INFO - 'sessionrestore_no_auto_restore']}, 22:47:47 INFO - 'other_l64': {'tests': ['a11yr', 22:47:47 INFO - 'ts_paint', 22:47:47 INFO - 'tpaint', 22:47:47 INFO - 'sessionrestore', 22:47:47 INFO - 'sessionrestore_no_auto_restore']}, 22:47:47 INFO - 'other_nol64': {'tests': ['a11yr', 22:47:47 INFO - 'ts_paint', 22:47:47 INFO - 'tpaint', 22:47:47 INFO - 'sessionrestore', 22:47:47 INFO - 'sessionrestore_no_auto_restore']}, 22:47:47 INFO - 'svgr': {'tests': ['tsvgx', 22:47:47 INFO - 'tsvgr_opacity', 22:47:47 INFO - 'tart', 22:47:47 INFO - 'tscrollx', 22:47:47 INFO - 'cart']}, 22:47:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:47:47 INFO - 'tests': ['tsvgx', 22:47:47 INFO - 'tsvgr_opacity', 22:47:47 INFO - 'tart', 22:47:47 INFO - 'tscrollx', 22:47:47 INFO - 'cart']}, 22:47:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:47 INFO - 'tests': ['tp5o']}, 22:47:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:47 INFO - 'talos_options': ['--e10s'], 22:47:47 INFO - 'tests': ['tp5o']}, 22:47:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:47 INFO - 'talos_options': ['--xperf_path', 22:47:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:47:47 INFO - 'tests': ['tp5n']}, 22:47:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:47 INFO - 'talos_options': ['--e10s', 22:47:47 INFO - '--xperf_path', 22:47:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:47:47 INFO - 'tests': ['tp5n']}}, 22:47:47 INFO - 'talos.zip': {'path': '', 22:47:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:47:47 INFO - Running post-action listener: _resource_record_post_action 22:47:47 INFO - ##### 22:47:47 INFO - ##### Running create-virtualenv step. 22:47:47 INFO - ##### 22:47:47 INFO - Running pre-action listener: _resource_record_pre_action 22:47:47 INFO - Running main action method: create_virtualenv 22:47:47 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:47:47 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 22:47:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:47:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:47:47 INFO - Using real prefix '/usr' 22:47:47 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:47:47 INFO - Installing distribute.............................................................................................................................................................................................done. 22:47:49 INFO - Installing pip.................done. 22:47:49 INFO - Return code: 0 22:47:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:47:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:47:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:49 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 0x7f589e83ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a89630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1a840>, '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 0x2a876b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a87b60>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1452148946.101408-1060205550', '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 22:47:49 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 22:47:49 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 22:47:49 INFO - Using env: {'DISPLAY': ':0', 22:47:49 INFO - 'HOME': '/home/cltbld', 22:47:49 INFO - 'LANG': 'en_US.UTF-8', 22:47:49 INFO - 'LANGUAGE': 'en_US:en', 22:47:49 INFO - 'LOGNAME': 'cltbld', 22:47:49 INFO - 'MAIL': '/var/mail/cltbld', 22:47:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:49 INFO - 'MOZ_NO_REMOTE': '1', 22:47:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:49 INFO - 'NO_EM_RESTART': '1', 22:47:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:47:49 INFO - 'PWD': '/builds/slave/test-pgo', 22:47:49 INFO - 'SHELL': '/bin/bash', 22:47:49 INFO - 'SHLVL': '1', 22:47:49 INFO - 'TERM': 'linux', 22:47:49 INFO - 'TMOUT': '86400', 22:47:49 INFO - 'USER': 'cltbld', 22:47:49 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452148946.101408-1060205550', 22:47:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:49 INFO - '_': '/tools/buildbot/bin/python'} 22:47:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:49 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 22:47:49 INFO - Cleaning up... 22:47:49 INFO - Return code: 0 22:47:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:47:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:47:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:49 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 0x7f589e83ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a89630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1a840>, '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 0x2a876b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a87b60>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1452148946.101408-1060205550', '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 22:47:49 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 22:47:49 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 22:47:49 INFO - Using env: {'DISPLAY': ':0', 22:47:49 INFO - 'HOME': '/home/cltbld', 22:47:49 INFO - 'LANG': 'en_US.UTF-8', 22:47:49 INFO - 'LANGUAGE': 'en_US:en', 22:47:49 INFO - 'LOGNAME': 'cltbld', 22:47:49 INFO - 'MAIL': '/var/mail/cltbld', 22:47:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:49 INFO - 'MOZ_NO_REMOTE': '1', 22:47:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:49 INFO - 'NO_EM_RESTART': '1', 22:47:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:47:49 INFO - 'PWD': '/builds/slave/test-pgo', 22:47:49 INFO - 'SHELL': '/bin/bash', 22:47:49 INFO - 'SHLVL': '1', 22:47:49 INFO - 'TERM': 'linux', 22:47:49 INFO - 'TMOUT': '86400', 22:47:49 INFO - 'USER': 'cltbld', 22:47:49 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452148946.101408-1060205550', 22:47:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:49 INFO - '_': '/tools/buildbot/bin/python'} 22:47:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:50 INFO - Downloading/unpacking psutil>=0.7.1 22:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:51 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 22:47:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:47:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:47:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:47:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:47:51 INFO - Installing collected packages: psutil 22:47:51 INFO - Running setup.py install for psutil 22:47:51 INFO - building 'psutil._psutil_linux' extension 22:47:51 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 22:47:52 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 22:47:52 INFO - building 'psutil._psutil_posix' extension 22:47:52 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 22:47:52 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 22:47:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:47:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:47:52 INFO - Successfully installed psutil 22:47:52 INFO - Cleaning up... 22:47:52 INFO - Return code: 0 22:47:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:47:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:52 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 0x7f589e83ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a89630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1a840>, '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 0x2a876b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a87b60>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1452148946.101408-1060205550', '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 22:47:52 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 22:47:52 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 22:47:52 INFO - Using env: {'DISPLAY': ':0', 22:47:52 INFO - 'HOME': '/home/cltbld', 22:47:52 INFO - 'LANG': 'en_US.UTF-8', 22:47:52 INFO - 'LANGUAGE': 'en_US:en', 22:47:52 INFO - 'LOGNAME': 'cltbld', 22:47:52 INFO - 'MAIL': '/var/mail/cltbld', 22:47:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:52 INFO - 'MOZ_NO_REMOTE': '1', 22:47:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:52 INFO - 'NO_EM_RESTART': '1', 22:47:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:47:52 INFO - 'PWD': '/builds/slave/test-pgo', 22:47:52 INFO - 'SHELL': '/bin/bash', 22:47:52 INFO - 'SHLVL': '1', 22:47:52 INFO - 'TERM': 'linux', 22:47:52 INFO - 'TMOUT': '86400', 22:47:52 INFO - 'USER': 'cltbld', 22:47:52 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452148946.101408-1060205550', 22:47:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:52 INFO - '_': '/tools/buildbot/bin/python'} 22:47:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:47:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:47:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:47:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:47:54 INFO - Installing collected packages: mozsystemmonitor 22:47:54 INFO - Running setup.py install for mozsystemmonitor 22:47:54 INFO - Successfully installed mozsystemmonitor 22:47:54 INFO - Cleaning up... 22:47:54 INFO - Return code: 0 22:47:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 22:47:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:54 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 0x7f589e83ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a89630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1a840>, '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 0x2a876b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a87b60>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1452148946.101408-1060205550', '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 22:47:54 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 22:47:54 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 22:47:54 INFO - Using env: {'DISPLAY': ':0', 22:47:54 INFO - 'HOME': '/home/cltbld', 22:47:54 INFO - 'LANG': 'en_US.UTF-8', 22:47:54 INFO - 'LANGUAGE': 'en_US:en', 22:47:54 INFO - 'LOGNAME': 'cltbld', 22:47:54 INFO - 'MAIL': '/var/mail/cltbld', 22:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:54 INFO - 'MOZ_NO_REMOTE': '1', 22:47:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:54 INFO - 'NO_EM_RESTART': '1', 22:47:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:47:54 INFO - 'PWD': '/builds/slave/test-pgo', 22:47:54 INFO - 'SHELL': '/bin/bash', 22:47:54 INFO - 'SHLVL': '1', 22:47:54 INFO - 'TERM': 'linux', 22:47:54 INFO - 'TMOUT': '86400', 22:47:54 INFO - 'USER': 'cltbld', 22:47:54 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452148946.101408-1060205550', 22:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:54 INFO - '_': '/tools/buildbot/bin/python'} 22:47:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:54 INFO - Downloading/unpacking blobuploader==1.2.4 22:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:56 INFO - Downloading blobuploader-1.2.4.tar.gz 22:47:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:47:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:47:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:47:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:47:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:57 INFO - Downloading docopt-0.6.1.tar.gz 22:47:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:47:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:47:57 INFO - Installing collected packages: blobuploader, requests, docopt 22:47:57 INFO - Running setup.py install for blobuploader 22:47:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:47:57 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:47:57 INFO - Running setup.py install for requests 22:47:57 INFO - Running setup.py install for docopt 22:47:57 INFO - Successfully installed blobuploader requests docopt 22:47:57 INFO - Cleaning up... 22:47:57 INFO - Return code: 0 22:47:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:47:57 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')]} 22:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:57 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')]} 22:47:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:57 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 0x7f589e83ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a89630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1a840>, '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 0x2a876b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a87b60>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1452148946.101408-1060205550', '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 22:47:57 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 22:47:57 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 22:47:57 INFO - Using env: {'DISPLAY': ':0', 22:47:57 INFO - 'HOME': '/home/cltbld', 22:47:57 INFO - 'LANG': 'en_US.UTF-8', 22:47:57 INFO - 'LANGUAGE': 'en_US:en', 22:47:57 INFO - 'LOGNAME': 'cltbld', 22:47:57 INFO - 'MAIL': '/var/mail/cltbld', 22:47:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:57 INFO - 'MOZ_NO_REMOTE': '1', 22:47:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:57 INFO - 'NO_EM_RESTART': '1', 22:47:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:47:57 INFO - 'PWD': '/builds/slave/test-pgo', 22:47:57 INFO - 'SHELL': '/bin/bash', 22:47:57 INFO - 'SHLVL': '1', 22:47:57 INFO - 'TERM': 'linux', 22:47:57 INFO - 'TMOUT': '86400', 22:47:57 INFO - 'USER': 'cltbld', 22:47:57 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452148946.101408-1060205550', 22:47:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:57 INFO - '_': '/tools/buildbot/bin/python'} 22:47:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:47:57 INFO - Running setup.py (path:/tmp/pip-VC4C5L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:47:58 INFO - Running setup.py (path:/tmp/pip-IHQCyg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:47:58 INFO - Running setup.py (path:/tmp/pip-8gSY89-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:47:58 INFO - Running setup.py (path:/tmp/pip-X1E0Lo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:47:58 INFO - Running setup.py (path:/tmp/pip-SCloC5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:47:58 INFO - Running setup.py (path:/tmp/pip-_dqQ5I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:47:58 INFO - Running setup.py (path:/tmp/pip-IxVOVw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:47:58 INFO - Running setup.py (path:/tmp/pip-irRoGl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:47:58 INFO - Running setup.py (path:/tmp/pip-QDvfrM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:47:58 INFO - Running setup.py (path:/tmp/pip-Fzl7pr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:47:58 INFO - Running setup.py (path:/tmp/pip-9hPtxU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:47:58 INFO - Running setup.py (path:/tmp/pip-LqZf7q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:47:58 INFO - Running setup.py (path:/tmp/pip-HIocnB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:47:58 INFO - Running setup.py (path:/tmp/pip-LErIeh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:47:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:47:58 INFO - Running setup.py (path:/tmp/pip-dyB32v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:47:59 INFO - Running setup.py (path:/tmp/pip-azcYXu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:47:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:47:59 INFO - Running setup.py (path:/tmp/pip-7YpDAC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:47:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:47:59 INFO - Running setup.py install for manifestparser 22:47:59 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:47:59 INFO - Running setup.py install for mozcrash 22:47:59 INFO - Running setup.py install for mozdebug 22:47:59 INFO - Running setup.py install for mozdevice 22:47:59 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:47:59 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:47:59 INFO - Running setup.py install for mozfile 22:47:59 INFO - Running setup.py install for mozhttpd 22:47:59 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:47:59 INFO - Running setup.py install for mozinfo 22:47:59 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:47:59 INFO - Running setup.py install for mozInstall 22:48:00 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:48:00 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:48:00 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:48:00 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:48:00 INFO - Running setup.py install for mozleak 22:48:00 INFO - Running setup.py install for mozlog 22:48:00 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:48:00 INFO - Running setup.py install for moznetwork 22:48:00 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:48:00 INFO - Running setup.py install for mozprocess 22:48:00 INFO - Running setup.py install for mozprofile 22:48:00 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:48:00 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:48:00 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:48:00 INFO - Running setup.py install for mozrunner 22:48:00 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:48:00 INFO - Running setup.py install for mozscreenshot 22:48:00 INFO - Running setup.py install for moztest 22:48:00 INFO - Running setup.py install for mozversion 22:48:00 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:48:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:48:00 INFO - Cleaning up... 22:48:01 INFO - Return code: 0 22:48:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:48:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:48:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:48:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:01 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 0x7f589e83ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a89630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1a840>, '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 0x2a876b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a87b60>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1452148946.101408-1060205550', '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 22:48:01 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 22:48:01 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 22:48:01 INFO - Using env: {'DISPLAY': ':0', 22:48:01 INFO - 'HOME': '/home/cltbld', 22:48:01 INFO - 'LANG': 'en_US.UTF-8', 22:48:01 INFO - 'LANGUAGE': 'en_US:en', 22:48:01 INFO - 'LOGNAME': 'cltbld', 22:48:01 INFO - 'MAIL': '/var/mail/cltbld', 22:48:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:01 INFO - 'MOZ_NO_REMOTE': '1', 22:48:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:01 INFO - 'NO_EM_RESTART': '1', 22:48:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:48:01 INFO - 'PWD': '/builds/slave/test-pgo', 22:48:01 INFO - 'SHELL': '/bin/bash', 22:48:01 INFO - 'SHLVL': '1', 22:48:01 INFO - 'TERM': 'linux', 22:48:01 INFO - 'TMOUT': '86400', 22:48:01 INFO - 'USER': 'cltbld', 22:48:01 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452148946.101408-1060205550', 22:48:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:01 INFO - '_': '/tools/buildbot/bin/python'} 22:48:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:48:01 INFO - Running setup.py (path:/tmp/pip-29aJIz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:48:01 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)) 22:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:48:01 INFO - Running setup.py (path:/tmp/pip-tXvZvd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:48:01 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)) 22:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:48:01 INFO - Running setup.py (path:/tmp/pip-xVEYJy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:48:01 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)) 22:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:48:01 INFO - Running setup.py (path:/tmp/pip-6eL6Cv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:48:01 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)) 22:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:48:01 INFO - Running setup.py (path:/tmp/pip-6VWlEp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:48:01 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)) 22:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:48:01 INFO - Running setup.py (path:/tmp/pip-P89qh4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:48:01 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)) 22:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:48:01 INFO - Running setup.py (path:/tmp/pip-9cGgMU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:48:01 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)) 22:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:48:01 INFO - Running setup.py (path:/tmp/pip-smZztU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:48:01 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)) 22:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:48:01 INFO - Running setup.py (path:/tmp/pip-NHLyuZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:48:01 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)) 22:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:48:01 INFO - Running setup.py (path:/tmp/pip-wkhzeW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:48:01 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)) 22:48:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:48:01 INFO - Running setup.py (path:/tmp/pip-LCHzEh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:48:02 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)) 22:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:48:02 INFO - Running setup.py (path:/tmp/pip-1f5_Dw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:48:02 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)) 22:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:48:02 INFO - Running setup.py (path:/tmp/pip-WpfKZo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:48:02 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)) 22:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:48:02 INFO - Running setup.py (path:/tmp/pip-ko2hEi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:48:02 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)) 22:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:48:02 INFO - Running setup.py (path:/tmp/pip-O3_cWN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:48:02 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)) 22:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:48:02 INFO - Running setup.py (path:/tmp/pip-r2Gyhn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:48:02 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)) 22:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:48:02 INFO - Running setup.py (path:/tmp/pip-ylfhCQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:48:02 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)) 22:48:02 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)) 22:48:02 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)) 22:48:02 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)) 22:48:02 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)) 22:48:02 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)) 22:48:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:48:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:48:04 INFO - Downloading blessings-1.5.1.tar.gz 22:48:04 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 22:48:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:48:04 INFO - Installing collected packages: blessings 22:48:04 INFO - Running setup.py install for blessings 22:48:04 INFO - Successfully installed blessings 22:48:04 INFO - Cleaning up... 22:48:04 INFO - Return code: 0 22:48:04 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:48:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:48:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:48:04 INFO - Reading from file tmpfile_stdout 22:48:04 INFO - Current package versions: 22:48:04 INFO - argparse == 1.2.1 22:48:04 INFO - blessings == 1.5.1 22:48:04 INFO - blobuploader == 1.2.4 22:48:04 INFO - docopt == 0.6.1 22:48:04 INFO - manifestparser == 1.1 22:48:04 INFO - mozInstall == 1.12 22:48:04 INFO - mozcrash == 0.16 22:48:04 INFO - mozdebug == 0.1 22:48:04 INFO - mozdevice == 0.47 22:48:04 INFO - mozfile == 1.2 22:48:04 INFO - mozhttpd == 0.7 22:48:04 INFO - mozinfo == 0.9 22:48:04 INFO - mozleak == 0.1 22:48:04 INFO - mozlog == 3.1 22:48:04 INFO - moznetwork == 0.27 22:48:04 INFO - mozprocess == 0.22 22:48:04 INFO - mozprofile == 0.28 22:48:04 INFO - mozrunner == 6.11 22:48:04 INFO - mozscreenshot == 0.1 22:48:04 INFO - mozsystemmonitor == 0.0 22:48:04 INFO - moztest == 0.7 22:48:04 INFO - mozversion == 1.4 22:48:04 INFO - psutil == 3.1.1 22:48:04 INFO - requests == 1.2.3 22:48:04 INFO - wsgiref == 0.1.2 22:48:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:48:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:48:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:04 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 0x7f589e83ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a89630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1a840>, '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 0x2a876b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a87b60>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1452148946.101408-1060205550', '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 22:48:04 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 22:48:04 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 22:48:04 INFO - Using env: {'DISPLAY': ':0', 22:48:04 INFO - 'HOME': '/home/cltbld', 22:48:04 INFO - 'LANG': 'en_US.UTF-8', 22:48:04 INFO - 'LANGUAGE': 'en_US:en', 22:48:04 INFO - 'LOGNAME': 'cltbld', 22:48:04 INFO - 'MAIL': '/var/mail/cltbld', 22:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:04 INFO - 'MOZ_NO_REMOTE': '1', 22:48:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:04 INFO - 'NO_EM_RESTART': '1', 22:48:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:48:04 INFO - 'PWD': '/builds/slave/test-pgo', 22:48:04 INFO - 'SHELL': '/bin/bash', 22:48:04 INFO - 'SHLVL': '1', 22:48:04 INFO - 'TERM': 'linux', 22:48:04 INFO - 'TMOUT': '86400', 22:48:04 INFO - 'USER': 'cltbld', 22:48:04 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452148946.101408-1060205550', 22:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:04 INFO - '_': '/tools/buildbot/bin/python'} 22:48:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:48:04 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)) 22:48:04 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)) 22:48:04 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)) 22:48:04 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)) 22:48:04 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)) 22:48:04 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)) 22:48:04 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)) 22:48:04 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)) 22:48:04 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)) 22:48:04 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)) 22:48:04 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)) 22:48:04 INFO - Cleaning up... 22:48:04 INFO - Return code: 0 22:48:04 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:48:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:48:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:04 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 0x7f589e83ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a89630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1a840>, '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 0x2a876b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a87b60>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1452148946.101408-1060205550', '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 22:48:04 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 22:48:04 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 22:48:04 INFO - Using env: {'DISPLAY': ':0', 22:48:04 INFO - 'HOME': '/home/cltbld', 22:48:04 INFO - 'LANG': 'en_US.UTF-8', 22:48:04 INFO - 'LANGUAGE': 'en_US:en', 22:48:04 INFO - 'LOGNAME': 'cltbld', 22:48:04 INFO - 'MAIL': '/var/mail/cltbld', 22:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:04 INFO - 'MOZ_NO_REMOTE': '1', 22:48:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:04 INFO - 'NO_EM_RESTART': '1', 22:48:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:48:04 INFO - 'PWD': '/builds/slave/test-pgo', 22:48:04 INFO - 'SHELL': '/bin/bash', 22:48:04 INFO - 'SHLVL': '1', 22:48:04 INFO - 'TERM': 'linux', 22:48:04 INFO - 'TMOUT': '86400', 22:48:04 INFO - 'USER': 'cltbld', 22:48:04 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452148946.101408-1060205550', 22:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:04 INFO - '_': '/tools/buildbot/bin/python'} 22:48:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:48:05 INFO - Downloading/unpacking jsonschema 22:48:05 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 22:48:05 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 22:48:05 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 22:48:05 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 22:48:05 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 22:48:05 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 22:48:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:48:06 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 22:48:06 INFO - Downloading/unpacking functools32 (from jsonschema) 22:48: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 22:48: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 22:48: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 22:48: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 22:48: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 22:48: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 22:48:06 INFO - Downloading functools32-3.2.3-2.tar.gz 22:48:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 22:48:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:48:07 INFO - warning: no files found matching '*.txt' 22:48:07 INFO - no previously-included directories found matching 'build' 22:48:07 INFO - no previously-included directories found matching 'dist' 22:48:07 INFO - no previously-included directories found matching '.git*' 22:48:07 INFO - Installing collected packages: jsonschema, functools32 22:48:07 INFO - Running setup.py install for functools32 22:48:07 INFO - warning: no files found matching '*.txt' 22:48:07 INFO - no previously-included directories found matching 'build' 22:48:07 INFO - no previously-included directories found matching 'dist' 22:48:07 INFO - no previously-included directories found matching '.git*' 22:48:07 INFO - Successfully installed jsonschema functools32 22:48:07 INFO - Cleaning up... 22:48:07 INFO - Return code: 0 22:48:07 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:48:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:48:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:48:07 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 0x7f589e83ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a89630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1a840>, '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 0x2a876b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a87b60>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1452148946.101408-1060205550', '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 22:48:07 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 22:48:07 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 22:48:07 INFO - Using env: {'DISPLAY': ':0', 22:48:07 INFO - 'HOME': '/home/cltbld', 22:48:07 INFO - 'LANG': 'en_US.UTF-8', 22:48:07 INFO - 'LANGUAGE': 'en_US:en', 22:48:07 INFO - 'LOGNAME': 'cltbld', 22:48:07 INFO - 'MAIL': '/var/mail/cltbld', 22:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:07 INFO - 'MOZ_NO_REMOTE': '1', 22:48:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:07 INFO - 'NO_EM_RESTART': '1', 22:48:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:48:07 INFO - 'PWD': '/builds/slave/test-pgo', 22:48:07 INFO - 'SHELL': '/bin/bash', 22:48:07 INFO - 'SHLVL': '1', 22:48:07 INFO - 'TERM': 'linux', 22:48:07 INFO - 'TMOUT': '86400', 22:48:07 INFO - 'USER': 'cltbld', 22:48:07 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452148946.101408-1060205550', 22:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:07 INFO - '_': '/tools/buildbot/bin/python'} 22:48:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:48:07 INFO - Downloading/unpacking flake8 22:48:07 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 22:48:07 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 22:48:07 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 22:48:07 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 22:48:07 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 22:48:07 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 22:48:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:48:09 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 22:48:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:48:09 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 22:48:09 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 22:48:09 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 22:48:09 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 22:48:09 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 22:48:09 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 22:48:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:48:09 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 22:48:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:48:09 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 22:48:09 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 22:48:09 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 22:48:09 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 22:48:09 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 22:48:09 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 22:48:09 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 22:48:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:48:09 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 22:48:09 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 22:48:09 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 22:48:09 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 22:48:09 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 22:48:09 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 22:48:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 22:48:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:48:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:48:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:48:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:48:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:48:09 INFO - no previously-included directories found matching 'docs/_build' 22:48:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:48:09 INFO - Running setup.py install for pep8 22:48:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:48:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:48:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:48:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:48:09 INFO - no previously-included directories found matching 'docs/_build' 22:48:09 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:48:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:48:09 INFO - Cleaning up... 22:48:10 INFO - Return code: 0 22:48:10 INFO - Running post-action listener: _resource_record_post_action 22:48:10 INFO - Running post-action listener: _start_resource_monitoring 22:48:10 INFO - Starting resource monitoring. 22:48:10 INFO - ##### 22:48:10 INFO - ##### Running install step. 22:48:10 INFO - ##### 22:48:10 INFO - Running pre-action listener: _resource_record_pre_action 22:48:10 INFO - Running main action method: install 22:48:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:48:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:48:10 INFO - Reading from file tmpfile_stdout 22:48:10 INFO - Detecting whether we're running mozinstall >=1.0... 22:48:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:48:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:48:10 INFO - Reading from file tmpfile_stdout 22:48:10 INFO - Output received: 22:48:10 INFO - Usage: mozinstall [options] installer 22:48:10 INFO - Options: 22:48:10 INFO - -h, --help show this help message and exit 22:48:10 INFO - -d DEST, --destination=DEST 22:48:10 INFO - Directory to install application into. [default: 22:48:10 INFO - "/builds/slave/test-pgo"] 22:48:10 INFO - --app=APP Application being installed. [default: firefox] 22:48:10 INFO - mkdir: /builds/slave/test-pgo/build/application 22:48:10 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'] 22:48:10 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 22:48:26 INFO - Reading from file tmpfile_stdout 22:48:26 INFO - Output received: 22:48:26 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:48:26 INFO - Running post-action listener: _resource_record_post_action 22:48:26 INFO - ##### 22:48:26 INFO - ##### Running run-tests step. 22:48:26 INFO - ##### 22:48:26 INFO - Running pre-action listener: _resource_record_pre_action 22:48:26 INFO - Running main action method: run_tests 22:48:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:48:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:48:26 INFO - Python 2.7.3 22:48:26 INFO - Return code: 0 22:48:26 INFO - grabbing minidump binary from tooltool 22:48: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')]} 22:48:26 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-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 0x2b1a840>, '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 0x2a876b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a87b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:48:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 22:48:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:48:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:48:26 INFO - Return code: 0 22:48:26 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:48:26 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:48:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:48:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:48:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:48:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:48:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:48:27 INFO - Return code: 0 22:48:27 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/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 22:48:27 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/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 22:48:27 INFO - Using env: {'DISPLAY': ':0', 22:48:27 INFO - 'HOME': '/home/cltbld', 22:48:27 INFO - 'LANG': 'en_US.UTF-8', 22:48:27 INFO - 'LANGUAGE': 'en_US:en', 22:48:27 INFO - 'LOGNAME': 'cltbld', 22:48:27 INFO - 'MAIL': '/var/mail/cltbld', 22:48:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:48:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:27 INFO - 'MOZ_NO_REMOTE': '1', 22:48:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:48:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:27 INFO - 'NO_EM_RESTART': '1', 22:48:27 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:48:27 INFO - 'PWD': '/builds/slave/test-pgo', 22:48:27 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:48:27 INFO - 'SHELL': '/bin/bash', 22:48:27 INFO - 'SHLVL': '1', 22:48:27 INFO - 'TERM': 'linux', 22:48:27 INFO - 'TMOUT': '86400', 22:48:27 INFO - 'USER': 'cltbld', 22:48:27 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452148946.101408-1060205550', 22:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:27 INFO - '_': '/tools/buildbot/bin/python'} 22:48:27 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/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 22:48:27 INFO - mozversion application_buildid: 20160106203234 22:48:27 INFO - mozversion application_changeset: c91d6036456490a3bb20eb63e0dd02a5dd063561 22:48:27 INFO - mozversion application_display_name: Nightly 22:48:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:48:27 INFO - mozversion application_name: Firefox 22:48:27 INFO - mozversion application_remotingname: firefox 22:48:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:48:27 INFO - mozversion application_vendor: Mozilla 22:48:27 INFO - mozversion application_version: 46.0a1 22:48:27 INFO - mozversion platform_buildid: 20160106203234 22:48:27 INFO - mozversion platform_changeset: c91d6036456490a3bb20eb63e0dd02a5dd063561 22:48:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:48:27 INFO - mozversion platform_version: 46.0a1 22:48:27 INFO - using testdate: 1452149307 22:48:27 INFO - actual date: 1452149307 22:48:27 INFO - starting webserver on 'localhost:54013' 22:48:27 INFO - SUITE-START | Running 3 tests 22:48:27 INFO - TEST-START | dromaeo_css 22:48:27 INFO - operating with platform_type : linux_ 22:48:27 INFO - Initialising browser for dromaeo_css test... 22:48:27 INFO - TEST-INFO | started process 3889 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpo4MqKY/profile http://localhost:54013/getInfo.html) 22:48:31 INFO - PROCESS | 3889 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 22:48:31 INFO - PROCESS | 3889 | __metrics Screen width/height:1600/1200 22:48:31 INFO - PROCESS | 3889 | colorDepth:24 22:48:31 INFO - PROCESS | 3889 | Browser inner width/height: 1024/697 22:48:31 INFO - PROCESS | 3889 | __metrics 22:48:32 INFO - PROCESS | 3889 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:48:32 INFO - TEST-INFO | 3889: exit 0 22:48:32 INFO - Browser initialized. 22:48:32 INFO - Running cycle 1/1 for dromaeo_css test... 22:48:32 INFO - TEST-INFO | started process 4021 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpo4MqKY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:48:44 INFO - PROCESS | 4021 | RSS: Main: 150151168 22:48:44 INFO - PROCESS | 4021 | 22:49:34 INFO - PROCESS | 4021 | 1452149374302 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] 22:51:43 INFO - PROCESS | 4021 | Cycle 1(1): loaded http://localhost:54013/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54013/tests/dromaeo/cssquery-ext.html) 22:51:44 INFO - PROCESS | 4021 | RSS: Main: 157806592 22:51:44 INFO - PROCESS | 4021 | 22:54:46 INFO - PROCESS | 4021 | Cycle 1(1): loaded http://localhost:54013/tests/dromaeo/cssquery-ext.html (next: http://localhost:54013/tests/dromaeo/cssquery-jquery.html) 22:54:46 INFO - PROCESS | 4021 | RSS: Main: 153051136 22:54:46 INFO - PROCESS | 4021 | 22:57:48 INFO - PROCESS | 4021 | Cycle 1(1): loaded http://localhost:54013/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54013/tests/dromaeo/cssquery-mootools.html) 22:57:49 INFO - PROCESS | 4021 | RSS: Main: 155131904 22:57:49 INFO - PROCESS | 4021 | 23:00:51 INFO - PROCESS | 4021 | Cycle 1(1): loaded http://localhost:54013/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54013/tests/dromaeo/cssquery-prototype.html) 23:00:51 INFO - PROCESS | 4021 | RSS: Main: 152354816 23:00:51 INFO - PROCESS | 4021 | 23:03:54 INFO - PROCESS | 4021 | Cycle 1(1): loaded http://localhost:54013/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54013/tests/dromaeo/cssquery-yui.html) 23:03:54 INFO - PROCESS | 4021 | RSS: Main: 152637440 23:03:54 INFO - PROCESS | 4021 | 23:06:57 INFO - PROCESS | 4021 | Cycle 1(1): loaded http://localhost:54013/tests/dromaeo/cssquery-yui.html (next: http://localhost:54013/tests/dromaeo/cssquery-dojo.html) 23:06:57 INFO - PROCESS | 4021 | RSS: Main: 154910720 23:06:57 INFO - PROCESS | 4021 | 23:06:57 INFO - PROCESS | 4021 | __start_tp_report 23:06:57 INFO - PROCESS | 4021 | _x_x_mozilla_page_load 23:06:57 INFO - PROCESS | 4021 | _x_x_mozilla_page_load_details 23:06:57 INFO - PROCESS | 4021 | |i|pagename|runs| 23:06:57 INFO - PROCESS | 4021 | |0;dojo.html;3207.342494788568;3270.3622793555237;3272.3782481328562;3312.917177070574;3320.053784671368;5212.973935130319;5252.395974462938;5277.234800953859;5337.332833395825;5337.653052551586;5182.248573956774;5227.817026404076;5264.578833693305;5279.155335146377;5309.62832601718;4821.493743156971;4826.3725715657;4947.356843610326;5012.949870501303;5021.723805190713;4911.0177964407085;4929.3591833061655;4934.1365261079345;4989.525995030466;5053.5451809337155;4745.074710431467;4765.618750499952;4826.300186472942;4880.829170979035;4912.459629440758;4838.927416088762;4849.806007759686;4851.175300198975;4852.951470485285;4897.04507621014;4788.664793464459;4806.543378379049;4862.513748625144;4877.170880950247;4939.2838038484215;5213.478652134794;5225.4513276105845;5271.789128434858;5304.549113325372;5315.0432922074015;5711.228984087178;5739.3399759027825;5768.250127483442;5776.942230577724;5833.7374818133285;5671.886562268732;5764.221830052931;5852.356240813507;5857.824265272048;5869.325027621835;5359.705216213107;5447.809326673548;5453.754581043862;5475.233467314619;5479.5342395896;5802.129680547867;5819.330776960619;5830.504407125357;5830.650160990354;5839.562032847553;5613.326400831927;5624.803131890364;5643.661380317194;5647.519960803378;5660.773569057192;5529.115341545334;5651.491365777099;5653.180288858092;5656.660600363992;5743.310802703702;5586.1062230043;5597.860053498695;5635.464630860061;5637.774489020475;5658.547316214693;5474.7810087596845;5572.08060669993;5647.858803529944;5652.689102099424;5667.319921609434;4356.825726970949;4359.106383191438;4361.934570981438;4365.563443655609;4405.140997505519;3951.209758048402;3980.5621381647998;3995.5005624296964;3996.86010989614;4009.7794621296107;5296.205569164579;5329.733513324319;5369.194620806832;5450.863728406743;5485.6434331768305;5805.071188609802;5829.941700583025;5834.504067154339;5835.183074369592;5842.883142337129;5468.48049435303;5478.424765399655;5478.479544443271;5488.1493368527945;5507.697076660742;4774.904501910012;4869;4947.158982972831;4959.752012399438;5053.84838454847;5922.555808314393;5939.495142912814;5942.1383899335215;5944.6730429826775;5972.044472884318;5728.713564321684;5729.799457018984;5744.281964754406;5747.281589801275;5750.48245657876;5915.792947246998;6025.6083354581815;6027.939720602738;6105.328413874559;6125.326214116532;5651.4348565143155;5658.236138121301;5673.5461163107675;5674.631148975303;5686.886262274648;5682.261306030189;5699.4300569944335;5754.827355179351;5765.365809760839;5767.5385969121535;5407.242985981887;5532.75102620375;5663.122216056518;5726.885462290814;5777.971110144423;5567.415421380859;5602.411746766694;5610.915836262541;5611.915821262766;5618.52242559387;5445.428230035947;5518.668879867221;5521.5306698931045;5522.861928451821;5529.474699903502;5556.722163891708;5612.943870561242;5716.571257155813;5728.885422291614;5734.426557344399;5486.643368181056;5509.118541033416;5511.834644960658;5515.365732940602;5524.502794748492 23:06:57 INFO - PROCESS | 4021 | |1;ext.html;522.5349438999291;539.6950722841594;541.7535021565188;541.7616248850508;556.3713004305134;34963.300733985336;35922.640773592255;36031.459528107065;36044.81977590115;36093.27813443733;38522.807385963104;39052;39274;39281;39351.21297574054;8361.205685459872;8478.533680647563;8495.36284778641;8507.489550626951;8511.829763404729;8302.958485207566;8381.287590554779;8407.621657025418;8416.915830841705;8418.915810841905;8592.699255526059;8620.482771033758;8634.913650863473;8644.96260448747;8692.13078692132;8561.101084386111;8571.185737354972;8629.827403451896;8639.913600863974;8656.783580410509;8436.535990520519;8510.74467765968;8518.701845435442;8577.142285771435;8578.656853725906;38753.224935501414;39400.80299598513;39492.60507394918;39524.60475395238;39588.20823583541;2704.6619172603423;2713.226730381851;2727.3454370951026;2823.4917714811327;2871.224769312295;28360.716392836013;29238.122856314345;29257.561136582968;29259.268518287212;29497.41005179906;3874.302625527404;3875.534935807693;3895.162540053902;3909.7458665186955;3957.525096988351;192769;193193;193277;193420;194573.02713486482;40692.389614155814;41219.7939010303;54375.728121359934;54716.45283547193;54763.72618136964;39225.41161882574;39403.80298098491;39597.80201099034;39751.602483975366;39854.402183967264;14468.493602724066;14470.131792092508;14488.203148826706;14528.346224419714;14555.12669239849;11165.49755260999;11193.72015699614;11207.831882521768;11211.159163062639;11214.943925280322;13406.530771422953;13506.459741610226;13773.311334433238;13863.584092477242;13921.303934803422;5643.943560564342;5715.657060576295;5728.198052272685;5778.393268706809;5778.451047150514;889.9065598112105;950.3632566180537;956.7560272130562;981.676046904534;1002.9398236105857;27795.44409111847;28078.71921280802;28085.71914280872;28175.71824281772;28343.57484637732;1005.1707341443339;1021.2748948246827;1052.55792567122;1053.0838170791308;1055.767731099157;13408.128471649312;13544.45822167122;13823;13862.861371386358;13902.860971390359;363342;373367;374976;375137;375459;49778.25332620014;50123.74938125359;50264.24603630949;50357;50467.74766126219;1338.4579245405625;1360.3538319298254;1360.53741727813;1363.5023216525897;1477.9506550349372;25524.23427297184;26438;26477;26577.601335980362;26670.733292666824;46869.2969605463;47749.76125119352;47876;48167;48507.27239091346;231272;235179;235377;236498;236693;36113.638863612076;36830.63169368272;40659;41170.176596468504;41666.79166604148;37861;38493.61506385012;38745.22509549737;38957.41563876601;39200.80399597984;32834.34331313408;32988.1752956178;33246.20184414564;33300.83349583237;33821.661783382835;34580.82709586436;34823;35466.64533354634;35823.64176358203;35865.744698935414;37061.44407833831;37136.25727485381;37736.433953491265;37823.243535129695;37896.242075158894;27864.16407507697;29027.83888644515;30667.386652266385;30985.690143099182;31252.531212032292;24405.755942440348;25301.240962771146;26147;26256.606150908134;26291.342716432242 23:06:57 INFO - PROCESS | 4021 | |2;jquery.html;359.12015561873403;362.7297663240884;363.19552191894945;365.05450882215064;367.3571250311955;16423.917880410598;16986.405475808348;17068.658626827473;17715.114244287768;17777.644447111066;14688.412463501474;15639;15787.684246315066;15860.206989650529;15895.761563576556;4872.244802055687;4985.725785081819;5010.69935803853;5018.447970723236;5019.52314530119;4902.681325713835;4946.332245146913;4948.1093403187415;4953.4798846121175;4960.479149689285;5072.188449848025;5094.439611642735;5235.267062611238;5249.8950020999555;5291.391489978644;5053.646244762868;5130.615203859688;5160.509751573613;5190.039842629126;5191.013707395602;5039.319691841628;5039.72281524516;5040.6471546991725;5041.8487445376695;5046.293518907356;12351.38243087842;13272.070955033152;18256.178471968793;18786.342478013205;18850.811491885044;1951.375559820858;2000.7198992141111;2063.7626672932656;2071.275053731197;2174.9782502174935;9238.676646317346;9269.44383337002;9423.151916327495;9497.857532137023;9671.274654400948;1784.4379020608467;1796.4969808453654;1804.5578833185823;1833.6424397242542;1892.8485721142276;56159.71920140414;56311.71844140753;56645;58156.41843581595;60151;10269.845952310721;10300.948495257626;10306.845397319046;10368.481575921174;10429;13185.208887466782;13238.139520931109;13283.667908302177;13341.533046343331;13343.132696374705;7405.62971851416;7509.324160825552;7559.886601700979;7763.728269510653;7852.725154619561;7652.081750190013;7696.307332340116;7733;7743.612819359009;7750.14748377678;4327.307630779123;4348.826046958086;4406.691531592822;4412.713173643703;4505.301678239878;1803.2786885245744;1851.296507327234;1895.3366321787264;1905.352180258691;1911.9330823421114;405.5032585083308;814.4339683919619;985.6550207427487;995.2784231432298;1025.7844454321503;10330.535125919352;10491.16070714341;10605.734856628646;10663.34288919357;10670;445.67911104005066;448.6679856905931;450.8286850996666;451.5777747805812;455.180674785385;5886.764529418861;5902.675352855634;5979.581429299994;9903.801923961624;10034.949825250973;550622;569808;587188;589721;590240;38103.80948095242;38652.420213696816;60367.69816150891;77077.61461192658;80007.59996200098;1114.9944250278859;1135.27909777292;1144.0733006264952;1144.3305666185208;1147.9598214062469;14792.186429746467;14847.257637117886;14937.274823101732;15006.549803505912;15404.075755454709;32109.839450802596;32229.51655725213;33143.66856331406;33496.1625959353;33643.49534756932;41623.791881041616;42621.573784263004;44148;44386.11227775491;44450.55549444464;9566.139047485482;9574.90425095768;9745.171660408945;9785.559649815634;9874.753131171778;11560.884391155982;13798.724025519634;17440.040797756246;17521.82478175253;17597.824021759618;12615.495380185057;13320.533781317607;14056.367463464374;14474.901139334948;14778.77831832502;12498.12513124109;12596.307203103917;14443.205623690797;14571.271436427924;14774.33515491827;13637.11358761717;13685.384157713126;14178.858211417753;14200.360983755549;14288.714225715636;9634.614615415305;9775.169110625677;9891.159251463707;10007.799844002933;10087.486876968513;14699.853001469848;14753.631159221106;15145.621359466102;15201.847981520043;15220.162891041098 23:06:57 INFO - PROCESS | 4021 | |3;mootools.html;1471.977920331195;1476.3061361160258;1633.0446688687118;1755.4821327708325;1789.7762779652535;7216.891746623798;7273.2726727327245;7332;7422.814429639262;7461.813454663623;7193.388561972226;7202.315780000905;7257;7294.81762955925;7297.963510182455;2165.8592191507582;2170.663547150194;2182.334388011656;2186.2238905188588;2191.5288213034196;2139.251262058283;2163.4266919266406;2241.081156725743;2246.3485589179118;2257.559775843711;2181.454636340915;2214.8560343577697;2220.655798351258;2224.7775222477785;2256.6615007748887;2230.743464501587;2243.1588154442084;2266.5240299537118;2274.9886250568807;2279.988600057006;2174.8803815790125;2180.4875854174256;2194.08945287707;2195.835312351564;2197.450637340665;7162.606056666881;7229.09636295463;7261.3101755333155;7302.087239095114;7304.342609165147;4303.956960430387;4389.561043895616;4394.274944634131;4395.406620106309;4401.471823381183;2855.300451389423;2921.269682579355;2939.5884576159356;2981.329200929795;2987.312918028844;870.1037930931151;880.1550511508959;894.1728900766765;924.2790623313758;928.4893308680199;9546;9546.522673866348;9578.377405468622;9581.898081720552;9609.759756006086;3797.487339209227;3797.8480860765812;3808.1431677872256;3863.30460517104;3955.0310174007554;7864.21357864209;7877.487963282369;7898.644560994769;7906.881396779053;7920.207979202149;4392.3411488277015;4397.274449715761;4405.911881762411;4419.9337009944875;4424.159409712144;3932.4691166692132;3933.3903244997073;3975.0261186009034;3975.204959008152;3983.8008099594904;3341.515480255398;3357.244619960489;3364.2430453147845;3377.155711072232;3383.424817780983;1048.0881632979203;1049.4175732468552;1049.454283772434;1056.434807378049;1077.9892201078046;958.9212136346611;963.0658261486348;1020.3418794877263;1043.8434234864678;1219.6341097670663;6604.3725846044545;6683.4987375947;6702.095217145623;6712.295209002984;6719.193696756322;1042.7601651620018;1051.5688567687212;1061.976933940844;1073.0771536478621;1118.664400679809;5452.372977107683;5505.642133261325;5545.889082218414;5547.389787123413;5558.749856256478;8302.750917472486;8320.417570770109;8349.499030058094;8425.747227583182;8438;8331.250187483156;8414.410991230556;8420.53687047206;8434.873476897852;8451.746447606582;6404.935950640527;6422.2614399344675;6505.577137486143;6567;6597.8350541235895;6816.0457535946;6863.519553631198;6879.449644028566;6899.689513971783;6939.618320992394;7319.597422141834;7524.05949256343;7556.65995030236;7665.463417560717;7917.247861453153;7479.214682458263;7718.768436946901;8024.959875200587;8035;8120.593970301343;6304.148939893055;6307.653079080511;6352.36476352361;6371.299157092809;6409.198850143732;6962.303769622998;6987.475939304471;6989.720411183495;6990.300969902969;6990.440764738911;6271;6463.903041454476;6584.176977877765;6693.062971183941;6789.762358317435;6110.816675499742;6179.876402472015;6428.260750013808;6442;6539.149910511603;6336.493080553637;6366.713497892699;6422.518311126591;6533.575317604341;6567.737290508326;5525.143602741421;5525.861853453535;5526.309211348582;5541.030319694118;5548.778048878161;5533.723313834373;5576.637518561281;5609.046462101371;5610.5231055360755;5616.550675945833 23:06:57 INFO - PROCESS | 4021 | |4;prototype.html;334.24794213020704;334.5550417944134;339.4365353513167;342.69671340863334;344.0675768666914;6115.327313995463;6121.143039974396;6140.7850725224625;6167.969160154198;6246.187995560582;6013.278406591205;6087.147799308101;6120.632762034281;6131.693415329238;6147.907781383283;4708.058388322332;4709.434867815867;4714.552117548845;4721.952780472194;4726.1020406122725;4717.858464246078;4719.386479757643;4720.221163508017;4722.433308003045;4723.598494127986;4479.350494178342;4592.885177870563;4649.302604609302;4651.88370290742;4692.5072867348945;4605.194091034055;4607.470140933785;4628.8148474061;4629.560191781792;4645;3942.2115576884453;4033.838646454138;4043.8989025274605;4045.110075783323;4050.392441133824;5829.7376618052285;5848.064309710426;5874.295084589877;5882.147088672162;5907.172995780594;5405.891882162335;5415.10650742627;5423.83728488146;5426.240326354314;5432.782688692448;6499.93500064998;6504.804855854332;6509.93490065098;6515.087887695679;6529.379708927644;4383.8684839454545;4523.819047238107;4524.886877828048;4526.185286648402;4536.115457485792;6749.628770417625;6814.216365118025;6815.148106486689;6844.657767111675;6861.828454288633;4609.516000819865;4630.745309008037;4638.281066434708;4639.072185562901;4641.651876109306;4618.214903466419;4648.48866624671;4685.180093483695;4696.647751418657;4722.386089808371;5413;5418.187271909166;5420.34955805298;5427.782888684487;5445.992491389105;6563.606183628997;6565.671716414256;6567.573107747981;6570.178727659043;6581.901271480931;1628.4137710424238;1648.736202207641;1649.8762592805347;1650.414102993444;1656.8011838579448;1094.3269889018197;1103.961361352365;1112.7941330853819;1116.1963386361806;1122.938238396896;6247.312795592481;6250.499960003189;6253.843653908689;6260.311365749764;6263.154474145932;6730.226024007204;6744.22441419243;6745.628990405575;6754.729810807611;6756.560823546453;6071.058985857199;6207.410296021871;6238.313785483593;6250.343713910065;6251.468625166821;3646.0338010426726;3660.908477288036;3664.0656632558525;3664.4686520454384;3669.2111196092433;6910.481713871379;7060.18807837095;7072.1513418389095;7075.2570980047385;7087.114110736158;6966.12923384577;6976.790696279119;6991.7902462926195;7004.964975175193;7013.719451221894;6938.861222775517;7033.437325013987;7056.329648683367;7094.68073936674;7094.92905070953;6755.2231493378895;6763.188417389944;6766.15423072116;6778.4577233822165;6785.2536221016635;6637.568558043712;6646;6675.098861653809;6694.523026480233;6697.129373181455;6912.930870691229;6990.300969902969;7065.116860392451;7075.752348667772;7085;4506.977465112785;4535.705179163344;4544;4548.704334218265;4559.133764584718;6769.830754231184;6790.524663273523;6792;6813.454923606;6818.749812561942;6518.087467754423;6536.7712130075215;6580.144581204413;6621.437177839744;6632.734690612321;6530.281669016499;6574.145361103026;6577.704003319766;6580.901286480611;6584.374484423972;6436.806895792946;6466.515011374072;6481.513886458629;6487.124238227968;6490.902636460552;6556.082148499309;6600.174978127734;6613.933860661332;6635.933640663531;6653.63405012729;6444.548881578432;6473.320301368289;6483.546151769519;6486.837829054122;6489.448396886318 23:06:57 INFO - PROCESS | 4021 | |5;yui.html;694.8714487819753;697.320112889932;769.3114662377175;793.8293266947605;834.2075028722713;11507.504024476817;11652;11717.7656446871;11809.881901180986;11843.644690659294;11298.943505282463;11861.110416718737;11866.466009029593;11870.406479676025;11892.04863610909;655.1941112431712;663.9502037347219;756.3608750605729;772.069656064441;784.8940393046922;749.9962500187492;777.2344240922715;783.0329543014373;784.9332806711436;787.0948409329288;789.9802504937394;826.7643721539363;839.4249938791947;839.7648658375665;840.1598401598402;788.2117882117882;811.411726498287;820.6471217376526;822.3955392786297;828.7969447485344;580.5732786401991;593.6200831467821;617.0528239152878;617.9073139029136;619.1208483952798;11495.310281383145;11518.193726439153;11543.94228028863;11563.53745850165;11586.768264634744;10933.671989840317;11224.438778061065;11637.476313565825;11793.705157371134;11978.221415607957;9319.90680093204;9363.110504502061;9379.202767764747;9437.76405589859;9590.08894155054;3535.6287589803214;3546.379383607884;3554;3564.1624218308675;3666.2850744104912;43127;43464.78267608673;43471.34792978108;43508.60702661352;43564.128717425476;9337.439753614804;9797.216222702167;9833.901660983442;10215.23385746072;10260.179185665278;17894.194761235776;17900.820991789915;17931.910340448474;18016.90991545034;18025.549361266072;6811.659417029129;6986.476014298948;7017.543859649107;7077.681504332318;7365.300296471826;4008.8797336079965;4119.134981653886;4132.91734165315;4176.1230141669985;4225.746455212636;2879.2226098953165;2921.255079954598;2923.72224638659;2930.633670791151;2955.349823038928;468.10124560843263;476.3402687278145;478.2014036558955;504.50054446098096;506.20525774533627;556.9944300557023;606.918066061076;660.6069388713707;664.8271449423088;684.4626967830229;7633.313001829862;8100.149484304181;8105.1489593593005;8301.58492075406;8332.66669333232;521.1713375732528;610.9796639611859;615.9199304090529;655.505093654288;660.425429876011;3688.889333320005;3752.718546108998;3768.8869333920024;3819.388897776398;3821.560520540118;55198.724006380515;58229.4177058224;59720;59760.70119649374;59879;44165.337519937224;44188.24399925978;44989.55010449919;44996;46767;45652.54347456549;45687.77156114265;46345.76827115843;46379.30431043537;46708.29937550939;8218.465799722999;8394.790130246793;8460.619272132892;8494;8669.566521674018;33399.83300083484;34020.48969265413;34524;34610.134746631535;34811.651883481856;40745.59254407418;41894;44093.33859992038;44244.778776105915;44584;10433.582656693647;10465;10506.737331566772;10534.209934255116;10747.516361763583;11228.66314010581;11539.8269025963;11557.422128893353;11693.181477296508;12076.577319793765;10439.478026098817;10546.894531054591;10663.146948244277;11034.889651103707;11112.833307500556;10430.895691042992;10467.738306542398;10537.209709271681;10538.367697938149;11228.214025018171;10757.085647720032;10772.9765672261;11140.610078647209;11159.832602510807;11269.66191014271;9081.77295567616;9207.125323094295;9387.624495020124;9420.481873497023;9686.806263874823;8798.027839338578;9098.52246216436;9140.954295228481;9166.450012999241;9185.357025008185 23:06:57 INFO - PROCESS | 4021 | __end_tp_report 23:06:57 INFO - PROCESS | 4021 | __start_cc_report 23:06:57 INFO - PROCESS | 4021 | _x_x_mozilla_cycle_collect,323 23:06:57 INFO - PROCESS | 4021 | __end_cc_report 23:06:57 INFO - PROCESS | 4021 | __startTimestamp1452150417365__endTimestamp 23:06:57 INFO - PROCESS | 4021 | 23:06:57 INFO - PROCESS | 4021 | ------- Summary: start ------- 23:06:57 INFO - PROCESS | 4021 | Number of tests: 6 23:06:57 INFO - PROCESS | 4021 | 23:06:57 INFO - PROCESS | 4021 | [#0] dojo.html Cycles:165 Average:5329.40 Median:5518.67 stddev:583.94 (10.6%) stddev-sans-first:561.50 23:06:57 INFO - PROCESS | 4021 | Values: 3207.3 3270.4 3272.4 3312.9 3320.1 5213.0 5252.4 5277.2 5337.3 5337.7 5182.2 5227.8 5264.6 5279.2 5309.6 4821.5 4826.4 4947.4 5012.9 5021.7 4911.0 4929.4 4934.1 4989.5 5053.5 4745.1 4765.6 4826.3 4880.8 4912.5 4838.9 4849.8 4851.2 4853.0 4897.0 4788.7 4806.5 4862.5 4877.2 4939.3 5213.5 5225.5 5271.8 5304.5 5315.0 5711.2 5739.3 5768.3 5776.9 5833.7 5671.9 5764.2 5852.4 5857.8 5869.3 5359.7 5447.8 5453.8 5475.2 5479.5 5802.1 5819.3 5830.5 5830.7 5839.6 5613.3 5624.8 5643.7 5647.5 5660.8 5529.1 5651.5 5653.2 5656.7 5743.3 5586.1 5597.9 5635.5 5637.8 5658.5 5474.8 5572.1 5647.9 5652.7 5667.3 4356.8 4359.1 4361.9 4365.6 4405.1 3951.2 3980.6 3995.5 3996.9 4009.8 5296.2 5329.7 5369.2 5450.9 5485.6 5805.1 5829.9 5834.5 5835.2 5842.9 5468.5 5478.4 5478.5 5488.1 5507.7 4774.9 4869.0 4947.2 4959.8 5053.8 5922.6 5939.5 5942.1 5944.7 5972.0 5728.7 5729.8 5744.3 5747.3 5750.5 5915.8 6025.6 6027.9 6105.3 6125.3 5651.4 5658.2 5673.5 5674.6 5686.9 5682.3 5699.4 5754.8 5765.4 5767.5 5407.2 5532.8 5663.1 5726.9 5778.0 5567.4 5602.4 5610.9 5611.9 5618.5 5445.4 5518.7 5521.5 5522.9 5529.5 5556.7 5612.9 5716.6 5728.9 5734.4 5486.6 5509.1 5511.8 5515.4 5524.5 23:06:57 INFO - PROCESS | 4021 | 23:06:57 INFO - PROCESS | 4021 | [#1] ext.html Cycles:180 Average:42699.47 Median:205251.63 stddev:73001.24 (35.6%) stddev-sans-first:73137.34 23:06:57 INFO - PROCESS | 4021 | Values: 522.5 539.7 541.8 541.8 556.4 34963.3 35922.6 36031.5 36044.8 36093.3 38522.8 39052.0 39274.0 39281.0 39351.2 8361.2 8478.5 8495.4 8507.5 8511.8 8303.0 8381.3 8407.6 8416.9 8418.9 8592.7 8620.5 8634.9 8645.0 8692.1 8561.1 8571.2 8629.8 8639.9 8656.8 8436.5 8510.7 8518.7 8577.1 8578.7 38753.2 39400.8 39492.6 39524.6 39588.2 2704.7 2713.2 2727.3 2823.5 2871.2 28360.7 29238.1 29257.6 29259.3 29497.4 3874.3 3875.5 3895.2 3909.7 3957.5 192769.0 193193.0 193277.0 193420.0 194573.0 40692.4 41219.8 54375.7 54716.5 54763.7 39225.4 39403.8 39597.8 39751.6 39854.4 14468.5 14470.1 14488.2 14528.3 14555.1 11165.5 11193.7 11207.8 11211.2 11214.9 13406.5 13506.5 13773.3 13863.6 13921.3 5643.9 5715.7 5728.2 5778.4 5778.5 889.9 950.4 956.8 981.7 1002.9 27795.4 28078.7 28085.7 28175.7 28343.6 1005.2 1021.3 1052.6 1053.1 1055.8 13408.1 13544.5 13823.0 13862.9 13902.9 363342.0 373367.0 374976.0 375137.0 375459.0 49778.3 50123.7 50264.2 50357.0 50467.7 1338.5 1360.4 1360.5 1363.5 1478.0 25524.2 26438.0 26477.0 26577.6 26670.7 46869.3 47749.8 47876.0 48167.0 48507.3 231272.0 235179.0 235377.0 236498.0 236693.0 36113.6 36830.6 40659.0 41170.2 41666.8 37861.0 38493.6 38745.2 38957.4 39200.8 32834.3 32988.2 33246.2 33300.8 33821.7 34580.8 34823.0 35466.6 35823.6 35865.7 37061.4 37136.3 37736.4 37823.2 37896.2 27864.2 29027.8 30667.4 30985.7 31252.5 24405.8 25301.2 26147.0 26256.6 26291.3 23:06:57 INFO - PROCESS | 4021 | 23:06:57 INFO - PROCESS | 4021 | [#2] jquery.html Cycles:180 Average:28632.98 Median:362.96 stddev:94161.91 (25942.6%) stddev-sans-first:94402.13 23:06:57 INFO - PROCESS | 4021 | Values: 359.1 362.7 363.2 365.1 367.4 16423.9 16986.4 17068.7 17715.1 17777.6 14688.4 15639.0 15787.7 15860.2 15895.8 4872.2 4985.7 5010.7 5018.4 5019.5 4902.7 4946.3 4948.1 4953.5 4960.5 5072.2 5094.4 5235.3 5249.9 5291.4 5053.6 5130.6 5160.5 5190.0 5191.0 5039.3 5039.7 5040.6 5041.8 5046.3 12351.4 13272.1 18256.2 18786.3 18850.8 1951.4 2000.7 2063.8 2071.3 2175.0 9238.7 9269.4 9423.2 9497.9 9671.3 1784.4 1796.5 1804.6 1833.6 1892.8 56159.7 56311.7 56645.0 58156.4 60151.0 10269.8 10300.9 10306.8 10368.5 10429.0 13185.2 13238.1 13283.7 13341.5 13343.1 7405.6 7509.3 7559.9 7763.7 7852.7 7652.1 7696.3 7733.0 7743.6 7750.1 4327.3 4348.8 4406.7 4412.7 4505.3 1803.3 1851.3 1895.3 1905.4 1911.9 405.5 814.4 985.7 995.3 1025.8 10330.5 10491.2 10605.7 10663.3 10670.0 445.7 448.7 450.8 451.6 455.2 5886.8 5902.7 5979.6 9903.8 10034.9 550622.0 569808.0 587188.0 589721.0 590240.0 38103.8 38652.4 60367.7 77077.6 80007.6 1115.0 1135.3 1144.1 1144.3 1148.0 14792.2 14847.3 14937.3 15006.5 15404.1 32109.8 32229.5 33143.7 33496.2 33643.5 41623.8 42621.6 44148.0 44386.1 44450.6 9566.1 9574.9 9745.2 9785.6 9874.8 11560.9 13798.7 17440.0 17521.8 17597.8 12615.5 13320.5 14056.4 14474.9 14778.8 12498.1 12596.3 14443.2 14571.3 14774.3 13637.1 13685.4 14178.9 14200.4 14288.7 9634.6 9775.2 9891.2 10007.8 10087.5 14699.9 14753.6 15145.6 15201.8 15220.2 23:06:57 INFO - PROCESS | 4021 | 23:06:57 INFO - PROCESS | 4021 | [#3] mootools.html Cycles:180 Average:5016.23 Median:6287.57 stddev:2526.69 (40.2%) stddev-sans-first:2519.73 23:06:57 INFO - PROCESS | 4021 | Values: 1472.0 1476.3 1633.0 1755.5 1789.8 7216.9 7273.3 7332.0 7422.8 7461.8 7193.4 7202.3 7257.0 7294.8 7298.0 2165.9 2170.7 2182.3 2186.2 2191.5 2139.3 2163.4 2241.1 2246.3 2257.6 2181.5 2214.9 2220.7 2224.8 2256.7 2230.7 2243.2 2266.5 2275.0 2280.0 2174.9 2180.5 2194.1 2195.8 2197.5 7162.6 7229.1 7261.3 7302.1 7304.3 4304.0 4389.6 4394.3 4395.4 4401.5 2855.3 2921.3 2939.6 2981.3 2987.3 870.1 880.2 894.2 924.3 928.5 9546.0 9546.5 9578.4 9581.9 9609.8 3797.5 3797.8 3808.1 3863.3 3955.0 7864.2 7877.5 7898.6 7906.9 7920.2 4392.3 4397.3 4405.9 4419.9 4424.2 3932.5 3933.4 3975.0 3975.2 3983.8 3341.5 3357.2 3364.2 3377.2 3383.4 1048.1 1049.4 1049.5 1056.4 1078.0 958.9 963.1 1020.3 1043.8 1219.6 6604.4 6683.5 6702.1 6712.3 6719.2 1042.8 1051.6 1062.0 1073.1 1118.7 5452.4 5505.6 5545.9 5547.4 5558.7 8302.8 8320.4 8349.5 8425.7 8438.0 8331.3 8414.4 8420.5 8434.9 8451.7 6404.9 6422.3 6505.6 6567.0 6597.8 6816.0 6863.5 6879.4 6899.7 6939.6 7319.6 7524.1 7556.7 7665.5 7917.2 7479.2 7718.8 8025.0 8035.0 8120.6 6304.1 6307.7 6352.4 6371.3 6409.2 6962.3 6987.5 6989.7 6990.3 6990.4 6271.0 6463.9 6584.2 6693.1 6789.8 6110.8 6179.9 6428.3 6442.0 6539.1 6336.5 6366.7 6422.5 6533.6 6567.7 5525.1 5525.9 5526.3 5541.0 5548.8 5533.7 5576.6 5609.0 5610.5 5616.6 23:06:57 INFO - PROCESS | 4021 | 23:06:57 INFO - PROCESS | 4021 | [#4] prototype.html Cycles:180 Average:5469.96 Median:6222.86 stddev:1665.78 (26.8%) stddev-sans-first:1625.24 23:06:57 INFO - PROCESS | 4021 | Values: 334.2 334.6 339.4 342.7 344.1 6115.3 6121.1 6140.8 6168.0 6246.2 6013.3 6087.1 6120.6 6131.7 6147.9 4708.1 4709.4 4714.6 4722.0 4726.1 4717.9 4719.4 4720.2 4722.4 4723.6 4479.4 4592.9 4649.3 4651.9 4692.5 4605.2 4607.5 4628.8 4629.6 4645.0 3942.2 4033.8 4043.9 4045.1 4050.4 5829.7 5848.1 5874.3 5882.1 5907.2 5405.9 5415.1 5423.8 5426.2 5432.8 6499.9 6504.8 6509.9 6515.1 6529.4 4383.9 4523.8 4524.9 4526.2 4536.1 6749.6 6814.2 6815.1 6844.7 6861.8 4609.5 4630.7 4638.3 4639.1 4641.7 4618.2 4648.5 4685.2 4696.6 4722.4 5413.0 5418.2 5420.3 5427.8 5446.0 6563.6 6565.7 6567.6 6570.2 6581.9 1628.4 1648.7 1649.9 1650.4 1656.8 1094.3 1104.0 1112.8 1116.2 1122.9 6247.3 6250.5 6253.8 6260.3 6263.2 6730.2 6744.2 6745.6 6754.7 6756.6 6071.1 6207.4 6238.3 6250.3 6251.5 3646.0 3660.9 3664.1 3664.5 3669.2 6910.5 7060.2 7072.2 7075.3 7087.1 6966.1 6976.8 6991.8 7005.0 7013.7 6938.9 7033.4 7056.3 7094.7 7094.9 6755.2 6763.2 6766.2 6778.5 6785.3 6637.6 6646.0 6675.1 6694.5 6697.1 6912.9 6990.3 7065.1 7075.8 7085.0 4507.0 4535.7 4544.0 4548.7 4559.1 6769.8 6790.5 6792.0 6813.5 6818.7 6518.1 6536.8 6580.1 6621.4 6632.7 6530.3 6574.1 6577.7 6580.9 6584.4 6436.8 6466.5 6481.5 6487.1 6490.9 6556.1 6600.2 6613.9 6635.9 6653.6 6444.5 6473.3 6483.5 6486.8 6489.4 23:06:57 INFO - PROCESS | 4021 | 23:06:57 INFO - PROCESS | 4021 | [#5] yui.html Cycles:180 Average:13099.20 Median:45324.27 stddev:15314.04 (33.8%) stddev-sans-first:15328.67 23:06:57 INFO - PROCESS | 4021 | Values: 694.9 697.3 769.3 793.8 834.2 11507.5 11652.0 11717.8 11809.9 11843.6 11298.9 11861.1 11866.5 11870.4 11892.0 655.2 664.0 756.4 772.1 784.9 750.0 777.2 783.0 784.9 787.1 790.0 826.8 839.4 839.8 840.2 788.2 811.4 820.6 822.4 828.8 580.6 593.6 617.1 617.9 619.1 11495.3 11518.2 11543.9 11563.5 11586.8 10933.7 11224.4 11637.5 11793.7 11978.2 9319.9 9363.1 9379.2 9437.8 9590.1 3535.6 3546.4 3554.0 3564.2 3666.3 43127.0 43464.8 43471.3 43508.6 43564.1 9337.4 9797.2 9833.9 10215.2 10260.2 17894.2 17900.8 17931.9 18016.9 18025.5 6811.7 6986.5 7017.5 7077.7 7365.3 4008.9 4119.1 4132.9 4176.1 4225.7 2879.2 2921.3 2923.7 2930.6 2955.3 468.1 476.3 478.2 504.5 506.2 557.0 606.9 660.6 664.8 684.5 7633.3 8100.1 8105.1 8301.6 8332.7 521.2 611.0 615.9 655.5 660.4 3688.9 3752.7 3768.9 3819.4 3821.6 55198.7 58229.4 59720.0 59760.7 59879.0 44165.3 44188.2 44989.6 44996.0 46767.0 45652.5 45687.8 46345.8 46379.3 46708.3 8218.5 8394.8 8460.6 8494.0 8669.6 33399.8 34020.5 34524.0 34610.1 34811.7 40745.6 41894.0 44093.3 44244.8 44584.0 10433.6 10465.0 10506.7 10534.2 10747.5 11228.7 11539.8 11557.4 11693.2 12076.6 10439.5 10546.9 10663.1 11034.9 11112.8 10430.9 10467.7 10537.2 10538.4 11228.2 10757.1 10773.0 11140.6 11159.8 11269.7 9081.8 9207.1 9387.6 9420.5 9686.8 8798.0 9098.5 9141.0 9166.5 9185.4 23:06:57 INFO - PROCESS | 4021 | -------- Summary: end -------- 23:06:57 INFO - PROCESS | 4021 | 23:06:58 INFO - TEST-INFO | 4021: exit 0 23:06:58 INFO - TEST-OK | dromaeo_css | took 1110543ms 23:06:58 INFO - TEST-START | kraken 23:06:58 INFO - operating with platform_type : linux_ 23:06:58 INFO - Initialising browser for kraken test... 23:06:58 INFO - TEST-INFO | started process 4263 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8D4TIT/profile http://localhost:54013/getInfo.html) 23:07:01 INFO - PROCESS | 4263 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 23:07:02 INFO - PROCESS | 4263 | __metrics Screen width/height:1600/1200 23:07:02 INFO - PROCESS | 4263 | colorDepth:24 23:07:02 INFO - PROCESS | 4263 | Browser inner width/height: 1024/697 23:07:02 INFO - PROCESS | 4263 | __metrics 23:07:02 INFO - PROCESS | 4263 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:07:03 INFO - TEST-INFO | 4263: exit 0 23:07:03 INFO - Browser initialized. 23:07:03 INFO - Running cycle 1/1 for kraken test... 23:07:03 INFO - TEST-INFO | started process 4384 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8D4TIT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:07:15 INFO - PROCESS | 4384 | RSS: Main: 150208512 23:07:15 INFO - PROCESS | 4384 | 23:07:17 INFO - PROCESS | 4384 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54013/tests/kraken/driver.html?testName=audio-beat-detection) 23:07:18 INFO - PROCESS | 4384 | RSS: Main: 151101440 23:07:18 INFO - PROCESS | 4384 | 23:07:20 INFO - PROCESS | 4384 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54013/tests/kraken/driver.html?testName=audio-dft) 23:07:21 INFO - PROCESS | 4384 | RSS: Main: 152121344 23:07:21 INFO - PROCESS | 4384 | 23:07:24 INFO - PROCESS | 4384 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54013/tests/kraken/driver.html?testName=audio-fft) 23:07:24 INFO - PROCESS | 4384 | RSS: Main: 146685952 23:07:24 INFO - PROCESS | 4384 | 23:07:27 INFO - PROCESS | 4384 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54013/tests/kraken/driver.html?testName=audio-oscillator) 23:07:27 INFO - PROCESS | 4384 | RSS: Main: 146472960 23:07:27 INFO - PROCESS | 4384 | 23:07:29 INFO - PROCESS | 4384 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54013/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:07:30 INFO - PROCESS | 4384 | RSS: Main: 146558976 23:07:30 INFO - PROCESS | 4384 | 23:07:33 INFO - PROCESS | 4384 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54013/tests/kraken/driver.html?testName=imaging-darkroom) 23:07:34 INFO - PROCESS | 4384 | RSS: Main: 148279296 23:07:34 INFO - PROCESS | 4384 | 23:07:37 INFO - PROCESS | 4384 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54013/tests/kraken/driver.html?testName=imaging-desaturate) 23:07:38 INFO - PROCESS | 4384 | RSS: Main: 149544960 23:07:38 INFO - PROCESS | 4384 | 23:07:40 INFO - PROCESS | 4384 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54013/tests/kraken/driver.html?testName=json-parse-financial) 23:07:41 INFO - PROCESS | 4384 | RSS: Main: 148000768 23:07:41 INFO - PROCESS | 4384 | 23:07:43 INFO - PROCESS | 4384 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54013/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:07:43 INFO - PROCESS | 4384 | RSS: Main: 148619264 23:07:43 INFO - PROCESS | 4384 | 23:07:45 INFO - PROCESS | 4384 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54013/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:07:46 INFO - PROCESS | 4384 | RSS: Main: 148299776 23:07:46 INFO - PROCESS | 4384 | 23:07:48 INFO - PROCESS | 4384 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54013/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:07:48 INFO - PROCESS | 4384 | RSS: Main: 149094400 23:07:48 INFO - PROCESS | 4384 | 23:07:51 INFO - PROCESS | 4384 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54013/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:07:51 INFO - PROCESS | 4384 | RSS: Main: 148267008 23:07:51 INFO - PROCESS | 4384 | 23:07:54 INFO - PROCESS | 4384 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54013/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:07:54 INFO - PROCESS | 4384 | RSS: Main: 148054016 23:07:54 INFO - PROCESS | 4384 | 23:07:56 INFO - PROCESS | 4384 | Cycle 1(1): loaded http://localhost:54013/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54013/tests/kraken/driver.html?testName=ai-astar) 23:07:56 INFO - PROCESS | 4384 | RSS: Main: 147738624 23:07:56 INFO - PROCESS | 4384 | 23:07:56 INFO - PROCESS | 4384 | __start_tp_report 23:07:56 INFO - PROCESS | 4384 | _x_x_mozilla_page_load 23:07:56 INFO - PROCESS | 4384 | _x_x_mozilla_page_load_details 23:07:56 INFO - PROCESS | 4384 | |i|pagename|runs| 23:07:56 INFO - PROCESS | 4384 | |0;ai-astar;111;109;112;112;111;122;110;112;111;112 23:07:56 INFO - PROCESS | 4384 | |1;audio-beat-detection;154;127;154;173;127;159;152;131;165;129 23:07:56 INFO - PROCESS | 4384 | |2;audio-dft;165;162;167;163;161;162;166;171;164;164 23:07:56 INFO - PROCESS | 4384 | |3;audio-fft;74;73;75;73;75;74;75;135;72;72 23:07:56 INFO - PROCESS | 4384 | |4;audio-oscillator;98;97;137;96;96;97;151;95;96;141 23:07:56 INFO - PROCESS | 4384 | |5;imaging-gaussian-blur;109;109;109;110;109;110;109;113;112;109 23:07:56 INFO - PROCESS | 4384 | |6;imaging-darkroom;148;146;146;146;146;146;147;147;147;146 23:07:56 INFO - PROCESS | 4384 | |7;imaging-desaturate;97;96;96;96;95;97;96;96;96;95 23:07:56 INFO - PROCESS | 4384 | |8;json-parse-financial;59;58;60;60;61;61;61;61;58;59 23:07:56 INFO - PROCESS | 4384 | |9;json-stringify-tinderbox;67;67;68;68;70;68;69;68;68;68 23:07:56 INFO - PROCESS | 4384 | |10;stanford-crypto-aes;84;87;86;95;88;85;93;87;86;87 23:07:56 INFO - PROCESS | 4384 | |11;stanford-crypto-ccm;131;118;132;121;129;117;123;118;121;117 23:07:56 INFO - PROCESS | 4384 | |12;stanford-crypto-pbkdf2;145;155;153;157;151;152;152;150;153;141 23:07:56 INFO - PROCESS | 4384 | |13;stanford-crypto-sha256-iterative;67;68;71;70;68;67;67;68;68;67 23:07:56 INFO - PROCESS | 4384 | __end_tp_report 23:07:56 INFO - PROCESS | 4384 | __start_cc_report 23:07:56 INFO - PROCESS | 4384 | _x_x_mozilla_cycle_collect,727 23:07:56 INFO - PROCESS | 4384 | __end_cc_report 23:07:56 INFO - PROCESS | 4384 | __startTimestamp1452150476924__endTimestamp 23:07:56 INFO - PROCESS | 4384 | 23:07:56 INFO - PROCESS | 4384 | ------- Summary: start ------- 23:07:56 INFO - PROCESS | 4384 | Number of tests: 14 23:07:56 INFO - PROCESS | 4384 | 23:07:56 INFO - PROCESS | 4384 | [#0] ai-astar Cycles:10 Average:112.20 Median:112.00 stddev:3.58 (3.2%) stddev-sans-first:3.77 23:07:56 INFO - PROCESS | 4384 | Values: 111.0 109.0 112.0 112.0 111.0 122.0 110.0 112.0 111.0 112.0 23:07:56 INFO - PROCESS | 4384 | 23:07:56 INFO - PROCESS | 4384 | [#1] audio-beat-detection Cycles:10 Average:147.10 Median:154.00 stddev:17.15 (11.1%) stddev-sans-first:18.01 23:07:56 INFO - PROCESS | 4384 | Values: 154.0 127.0 154.0 173.0 127.0 159.0 152.0 131.0 165.0 129.0 23:07:56 INFO - PROCESS | 4384 | 23:07:56 INFO - PROCESS | 4384 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.50 stddev:2.95 (1.8%) stddev-sans-first:3.13 23:07:56 INFO - PROCESS | 4384 | Values: 165.0 162.0 167.0 163.0 161.0 162.0 166.0 171.0 164.0 164.0 23:07:56 INFO - PROCESS | 4384 | 23:07:56 INFO - PROCESS | 4384 | [#3] audio-fft Cycles:10 Average:79.80 Median:74.00 stddev:19.43 (26.3%) stddev-sans-first:20.49 23:07:56 INFO - PROCESS | 4384 | Values: 74.0 73.0 75.0 73.0 75.0 74.0 75.0 135.0 72.0 72.0 23:07:56 INFO - PROCESS | 4384 | 23:07:56 INFO - PROCESS | 4384 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:96.00 stddev:22.77 (23.7%) stddev-sans-first:23.70 23:07:56 INFO - PROCESS | 4384 | Values: 98.0 97.0 137.0 96.0 96.0 97.0 151.0 95.0 96.0 141.0 23:07:56 INFO - PROCESS | 4384 | 23:07:56 INFO - PROCESS | 4384 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:109.50 stddev:1.45 (1.3%) stddev-sans-first:1.50 23:07:56 INFO - PROCESS | 4384 | Values: 109.0 109.0 109.0 110.0 109.0 110.0 109.0 113.0 112.0 109.0 23:07:56 INFO - PROCESS | 4384 | 23:07:56 INFO - PROCESS | 4384 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.50 23:07:56 INFO - PROCESS | 4384 | Values: 148.0 146.0 146.0 146.0 146.0 146.0 147.0 147.0 147.0 146.0 23:07:56 INFO - PROCESS | 4384 | 23:07:56 INFO - PROCESS | 4384 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 23:07:56 INFO - PROCESS | 4384 | Values: 97.0 96.0 96.0 96.0 95.0 97.0 96.0 96.0 96.0 95.0 23:07:56 INFO - PROCESS | 4384 | 23:07:56 INFO - PROCESS | 4384 | [#8] json-parse-financial Cycles:10 Average:59.80 Median:60.50 stddev:1.23 (2.0%) stddev-sans-first:1.27 23:07:56 INFO - PROCESS | 4384 | Values: 59.0 58.0 60.0 60.0 61.0 61.0 61.0 61.0 58.0 59.0 23:07:56 INFO - PROCESS | 4384 | 23:07:56 INFO - PROCESS | 4384 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.88 (1.3%) stddev-sans-first:0.83 23:07:56 INFO - PROCESS | 4384 | Values: 67.0 67.0 68.0 68.0 70.0 68.0 69.0 68.0 68.0 68.0 23:07:56 INFO - PROCESS | 4384 | 23:07:56 INFO - PROCESS | 4384 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:87.00 stddev:3.49 (4.0%) stddev-sans-first:3.42 23:07:56 INFO - PROCESS | 4384 | Values: 84.0 87.0 86.0 95.0 88.0 85.0 93.0 87.0 86.0 87.0 23:07:56 INFO - PROCESS | 4384 | 23:07:56 INFO - PROCESS | 4384 | [#11] stanford-crypto-ccm Cycles:10 Average:122.70 Median:122.00 stddev:5.87 (4.8%) stddev-sans-first:5.40 23:07:56 INFO - PROCESS | 4384 | Values: 131.0 118.0 132.0 121.0 129.0 117.0 123.0 118.0 121.0 117.0 23:07:56 INFO - PROCESS | 4384 | 23:07:56 INFO - PROCESS | 4384 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.90 Median:152.50 stddev:4.70 (3.1%) stddev-sans-first:4.48 23:07:56 INFO - PROCESS | 4384 | Values: 145.0 155.0 153.0 157.0 151.0 152.0 152.0 150.0 153.0 141.0 23:07:56 INFO - PROCESS | 4384 | 23:07:56 INFO - PROCESS | 4384 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:1.37 (2.0%) stddev-sans-first:1.39 23:07:56 INFO - PROCESS | 4384 | Values: 67.0 68.0 71.0 70.0 68.0 67.0 67.0 68.0 68.0 67.0 23:07:56 INFO - PROCESS | 4384 | -------- Summary: end -------- 23:07:56 INFO - PROCESS | 4384 | 23:07:57 INFO - TEST-INFO | 4384: exit 0 23:07:58 INFO - TEST-OK | kraken | took 59987ms 23:07:58 INFO - TEST-START | v8_7 23:07:58 INFO - operating with platform_type : linux_ 23:07:58 INFO - Initialising browser for v8_7 test... 23:07:58 INFO - TEST-INFO | started process 4670 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpExmWHT/profile http://localhost:54013/getInfo.html) 23:08:01 INFO - PROCESS | 4670 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 23:08:02 INFO - PROCESS | 4670 | __metrics Screen width/height:1600/1200 23:08:02 INFO - PROCESS | 4670 | colorDepth:24 23:08:02 INFO - PROCESS | 4670 | Browser inner width/height: 1024/697 23:08:02 INFO - PROCESS | 4670 | __metrics 23:08:02 INFO - PROCESS | 4670 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:08:03 INFO - TEST-INFO | 4670: exit 0 23:08:03 INFO - Browser initialized. 23:08:03 INFO - Running cycle 1/1 for v8_7 test... 23:08:03 INFO - TEST-INFO | started process 4790 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpExmWHT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:08:15 INFO - PROCESS | 4790 | RSS: Main: 150134784 23:08:15 INFO - PROCESS | 4790 | 23:08:36 INFO - PROCESS | 4790 | Cycle 1(1): loaded http://localhost:54013/tests/v8_7/run.html (next: http://localhost:54013/tests/v8_7/run.html) 23:08:36 INFO - PROCESS | 4790 | RSS: Main: 146624512 23:08:36 INFO - PROCESS | 4790 | 23:08:36 INFO - PROCESS | 4790 | __start_tp_report 23:08:36 INFO - PROCESS | 4790 | _x_x_mozilla_page_load 23:08:36 INFO - PROCESS | 4790 | _x_x_mozilla_page_load_details 23:08:36 INFO - PROCESS | 4790 | |i|pagename|runs| 23:08:36 INFO - PROCESS | 4790 | |0;Richards;170.32873445750297 23:08:36 INFO - PROCESS | 4790 | |1;DeltaBlue;189.60940462646948 23:08:36 INFO - PROCESS | 4790 | |2;Encrypt;280.0336040324839 23:08:36 INFO - PROCESS | 4790 | |3;Decrypt;5251.308900523561 23:08:36 INFO - PROCESS | 4790 | |4;RayTrace;1079.913606911447 23:08:36 INFO - PROCESS | 4790 | |5;Earley;702.2471910112359 23:08:36 INFO - PROCESS | 4790 | |6;Boyer;12243.90243902439 23:08:36 INFO - PROCESS | 4790 | |7;RegExp;25550 23:08:36 INFO - PROCESS | 4790 | |8;Splay;667.5567423230974 23:08:36 INFO - PROCESS | 4790 | |9;NavierStokes;4845.410628019324 23:08:36 INFO - PROCESS | 4790 | __end_tp_report 23:08:36 INFO - PROCESS | 4790 | __startTimestamp1452150516659__endTimestamp 23:08:36 INFO - PROCESS | 4790 | 23:08:36 INFO - PROCESS | 4790 | ------- Summary: start ------- 23:08:36 INFO - PROCESS | 4790 | Number of tests: 10 23:08:36 INFO - PROCESS | 4790 | 23:08:36 INFO - PROCESS | 4790 | [#0] Richards Cycles:1 Average:170.33 Median:170.33 stddev:0.00 (0.0%) 23:08:36 INFO - PROCESS | 4790 | Values: 170.3 23:08:36 INFO - PROCESS | 4790 | 23:08:36 INFO - PROCESS | 4790 | [#1] DeltaBlue Cycles:1 Average:189.61 Median:189.61 stddev:0.00 (0.0%) 23:08:36 INFO - PROCESS | 4790 | Values: 189.6 23:08:36 INFO - PROCESS | 4790 | 23:08:36 INFO - PROCESS | 4790 | [#2] Encrypt Cycles:1 Average:280.03 Median:280.03 stddev:0.00 (0.0%) 23:08:36 INFO - PROCESS | 4790 | Values: 280.0 23:08:36 INFO - PROCESS | 4790 | 23:08:36 INFO - PROCESS | 4790 | [#3] Decrypt Cycles:1 Average:5251.31 Median:5251.31 stddev:0.00 (0.0%) 23:08:36 INFO - PROCESS | 4790 | Values: 5251.3 23:08:36 INFO - PROCESS | 4790 | 23:08:36 INFO - PROCESS | 4790 | [#4] RayTrace Cycles:1 Average:1079.91 Median:1079.91 stddev:0.00 (0.0%) 23:08:36 INFO - PROCESS | 4790 | Values: 1079.9 23:08:36 INFO - PROCESS | 4790 | 23:08:36 INFO - PROCESS | 4790 | [#5] Earley Cycles:1 Average:702.25 Median:702.25 stddev:0.00 (0.0%) 23:08:36 INFO - PROCESS | 4790 | Values: 702.2 23:08:36 INFO - PROCESS | 4790 | 23:08:36 INFO - PROCESS | 4790 | [#6] Boyer Cycles:1 Average:12243.90 Median:12243.90 stddev:0.00 (0.0%) 23:08:36 INFO - PROCESS | 4790 | Values: 12243.9 23:08:36 INFO - PROCESS | 4790 | 23:08:36 INFO - PROCESS | 4790 | [#7] RegExp Cycles:1 Average:25550.00 Median:25550.00 stddev:0.00 (0.0%) 23:08:36 INFO - PROCESS | 4790 | Values: 25550.0 23:08:36 INFO - PROCESS | 4790 | 23:08:36 INFO - PROCESS | 4790 | [#8] Splay Cycles:1 Average:667.56 Median:667.56 stddev:0.00 (0.0%) 23:08:36 INFO - PROCESS | 4790 | Values: 667.6 23:08:36 INFO - PROCESS | 4790 | 23:08:36 INFO - PROCESS | 4790 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 23:08:36 INFO - PROCESS | 4790 | Values: 4845.4 23:08:36 INFO - PROCESS | 4790 | -------- Summary: end -------- 23:08:36 INFO - PROCESS | 4790 | 23:08:37 INFO - TEST-INFO | 4790: exit 0 23:08:37 INFO - TEST-OK | v8_7 | took 39582ms 23:08:37 INFO - SUITE-END | took 1210s 23:08:37 INFO - Completed test suite (00:20:10) 23:08:37 INFO - Working with test: dromaeo_css 23:08:37 INFO - Generating results file: dromaeo_css 23:08:37 INFO - Working with test: kraken 23:08:37 INFO - Generating results file: kraken 23:08:37 INFO - javascript benchmark 23:08:37 INFO - Working with test: v8_7 23:08:37 INFO - Generating results file: v8_7 23:08:37 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:08:37 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 23:08:37 INFO - process_Request line: dromaeo_css 6719.65 graph.html#tests=[[72,64,43]] 23:08:37 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:08:37 INFO - process_Request line: kraken 1523.80 graph.html#tests=[[232,64,43]] 23:08:37 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:08:37 INFO - process_Request line: v8_7 21053.95 graph.html#tests=[[230,64,43]] 23:08:37 INFO - RETURN: dromaeo_css: 6719.65 23:08:37 INFO - RETURN: kraken: 1523.80 23:08:37 INFO - RETURN: v8_7: 21053.95 23:08:37 INFO - javascript benchmark 23:08:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3207.342494788568, 3270.3622793555237, 3272.3782481328562, 3312.917177070574, 3320.053784671368, 5212.973935130319, 5252.395974462938, 5277.234800953859, 5337.332833395825, 5337.653052551586, 5182.248573956774, 5227.817026404076, 5264.578833693305, 5279.155335146377, 5309.62832601718, 4821.493743156971, 4826.3725715657, 4947.356843610326, 5012.949870501303, 5021.723805190713, 4911.0177964407085, 4929.3591833061655, 4934.1365261079345, 4989.525995030466, 5053.5451809337155, 4745.074710431467, 4765.618750499952, 4826.300186472942, 4880.829170979035, 4912.459629440758, 4838.927416088762, 4849.806007759686, 4851.175300198975, 4852.951470485285, 4897.04507621014, 4788.664793464459, 4806.543378379049, 4862.513748625144, 4877.170880950247, 4939.2838038484215, 5213.478652134794, 5225.4513276105845, 5271.789128434858, 5304.549113325372, 5315.0432922074015, 5711.228984087178, 5739.3399759027825, 5768.250127483442, 5776.942230577724, 5833.7374818133285, 5671.886562268732, 5764.221830052931, 5852.356240813507, 5857.824265272048, 5869.325027621835, 5359.705216213107, 5447.809326673548, 5453.754581043862, 5475.233467314619, 5479.5342395896, 5802.129680547867, 5819.330776960619, 5830.504407125357, 5830.650160990354, 5839.562032847553, 5613.326400831927, 5624.803131890364, 5643.661380317194, 5647.519960803378, 5660.773569057192, 5529.115341545334, 5651.491365777099, 5653.180288858092, 5656.660600363992, 5743.310802703702, 5586.1062230043, 5597.860053498695, 5635.464630860061, 5637.774489020475, 5658.547316214693, 5474.7810087596845, 5572.08060669993, 5647.858803529944, 5652.689102099424, 5667.319921609434, 4356.825726970949, 4359.106383191438, 4361.934570981438, 4365.563443655609, 4405.140997505519, 3951.209758048402, 3980.5621381647998, 3995.5005624296964, 3996.86010989614, 4009.7794621296107, 5296.205569164579, 5329.733513324319, 5369.194620806832, 5450.863728406743, 5485.6434331768305, 5805.071188609802, 5829.941700583025, 5834.504067154339, 5835.183074369592, 5842.883142337129, 5468.48049435303, 5478.424765399655, 5478.479544443271, 5488.1493368527945, 5507.697076660742, 4774.904501910012, 4869.0, 4947.158982972831, 4959.752012399438, 5053.84838454847, 5922.555808314393, 5939.495142912814, 5942.1383899335215, 5944.6730429826775, 5972.044472884318, 5728.713564321684, 5729.799457018984, 5744.281964754406, 5747.281589801275, 5750.48245657876, 5915.792947246998, 6025.6083354581815, 6027.939720602738, 6105.328413874559, 6125.326214116532, 5651.4348565143155, 5658.236138121301, 5673.5461163107675, 5674.631148975303, 5686.886262274648, 5682.261306030189, 5699.4300569944335, 5754.827355179351, 5765.365809760839, 5767.5385969121535, 5407.242985981887, 5532.75102620375, 5663.122216056518, 5726.885462290814, 5777.971110144423, 5567.415421380859, 5602.411746766694, 5610.915836262541, 5611.915821262766, 5618.52242559387, 5445.428230035947, 5518.668879867221, 5521.5306698931045, 5522.861928451821, 5529.474699903502, 5556.722163891708, 5612.943870561242, 5716.571257155813, 5728.885422291614, 5734.426557344399, 5486.643368181056, 5509.118541033416, 5511.834644960658, 5515.365732940602, 5524.502794748492], "unit": "score", "name": "dojo.html", "value": 5292.473959708278}, {"lowerIsBetter": false, "replicates": [522.5349438999291, 539.6950722841594, 541.7535021565188, 541.7616248850508, 556.3713004305134, 34963.300733985336, 35922.640773592255, 36031.459528107065, 36044.81977590115, 36093.27813443733, 38522.807385963104, 39052.0, 39274.0, 39281.0, 39351.21297574054, 8361.205685459872, 8478.533680647563, 8495.36284778641, 8507.489550626951, 8511.829763404729, 8302.958485207566, 8381.287590554779, 8407.621657025418, 8416.915830841705, 8418.915810841905, 8592.699255526059, 8620.482771033758, 8634.913650863473, 8644.96260448747, 8692.13078692132, 8561.101084386111, 8571.185737354972, 8629.827403451896, 8639.913600863974, 8656.783580410509, 8436.535990520519, 8510.74467765968, 8518.701845435442, 8577.142285771435, 8578.656853725906, 38753.224935501414, 39400.80299598513, 39492.60507394918, 39524.60475395238, 39588.20823583541, 2704.6619172603423, 2713.226730381851, 2727.3454370951026, 2823.4917714811327, 2871.224769312295, 28360.716392836013, 29238.122856314345, 29257.561136582968, 29259.268518287212, 29497.41005179906, 3874.302625527404, 3875.534935807693, 3895.162540053902, 3909.7458665186955, 3957.525096988351, 192769.0, 193193.0, 193277.0, 193420.0, 194573.02713486482, 40692.389614155814, 41219.7939010303, 54375.728121359934, 54716.45283547193, 54763.72618136964, 39225.41161882574, 39403.80298098491, 39597.80201099034, 39751.602483975366, 39854.402183967264, 14468.493602724066, 14470.131792092508, 14488.203148826706, 14528.346224419714, 14555.12669239849, 11165.49755260999, 11193.72015699614, 11207.831882521768, 11211.159163062639, 11214.943925280322, 13406.530771422953, 13506.459741610226, 13773.311334433238, 13863.584092477242, 13921.303934803422, 5643.943560564342, 5715.657060576295, 5728.198052272685, 5778.393268706809, 5778.451047150514, 889.9065598112105, 950.3632566180537, 956.7560272130562, 981.676046904534, 1002.9398236105857, 27795.44409111847, 28078.71921280802, 28085.71914280872, 28175.71824281772, 28343.57484637732, 1005.1707341443339, 1021.2748948246827, 1052.55792567122, 1053.0838170791308, 1055.767731099157, 13408.128471649312, 13544.45822167122, 13823.0, 13862.861371386358, 13902.860971390359, 363342.0, 373367.0, 374976.0, 375137.0, 375459.0, 49778.25332620014, 50123.74938125359, 50264.24603630949, 50357.0, 50467.74766126219, 1338.4579245405625, 1360.3538319298254, 1360.53741727813, 1363.5023216525897, 1477.9506550349372, 25524.23427297184, 26438.0, 26477.0, 26577.601335980362, 26670.733292666824, 46869.2969605463, 47749.76125119352, 47876.0, 48167.0, 48507.27239091346, 231272.0, 235179.0, 235377.0, 236498.0, 236693.0, 36113.638863612076, 36830.63169368272, 40659.0, 41170.176596468504, 41666.79166604148, 37861.0, 38493.61506385012, 38745.22509549737, 38957.41563876601, 39200.80399597984, 32834.34331313408, 32988.1752956178, 33246.20184414564, 33300.83349583237, 33821.661783382835, 34580.82709586436, 34823.0, 35466.64533354634, 35823.64176358203, 35865.744698935414, 37061.44407833831, 37136.25727485381, 37736.433953491265, 37823.243535129695, 37896.242075158894, 27864.16407507697, 29027.83888644515, 30667.386652266385, 30985.690143099182, 31252.531212032292, 24405.755942440348, 25301.240962771146, 26147.0, 26256.606150908134, 26291.342716432242], "unit": "score", "name": "ext.html", "value": 17206.22207227777}, {"lowerIsBetter": false, "replicates": [359.12015561873403, 362.7297663240884, 363.19552191894945, 365.05450882215064, 367.3571250311955, 16423.917880410598, 16986.405475808348, 17068.658626827473, 17715.114244287768, 17777.644447111066, 14688.412463501474, 15639.0, 15787.684246315066, 15860.206989650529, 15895.761563576556, 4872.244802055687, 4985.725785081819, 5010.69935803853, 5018.447970723236, 5019.52314530119, 4902.681325713835, 4946.332245146913, 4948.1093403187415, 4953.4798846121175, 4960.479149689285, 5072.188449848025, 5094.439611642735, 5235.267062611238, 5249.8950020999555, 5291.391489978644, 5053.646244762868, 5130.615203859688, 5160.509751573613, 5190.039842629126, 5191.013707395602, 5039.319691841628, 5039.72281524516, 5040.6471546991725, 5041.8487445376695, 5046.293518907356, 12351.38243087842, 13272.070955033152, 18256.178471968793, 18786.342478013205, 18850.811491885044, 1951.375559820858, 2000.7198992141111, 2063.7626672932656, 2071.275053731197, 2174.9782502174935, 9238.676646317346, 9269.44383337002, 9423.151916327495, 9497.857532137023, 9671.274654400948, 1784.4379020608467, 1796.4969808453654, 1804.5578833185823, 1833.6424397242542, 1892.8485721142276, 56159.71920140414, 56311.71844140753, 56645.0, 58156.41843581595, 60151.0, 10269.845952310721, 10300.948495257626, 10306.845397319046, 10368.481575921174, 10429.0, 13185.208887466782, 13238.139520931109, 13283.667908302177, 13341.533046343331, 13343.132696374705, 7405.62971851416, 7509.324160825552, 7559.886601700979, 7763.728269510653, 7852.725154619561, 7652.081750190013, 7696.307332340116, 7733.0, 7743.612819359009, 7750.14748377678, 4327.307630779123, 4348.826046958086, 4406.691531592822, 4412.713173643703, 4505.301678239878, 1803.2786885245744, 1851.296507327234, 1895.3366321787264, 1905.352180258691, 1911.9330823421114, 405.5032585083308, 814.4339683919619, 985.6550207427487, 995.2784231432298, 1025.7844454321503, 10330.535125919352, 10491.16070714341, 10605.734856628646, 10663.34288919357, 10670.0, 445.67911104005066, 448.6679856905931, 450.8286850996666, 451.5777747805812, 455.180674785385, 5886.764529418861, 5902.675352855634, 5979.581429299994, 9903.801923961624, 10034.949825250973, 550622.0, 569808.0, 587188.0, 589721.0, 590240.0, 38103.80948095242, 38652.420213696816, 60367.69816150891, 77077.61461192658, 80007.59996200098, 1114.9944250278859, 1135.27909777292, 1144.0733006264952, 1144.3305666185208, 1147.9598214062469, 14792.186429746467, 14847.257637117886, 14937.274823101732, 15006.549803505912, 15404.075755454709, 32109.839450802596, 32229.51655725213, 33143.66856331406, 33496.1625959353, 33643.49534756932, 41623.791881041616, 42621.573784263004, 44148.0, 44386.11227775491, 44450.55549444464, 9566.139047485482, 9574.90425095768, 9745.171660408945, 9785.559649815634, 9874.753131171778, 11560.884391155982, 13798.724025519634, 17440.040797756246, 17521.82478175253, 17597.824021759618, 12615.495380185057, 13320.533781317607, 14056.367463464374, 14474.901139334948, 14778.77831832502, 12498.12513124109, 12596.307203103917, 14443.205623690797, 14571.271436427924, 14774.33515491827, 13637.11358761717, 13685.384157713126, 14178.858211417753, 14200.360983755549, 14288.714225715636, 9634.614615415305, 9775.169110625677, 9891.159251463707, 10007.799844002933, 10087.486876968513, 14699.853001469848, 14753.631159221106, 15145.621359466102, 15201.847981520043, 15220.162891041098], "unit": "score", "name": "jquery.html", "value": 8270.259280552249}, {"lowerIsBetter": false, "replicates": [1471.977920331195, 1476.3061361160258, 1633.0446688687118, 1755.4821327708325, 1789.7762779652535, 7216.891746623798, 7273.2726727327245, 7332.0, 7422.814429639262, 7461.813454663623, 7193.388561972226, 7202.315780000905, 7257.0, 7294.81762955925, 7297.963510182455, 2165.8592191507582, 2170.663547150194, 2182.334388011656, 2186.2238905188588, 2191.5288213034196, 2139.251262058283, 2163.4266919266406, 2241.081156725743, 2246.3485589179118, 2257.559775843711, 2181.454636340915, 2214.8560343577697, 2220.655798351258, 2224.7775222477785, 2256.6615007748887, 2230.743464501587, 2243.1588154442084, 2266.5240299537118, 2274.9886250568807, 2279.988600057006, 2174.8803815790125, 2180.4875854174256, 2194.08945287707, 2195.835312351564, 2197.450637340665, 7162.606056666881, 7229.09636295463, 7261.3101755333155, 7302.087239095114, 7304.342609165147, 4303.956960430387, 4389.561043895616, 4394.274944634131, 4395.406620106309, 4401.471823381183, 2855.300451389423, 2921.269682579355, 2939.5884576159356, 2981.329200929795, 2987.312918028844, 870.1037930931151, 880.1550511508959, 894.1728900766765, 924.2790623313758, 928.4893308680199, 9546.0, 9546.522673866348, 9578.377405468622, 9581.898081720552, 9609.759756006086, 3797.487339209227, 3797.8480860765812, 3808.1431677872256, 3863.30460517104, 3955.0310174007554, 7864.21357864209, 7877.487963282369, 7898.644560994769, 7906.881396779053, 7920.207979202149, 4392.3411488277015, 4397.274449715761, 4405.911881762411, 4419.9337009944875, 4424.159409712144, 3932.4691166692132, 3933.3903244997073, 3975.0261186009034, 3975.204959008152, 3983.8008099594904, 3341.515480255398, 3357.244619960489, 3364.2430453147845, 3377.155711072232, 3383.424817780983, 1048.0881632979203, 1049.4175732468552, 1049.454283772434, 1056.434807378049, 1077.9892201078046, 958.9212136346611, 963.0658261486348, 1020.3418794877263, 1043.8434234864678, 1219.6341097670663, 6604.3725846044545, 6683.4987375947, 6702.095217145623, 6712.295209002984, 6719.193696756322, 1042.7601651620018, 1051.5688567687212, 1061.976933940844, 1073.0771536478621, 1118.664400679809, 5452.372977107683, 5505.642133261325, 5545.889082218414, 5547.389787123413, 5558.749856256478, 8302.750917472486, 8320.417570770109, 8349.499030058094, 8425.747227583182, 8438.0, 8331.250187483156, 8414.410991230556, 8420.53687047206, 8434.873476897852, 8451.746447606582, 6404.935950640527, 6422.2614399344675, 6505.577137486143, 6567.0, 6597.8350541235895, 6816.0457535946, 6863.519553631198, 6879.449644028566, 6899.689513971783, 6939.618320992394, 7319.597422141834, 7524.05949256343, 7556.65995030236, 7665.463417560717, 7917.247861453153, 7479.214682458263, 7718.768436946901, 8024.959875200587, 8035.0, 8120.593970301343, 6304.148939893055, 6307.653079080511, 6352.36476352361, 6371.299157092809, 6409.198850143732, 6962.303769622998, 6987.475939304471, 6989.720411183495, 6990.300969902969, 6990.440764738911, 6271.0, 6463.903041454476, 6584.176977877765, 6693.062971183941, 6789.762358317435, 6110.816675499742, 6179.876402472015, 6428.260750013808, 6442.0, 6539.149910511603, 6336.493080553637, 6366.713497892699, 6422.518311126591, 6533.575317604341, 6567.737290508326, 5525.143602741421, 5525.861853453535, 5526.309211348582, 5541.030319694118, 5548.778048878161, 5533.723313834373, 5576.637518561281, 5609.046462101371, 5610.5231055360755, 5616.550675945833], "unit": "score", "name": "mootools.html", "value": 4161.905340979269}, {"lowerIsBetter": false, "replicates": [334.24794213020704, 334.5550417944134, 339.4365353513167, 342.69671340863334, 344.0675768666914, 6115.327313995463, 6121.143039974396, 6140.7850725224625, 6167.969160154198, 6246.187995560582, 6013.278406591205, 6087.147799308101, 6120.632762034281, 6131.693415329238, 6147.907781383283, 4708.058388322332, 4709.434867815867, 4714.552117548845, 4721.952780472194, 4726.1020406122725, 4717.858464246078, 4719.386479757643, 4720.221163508017, 4722.433308003045, 4723.598494127986, 4479.350494178342, 4592.885177870563, 4649.302604609302, 4651.88370290742, 4692.5072867348945, 4605.194091034055, 4607.470140933785, 4628.8148474061, 4629.560191781792, 4645.0, 3942.2115576884453, 4033.838646454138, 4043.8989025274605, 4045.110075783323, 4050.392441133824, 5829.7376618052285, 5848.064309710426, 5874.295084589877, 5882.147088672162, 5907.172995780594, 5405.891882162335, 5415.10650742627, 5423.83728488146, 5426.240326354314, 5432.782688692448, 6499.93500064998, 6504.804855854332, 6509.93490065098, 6515.087887695679, 6529.379708927644, 4383.8684839454545, 4523.819047238107, 4524.886877828048, 4526.185286648402, 4536.115457485792, 6749.628770417625, 6814.216365118025, 6815.148106486689, 6844.657767111675, 6861.828454288633, 4609.516000819865, 4630.745309008037, 4638.281066434708, 4639.072185562901, 4641.651876109306, 4618.214903466419, 4648.48866624671, 4685.180093483695, 4696.647751418657, 4722.386089808371, 5413.0, 5418.187271909166, 5420.34955805298, 5427.782888684487, 5445.992491389105, 6563.606183628997, 6565.671716414256, 6567.573107747981, 6570.178727659043, 6581.901271480931, 1628.4137710424238, 1648.736202207641, 1649.8762592805347, 1650.414102993444, 1656.8011838579448, 1094.3269889018197, 1103.961361352365, 1112.7941330853819, 1116.1963386361806, 1122.938238396896, 6247.312795592481, 6250.499960003189, 6253.843653908689, 6260.311365749764, 6263.154474145932, 6730.226024007204, 6744.22441419243, 6745.628990405575, 6754.729810807611, 6756.560823546453, 6071.058985857199, 6207.410296021871, 6238.313785483593, 6250.343713910065, 6251.468625166821, 3646.0338010426726, 3660.908477288036, 3664.0656632558525, 3664.4686520454384, 3669.2111196092433, 6910.481713871379, 7060.18807837095, 7072.1513418389095, 7075.2570980047385, 7087.114110736158, 6966.12923384577, 6976.790696279119, 6991.7902462926195, 7004.964975175193, 7013.719451221894, 6938.861222775517, 7033.437325013987, 7056.329648683367, 7094.68073936674, 7094.92905070953, 6755.2231493378895, 6763.188417389944, 6766.15423072116, 6778.4577233822165, 6785.2536221016635, 6637.568558043712, 6646.0, 6675.098861653809, 6694.523026480233, 6697.129373181455, 6912.930870691229, 6990.300969902969, 7065.116860392451, 7075.752348667772, 7085.0, 4506.977465112785, 4535.705179163344, 4544.0, 4548.704334218265, 4559.133764584718, 6769.830754231184, 6790.524663273523, 6792.0, 6813.454923606, 6818.749812561942, 6518.087467754423, 6536.7712130075215, 6580.144581204413, 6621.437177839744, 6632.734690612321, 6530.281669016499, 6574.145361103026, 6577.704003319766, 6580.901286480611, 6584.374484423972, 6436.806895792946, 6466.515011374072, 6481.513886458629, 6487.124238227968, 6490.902636460552, 6556.082148499309, 6600.174978127734, 6613.933860661332, 6635.933640663531, 6653.63405012729, 6444.548881578432, 6473.320301368289, 6483.546151769519, 6486.837829054122, 6489.448396886318], "unit": "score", "name": "prototype.html", "value": 4926.130992268523}, {"lowerIsBetter": false, "replicates": [694.8714487819753, 697.320112889932, 769.3114662377175, 793.8293266947605, 834.2075028722713, 11507.504024476817, 11652.0, 11717.7656446871, 11809.881901180986, 11843.644690659294, 11298.943505282463, 11861.110416718737, 11866.466009029593, 11870.406479676025, 11892.04863610909, 655.1941112431712, 663.9502037347219, 756.3608750605729, 772.069656064441, 784.8940393046922, 749.9962500187492, 777.2344240922715, 783.0329543014373, 784.9332806711436, 787.0948409329288, 789.9802504937394, 826.7643721539363, 839.4249938791947, 839.7648658375665, 840.1598401598402, 788.2117882117882, 811.411726498287, 820.6471217376526, 822.3955392786297, 828.7969447485344, 580.5732786401991, 593.6200831467821, 617.0528239152878, 617.9073139029136, 619.1208483952798, 11495.310281383145, 11518.193726439153, 11543.94228028863, 11563.53745850165, 11586.768264634744, 10933.671989840317, 11224.438778061065, 11637.476313565825, 11793.705157371134, 11978.221415607957, 9319.90680093204, 9363.110504502061, 9379.202767764747, 9437.76405589859, 9590.08894155054, 3535.6287589803214, 3546.379383607884, 3554.0, 3564.1624218308675, 3666.2850744104912, 43127.0, 43464.78267608673, 43471.34792978108, 43508.60702661352, 43564.128717425476, 9337.439753614804, 9797.216222702167, 9833.901660983442, 10215.23385746072, 10260.179185665278, 17894.194761235776, 17900.820991789915, 17931.910340448474, 18016.90991545034, 18025.549361266072, 6811.659417029129, 6986.476014298948, 7017.543859649107, 7077.681504332318, 7365.300296471826, 4008.8797336079965, 4119.134981653886, 4132.91734165315, 4176.1230141669985, 4225.746455212636, 2879.2226098953165, 2921.255079954598, 2923.72224638659, 2930.633670791151, 2955.349823038928, 468.10124560843263, 476.3402687278145, 478.2014036558955, 504.50054446098096, 506.20525774533627, 556.9944300557023, 606.918066061076, 660.6069388713707, 664.8271449423088, 684.4626967830229, 7633.313001829862, 8100.149484304181, 8105.1489593593005, 8301.58492075406, 8332.66669333232, 521.1713375732528, 610.9796639611859, 615.9199304090529, 655.505093654288, 660.425429876011, 3688.889333320005, 3752.718546108998, 3768.8869333920024, 3819.388897776398, 3821.560520540118, 55198.724006380515, 58229.4177058224, 59720.0, 59760.70119649374, 59879.0, 44165.337519937224, 44188.24399925978, 44989.55010449919, 44996.0, 46767.0, 45652.54347456549, 45687.77156114265, 46345.76827115843, 46379.30431043537, 46708.29937550939, 8218.465799722999, 8394.790130246793, 8460.619272132892, 8494.0, 8669.566521674018, 33399.83300083484, 34020.48969265413, 34524.0, 34610.134746631535, 34811.651883481856, 40745.59254407418, 41894.0, 44093.33859992038, 44244.778776105915, 44584.0, 10433.582656693647, 10465.0, 10506.737331566772, 10534.209934255116, 10747.516361763583, 11228.66314010581, 11539.8269025963, 11557.422128893353, 11693.181477296508, 12076.577319793765, 10439.478026098817, 10546.894531054591, 10663.146948244277, 11034.889651103707, 11112.833307500556, 10430.895691042992, 10467.738306542398, 10537.209709271681, 10538.367697938149, 11228.214025018171, 10757.085647720032, 10772.9765672261, 11140.610078647209, 11159.832602510807, 11269.66191014271, 9081.77295567616, 9207.125323094295, 9387.624495020124, 9420.481873497023, 9686.806263874823, 8798.027839338578, 9098.52246216436, 9140.954295228481, 9166.450012999241, 9185.357025008185], "unit": "score", "name": "yui.html", "value": 5961.8502382395245}], "name": "dromaeo_css", "value": 6719.650138278794}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 109.0, 112.0, 112.0, 111.0, 122.0, 110.0, 112.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.2}, {"lowerIsBetter": true, "replicates": [154.0, 127.0, 154.0, 173.0, 127.0, 159.0, 152.0, 131.0, 165.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 147.1}, {"lowerIsBetter": true, "replicates": [165.0, 162.0, 167.0, 163.0, 161.0, 162.0, 166.0, 171.0, 164.0, 164.0], "unit": "score", "name": "audio-dft", "value": 164.5}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 75.0, 73.0, 75.0, 74.0, 75.0, 135.0, 72.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.8}, {"lowerIsBetter": true, "replicates": [98.0, 97.0, 137.0, 96.0, 96.0, 97.0, 151.0, 95.0, 96.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 110.4}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 113.0, 112.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 96.0, 95.0, 97.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [59.0, 58.0, 60.0, 60.0, 61.0, 61.0, 61.0, 61.0, 58.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 59.8}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 68.0, 70.0, 68.0, 69.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [84.0, 87.0, 86.0, 95.0, 88.0, 85.0, 93.0, 87.0, 86.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.8}, {"lowerIsBetter": true, "replicates": [131.0, 118.0, 132.0, 121.0, 129.0, 117.0, 123.0, 118.0, 121.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.7}, {"lowerIsBetter": true, "replicates": [145.0, 155.0, 153.0, 157.0, 151.0, 152.0, 152.0, 150.0, 153.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.9}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 71.0, 70.0, 68.0, 67.0, 67.0, 68.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.1}], "name": "kraken", "value": 1523.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [170.32873445750297], "unit": "score", "name": "Richards", "value": 207.25804199999993}, {"lowerIsBetter": false, "replicates": [189.60940462646948], "unit": "score", "name": "DeltaBlue", "value": 348.7063319999999}, {"lowerIsBetter": false, "replicates": [280.0336040324839], "unit": "score", "name": "Encrypt", "value": 950.5323509999997}, {"lowerIsBetter": false, "replicates": [5251.308900523561], "unit": "score", "name": "Decrypt", "value": 50.68850548354939}, {"lowerIsBetter": false, "replicates": [1079.913606911447], "unit": "score", "name": "RayTrace", "value": 685.2298140000004}, {"lowerIsBetter": false, "replicates": [702.2471910112359], "unit": "score", "name": "Earley", "value": 949.0433120000004}, {"lowerIsBetter": false, "replicates": [12243.90243902439], "unit": "score", "name": "Boyer", "value": 54.4322370517928}, {"lowerIsBetter": false, "replicates": [25550.0], "unit": "score", "name": "RegExp", "value": 35.65499021526421}, {"lowerIsBetter": false, "replicates": [667.5567423230974], "unit": "score", "name": "Splay", "value": 122.07351800000004}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 21053.951024237384}]} 23:08:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21053.95"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1523.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6719.65"}}} 23:08:37 INFO - Return code: 0 23:08:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:08:37 INFO - # TBPL SUCCESS # 23:08:37 INFO - Running post-action listener: _resource_record_post_action 23:08:37 INFO - Running post-run listener: _resource_record_post_run 23:08:39 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 0; Write bytes: 559792128; Read time: 0; Write time: 506064 23:08:39 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 238010368; Read time: 0; Write time: 246728 23:08:39 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 320901120; Read time: 0; Write time: 259288 23:08:39 INFO - Running post-run listener: _upload_blobber_files 23:08:39 INFO - Blob upload gear active. 23:08:39 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:08:39 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 23:08:39 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'] 23:08:39 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 23:08:39 INFO - (blobuploader) - INFO - Open directory for files ... 23:08:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:08:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:08:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:08:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:08:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:08:40 INFO - (blobuploader) - INFO - Done attempting. 23:08:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:08:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:08:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:08:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:08:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:08:41 INFO - (blobuploader) - INFO - Done attempting. 23:08:41 INFO - (blobuploader) - INFO - Iteration through files over. 23:08:41 INFO - Return code: 0 23:08:41 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:08:41 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:08:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec318dd62b174a77adc4f5c9b84d5ac655ab9a9f9f208b3551cf7f02ca5b9c9ddf821f870d8d133452ea469ccbe96422d58d0cd9ee344dad4c8bc7bb1895f290", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dfabb915afb8a2eda978b76da1d52192592efbe310584fb605f0f4d133e7202d0c807721c37ca3eb9823d0024ef4b3582401ae1e699cfc08e49ec773db9bab0f"} 23:08:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:08:41 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:08:41 INFO - Contents: 23:08:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec318dd62b174a77adc4f5c9b84d5ac655ab9a9f9f208b3551cf7f02ca5b9c9ddf821f870d8d133452ea469ccbe96422d58d0cd9ee344dad4c8bc7bb1895f290", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dfabb915afb8a2eda978b76da1d52192592efbe310584fb605f0f4d133e7202d0c807721c37ca3eb9823d0024ef4b3582401ae1e699cfc08e49ec773db9bab0f"} 23:08:41 INFO - Copying logs to upload dir... 23:08:41 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1274.004992 ========= master_lag: 0.44 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-06 23:08:41.124121) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-06 23:08:41.132210) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1452148946.101408-1060205550 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/ec318dd62b174a77adc4f5c9b84d5ac655ab9a9f9f208b3551cf7f02ca5b9c9ddf821f870d8d133452ea469ccbe96422d58d0cd9ee344dad4c8bc7bb1895f290", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dfabb915afb8a2eda978b76da1d52192592efbe310584fb605f0f4d133e7202d0c807721c37ca3eb9823d0024ef4b3582401ae1e699cfc08e49ec773db9bab0f"} build_url:https://queue.taskcluster.net/v1/task/e_8pEUlMR2uvzRnhI2DTOA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011213 build_url: 'https://queue.taskcluster.net/v1/task/e_8pEUlMR2uvzRnhI2DTOA/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/ec318dd62b174a77adc4f5c9b84d5ac655ab9a9f9f208b3551cf7f02ca5b9c9ddf821f870d8d133452ea469ccbe96422d58d0cd9ee344dad4c8bc7bb1895f290", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dfabb915afb8a2eda978b76da1d52192592efbe310584fb605f0f4d133e7202d0c807721c37ca3eb9823d0024ef4b3582401ae1e699cfc08e49ec773db9bab0f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-06 23:08:41.162467) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 23:08:41.162858) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1452148946.101408-1060205550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004596 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 23:08:41.215727) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-06 23:08:41.216098) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-06 23:08:41.216442) ========= ========= Total master_lag: 0.69 =========