builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1451426329.64 results: success (0) buildid: 20151229113008 builduid: 520878e0fc9240998613eb83f6dc1ccc revision: 7d1b18c49d6599ec982477034e86c721ff7cff23 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:49.638924) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:49.639659) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:49.639968) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1451416077.418951-498231862 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006305 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:49.669734) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:49.670021) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:49.710928) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:49.711176) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1451416077.418951-498231862 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004613 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:49.771952) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:49.772221) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:49.772597) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:49.772892) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1451416077.418951-498231862 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-29 13:58:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2015-12-29 13:58:50 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166408 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:49.951887) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:49.952175) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1451416077.418951-498231862 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020712 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:50.005603) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:50.005914) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7d1b18c49d6599ec982477034e86c721ff7cff23 --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 7d1b18c49d6599ec982477034e86c721ff7cff23 --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=d7d9c069d1ebe471abe975fc000001d9-1451416077.418951-498231862 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-29 13:58:50,905 truncating revision to first 12 chars 2015-12-29 13:58:50,905 Setting DEBUG logging. 2015-12-29 13:58:50,905 attempt 1/10 2015-12-29 13:58:50,905 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7d1b18c49d65?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-29 13:58:51,155 unpacking tar archive at: fx-team-7d1b18c49d65/testing/mozharness/ program finished with exit code 0 elapsedTime=0.532570 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:50.550924) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:50.551194) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:50.558377) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:50.558644) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 13:58:50.559012) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-29 13:58:50.559311) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=d7d9c069d1ebe471abe975fc000001d9-1451416077.418951-498231862 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:58:51 INFO - MultiFileLogger online at 20151229 13:58:51 in /builds/slave/test-pgo 13:58:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 13:58:51 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 13:58:51 INFO - {'append_to_log': False, 13:58:51 INFO - 'base_work_dir': '/builds/slave/test-pgo', 13:58:51 INFO - 'blob_upload_branch': 'Fx-Team', 13:58:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 13:58:51 INFO - 'branch': 'Fx-Team', 13:58:51 INFO - 'buildbot_json_path': 'buildprops.json', 13:58:51 INFO - 'config_files': ('talos/linux_config.py',), 13:58:51 INFO - 'default_actions': ('clobber', 13:58:51 INFO - 'read-buildbot-config', 13:58:51 INFO - 'download-and-extract', 13:58:51 INFO - 'populate-webroot', 13:58:51 INFO - 'create-virtualenv', 13:58:51 INFO - 'install', 13:58:51 INFO - 'run-tests'), 13:58:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:58:51 INFO - 'download_minidump_stackwalk': True, 13:58:51 INFO - 'download_symbols': 'ondemand', 13:58:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:58:51 INFO - 'tooltool.py': '/tools/tooltool.py', 13:58:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:58:51 INFO - '/tools/misc-python/virtualenv.py')}, 13:58:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:58:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:58:51 INFO - 'installer_path': 'installer.exe', 13:58:51 INFO - 'log_level': 'info', 13:58:51 INFO - 'log_name': 'talos', 13:58:51 INFO - 'log_to_console': True, 13:58:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:58:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:58:51 INFO - 'opt_config_files': (), 13:58:51 INFO - 'pip_index': False, 13:58:51 INFO - 'sps_profile': False, 13:58:51 INFO - 'sps_profile_interval': 0, 13:58:51 INFO - 'suite': 'dromaeojs', 13:58:51 INFO - 'system_bits': '32', 13:58:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:58:51 INFO - 'title': 'talos-linux64-ix-068', 13:58:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:58:51 INFO - 'use_talos_json': True, 13:58:51 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 13:58:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:58:51 INFO - 'work_dir': 'build'} 13:58:51 INFO - ##### 13:58:51 INFO - ##### Running clobber step. 13:58:51 INFO - ##### 13:58:51 INFO - Running pre-action listener: _resource_record_pre_action 13:58:51 INFO - Running main action method: clobber 13:58:51 INFO - rmtree: /builds/slave/test-pgo/build 13:58:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 13:58:52 INFO - Running post-action listener: _resource_record_post_action 13:58:52 INFO - ##### 13:58:52 INFO - ##### Running read-buildbot-config step. 13:58:52 INFO - ##### 13:58:52 INFO - Running pre-action listener: _resource_record_pre_action 13:58:52 INFO - Running main action method: read_buildbot_config 13:58:52 INFO - Using buildbot properties: 13:58:52 INFO - { 13:58:52 INFO - "project": "", 13:58:52 INFO - "product": "firefox", 13:58:52 INFO - "script_repo_revision": "production", 13:58:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:58:52 INFO - "repository": "", 13:58:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 13:58:52 INFO - "buildid": "20151229113008", 13:58:52 INFO - "pgo_build": "True", 13:58:52 INFO - "basedir": "/builds/slave/test-pgo", 13:58:52 INFO - "buildnumber": 561, 13:58:52 INFO - "slavename": "talos-linux64-ix-068", 13:58:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:58:52 INFO - "platform": "ubuntu64_hw", 13:58:52 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 13:58:52 INFO - "branch": "fx-team", 13:58:52 INFO - "repo_path": "integration/fx-team", 13:58:52 INFO - "revision": "7d1b18c49d6599ec982477034e86c721ff7cff23", 13:58:52 INFO - "stage_platform": "linux64-pgo", 13:58:52 INFO - "builduid": "520878e0fc9240998613eb83f6dc1ccc", 13:58:52 INFO - "slavebuilddir": "test" 13:58:52 INFO - } 13:58:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 13:58:52 INFO - Running post-action listener: _resource_record_post_action 13:58:52 INFO - ##### 13:58:52 INFO - ##### Running download-and-extract step. 13:58:52 INFO - ##### 13:58:52 INFO - Running pre-action listener: _resource_record_pre_action 13:58:52 INFO - Running main action method: download_and_extract 13:58:52 INFO - mkdir: /builds/slave/test-pgo/build/tests 13:58: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')]} 13:58:52 INFO - https://queue.taskcluster.net/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:58:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/test_packages.json 13:58:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/test_packages.json 13:58:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 13:58:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 13:58:54 INFO - Downloaded 1302 bytes. 13:58:54 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 13:58:54 INFO - Using the following test package requirements: 13:58:54 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:58:54 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:54 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:58:54 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:54 INFO - u'jsshell-linux-x86_64.zip'], 13:58:54 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:54 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:58:54 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:58:54 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:54 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:58:54 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:54 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:58:54 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:54 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:58:54 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:58:54 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:54 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:58:54 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:58: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')]} 13:58:54 INFO - https://queue.taskcluster.net/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:58:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:58:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:58:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/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 13:58:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/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 13:58:55 INFO - Downloaded 23192569 bytes. 13:58:55 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 13:58:55 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:58:55 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 13:58:56 INFO - Return code: 0 13:58:56 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 13:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:56 INFO - https://queue.taskcluster.net/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:58:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:58:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:58:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/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 13:58:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/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 13:59:00 INFO - Downloaded 23192569 bytes. 13:59:00 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 13:59:00 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:59:00 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 13:59:01 INFO - Return code: 0 13:59: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')]} 13:59:01 INFO - https://queue.taskcluster.net/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:59:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:59:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:59:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/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 13:59:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/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 13:59:02 INFO - Downloaded 11132270 bytes. 13:59:02 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 13:59:02 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:59:02 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 13:59:03 INFO - Return code: 0 13:59:03 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')]} 13:59:03 INFO - https://queue.taskcluster.net/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:59:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:59:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:59:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/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 13:59:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/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 13:59:04 INFO - Downloaded 54893147 bytes. 13:59:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:59:04 INFO - mkdir: /builds/slave/test-pgo/properties 13:59:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 13:59:04 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 13:59:04 INFO - Contents: 13:59:04 INFO - build_url:https://queue.taskcluster.net/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:59:04 INFO - Running post-action listener: _resource_record_post_action 13:59:04 INFO - Running post-action listener: set_extra_try_arguments 13:59:04 INFO - ##### 13:59:04 INFO - ##### Running populate-webroot step. 13:59:04 INFO - ##### 13:59:04 INFO - Running pre-action listener: _resource_record_pre_action 13:59:04 INFO - Running main action method: populate_webroot 13:59:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:59:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:59:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:59:04 INFO - '--tppagecycles', 13:59:04 INFO - '7'], 13:59:04 INFO - 'tests': ['tsvgm']}}, 13:59:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:59:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:59:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:59:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:59:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:59:04 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:59:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:59:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:04 INFO - 'talos_options': ['--e10s'], 13:59:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:59:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:04 INFO - 'tests': ['damp', 'tps']}, 13:59:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:04 INFO - 'talos_options': ['--e10s'], 13:59:04 INFO - 'tests': ['damp', 'tps']}, 13:59:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:59:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:59:04 INFO - 'other': {'tests': ['a11yr', 13:59:04 INFO - 'ts_paint', 13:59:04 INFO - 'tpaint', 13:59:04 INFO - 'sessionrestore', 13:59:04 INFO - 'sessionrestore_no_auto_restore']}, 13:59:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:59:04 INFO - 'tests': ['a11yr', 13:59:04 INFO - 'ts_paint', 13:59:04 INFO - 'tpaint', 13:59:04 INFO - 'sessionrestore', 13:59:04 INFO - 'sessionrestore_no_auto_restore']}, 13:59:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:59:04 INFO - 'tests': ['a11yr', 13:59:04 INFO - 'ts_paint', 13:59:04 INFO - 'tpaint', 13:59:04 INFO - 'sessionrestore', 13:59:04 INFO - 'sessionrestore_no_auto_restore']}, 13:59:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:59:04 INFO - 'tests': ['a11yr', 13:59:04 INFO - 'ts_paint', 13:59:04 INFO - 'tpaint', 13:59:04 INFO - 'sessionrestore', 13:59:04 INFO - 'sessionrestore_no_auto_restore']}, 13:59:04 INFO - 'other_l64': {'tests': ['a11yr', 13:59:04 INFO - 'ts_paint', 13:59:04 INFO - 'tpaint', 13:59:04 INFO - 'sessionrestore', 13:59:04 INFO - 'sessionrestore_no_auto_restore']}, 13:59:04 INFO - 'other_nol64': {'tests': ['a11yr', 13:59:04 INFO - 'ts_paint', 13:59:04 INFO - 'tpaint', 13:59:04 INFO - 'sessionrestore', 13:59:04 INFO - 'sessionrestore_no_auto_restore']}, 13:59:04 INFO - 'svgr': {'tests': ['tsvgx', 13:59:04 INFO - 'tsvgr_opacity', 13:59:04 INFO - 'tart', 13:59:04 INFO - 'tscrollx', 13:59:04 INFO - 'cart']}, 13:59:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:59:04 INFO - 'tests': ['tsvgx', 13:59:04 INFO - 'tsvgr_opacity', 13:59:04 INFO - 'tart', 13:59:04 INFO - 'tscrollx', 13:59:04 INFO - 'cart']}, 13:59:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:04 INFO - 'tests': ['tp5o']}, 13:59:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:04 INFO - 'talos_options': ['--e10s'], 13:59:04 INFO - 'tests': ['tp5o']}, 13:59:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:04 INFO - 'talos_options': ['--xperf_path', 13:59:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:59:04 INFO - 'tests': ['tp5n']}, 13:59:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:59:04 INFO - 'talos_options': ['--e10s', 13:59:04 INFO - '--xperf_path', 13:59:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:59:04 INFO - 'tests': ['tp5n']}}, 13:59:04 INFO - 'talos.zip': {'path': '', 13:59:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:59:04 INFO - Running post-action listener: _resource_record_post_action 13:59:04 INFO - ##### 13:59:04 INFO - ##### Running create-virtualenv step. 13:59:04 INFO - ##### 13:59:04 INFO - Running pre-action listener: _resource_record_pre_action 13:59:04 INFO - Running main action method: create_virtualenv 13:59:04 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 13:59:04 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 13:59:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 13:59:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:59:04 INFO - Using real prefix '/usr' 13:59:04 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 13:59:04 INFO - Installing distribute.............................................................................................................................................................................................done. 13:59:07 INFO - Installing pip.................done. 13:59:07 INFO - Return code: 0 13:59:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 13:59: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')]} 13:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59: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')]} 13:59:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f56dad84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfab840>, '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 0xf186b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf18b60>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1451416077.418951-498231862', '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 13:59: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 13:59: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 pip>=1.5 13:59:07 INFO - Using env: {'DISPLAY': ':0', 13:59:07 INFO - 'HOME': '/home/cltbld', 13:59:07 INFO - 'LANG': 'en_US.UTF-8', 13:59:07 INFO - 'LANGUAGE': 'en_US:en', 13:59:07 INFO - 'LOGNAME': 'cltbld', 13:59:07 INFO - 'MAIL': '/var/mail/cltbld', 13:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:07 INFO - 'MOZ_NO_REMOTE': '1', 13:59:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:07 INFO - 'NO_EM_RESTART': '1', 13:59:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:59:07 INFO - 'PWD': '/builds/slave/test-pgo', 13:59:07 INFO - 'SHELL': '/bin/bash', 13:59:07 INFO - 'SHLVL': '1', 13:59:07 INFO - 'TERM': 'linux', 13:59:07 INFO - 'TMOUT': '86400', 13:59:07 INFO - 'USER': 'cltbld', 13:59:07 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1451416077.418951-498231862', 13:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:07 INFO - '_': '/tools/buildbot/bin/python'} 13:59:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:07 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 13:59:07 INFO - Cleaning up... 13:59:07 INFO - Return code: 0 13:59:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 13:59: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')]} 13:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59: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')]} 13:59:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59: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', '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 0x7f56dad84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfab840>, '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 0xf186b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf18b60>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1451416077.418951-498231862', '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 13:59: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 13:59: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 psutil>=0.7.1 13:59:07 INFO - Using env: {'DISPLAY': ':0', 13:59:07 INFO - 'HOME': '/home/cltbld', 13:59:07 INFO - 'LANG': 'en_US.UTF-8', 13:59:07 INFO - 'LANGUAGE': 'en_US:en', 13:59:07 INFO - 'LOGNAME': 'cltbld', 13:59:07 INFO - 'MAIL': '/var/mail/cltbld', 13:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:07 INFO - 'MOZ_NO_REMOTE': '1', 13:59:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:07 INFO - 'NO_EM_RESTART': '1', 13:59:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:59:07 INFO - 'PWD': '/builds/slave/test-pgo', 13:59:07 INFO - 'SHELL': '/bin/bash', 13:59:07 INFO - 'SHLVL': '1', 13:59:07 INFO - 'TERM': 'linux', 13:59:07 INFO - 'TMOUT': '86400', 13:59:07 INFO - 'USER': 'cltbld', 13:59:07 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1451416077.418951-498231862', 13:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:07 INFO - '_': '/tools/buildbot/bin/python'} 13:59:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:07 INFO - Downloading/unpacking psutil>=0.7.1 13:59: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 13:59: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 13:59: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 13:59: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 13:59: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 13:59: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 13:59:09 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 13:59:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:59:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 13:59:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:59:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:59:09 INFO - Installing collected packages: psutil 13:59:09 INFO - Running setup.py install for psutil 13:59:09 INFO - building 'psutil._psutil_linux' extension 13:59:09 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 13:59:09 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 13:59:09 INFO - building 'psutil._psutil_posix' extension 13:59:09 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 13:59:09 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 13:59:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:59:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:59:09 INFO - Successfully installed psutil 13:59:09 INFO - Cleaning up... 13:59:09 INFO - Return code: 0 13:59:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 13:59:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:59:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:09 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 0x7f56dad84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfab840>, '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 0xf186b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf18b60>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1451416077.418951-498231862', '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 13:59:09 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 13:59:09 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 13:59:09 INFO - Using env: {'DISPLAY': ':0', 13:59:09 INFO - 'HOME': '/home/cltbld', 13:59:09 INFO - 'LANG': 'en_US.UTF-8', 13:59:09 INFO - 'LANGUAGE': 'en_US:en', 13:59:09 INFO - 'LOGNAME': 'cltbld', 13:59:09 INFO - 'MAIL': '/var/mail/cltbld', 13:59:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:09 INFO - 'MOZ_NO_REMOTE': '1', 13:59:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:09 INFO - 'NO_EM_RESTART': '1', 13:59:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:59:09 INFO - 'PWD': '/builds/slave/test-pgo', 13:59:09 INFO - 'SHELL': '/bin/bash', 13:59:09 INFO - 'SHLVL': '1', 13:59:09 INFO - 'TERM': 'linux', 13:59:09 INFO - 'TMOUT': '86400', 13:59:09 INFO - 'USER': 'cltbld', 13:59:09 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1451416077.418951-498231862', 13:59:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:09 INFO - '_': '/tools/buildbot/bin/python'} 13:59:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:59:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:59:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:59:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:59:11 INFO - Installing collected packages: mozsystemmonitor 13:59:11 INFO - Running setup.py install for mozsystemmonitor 13:59:11 INFO - Successfully installed mozsystemmonitor 13:59:11 INFO - Cleaning up... 13:59:11 INFO - Return code: 0 13:59:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 13:59:11 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')]} 13:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:11 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')]} 13:59:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:11 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 0x7f56dad84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfab840>, '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 0xf186b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf18b60>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1451416077.418951-498231862', '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 13:59:11 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 13:59:11 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 13:59:11 INFO - Using env: {'DISPLAY': ':0', 13:59:11 INFO - 'HOME': '/home/cltbld', 13:59:11 INFO - 'LANG': 'en_US.UTF-8', 13:59:11 INFO - 'LANGUAGE': 'en_US:en', 13:59:11 INFO - 'LOGNAME': 'cltbld', 13:59:11 INFO - 'MAIL': '/var/mail/cltbld', 13:59:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:11 INFO - 'MOZ_NO_REMOTE': '1', 13:59:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:11 INFO - 'NO_EM_RESTART': '1', 13:59:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:59:11 INFO - 'PWD': '/builds/slave/test-pgo', 13:59:11 INFO - 'SHELL': '/bin/bash', 13:59:11 INFO - 'SHLVL': '1', 13:59:11 INFO - 'TERM': 'linux', 13:59:11 INFO - 'TMOUT': '86400', 13:59:11 INFO - 'USER': 'cltbld', 13:59:11 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1451416077.418951-498231862', 13:59:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:11 INFO - '_': '/tools/buildbot/bin/python'} 13:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:12 INFO - Downloading/unpacking blobuploader==1.2.4 13:59:12 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 13:59:12 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 13:59:12 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 13:59:12 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 13:59:12 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 13:59:12 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 13:59:13 INFO - Downloading blobuploader-1.2.4.tar.gz 13:59:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:59:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:59:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:59:13 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 13:59:13 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 13:59:13 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 13:59:13 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 13:59:13 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 13:59:13 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 13:59:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:59:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 13:59:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:59:14 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 13:59:14 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 13:59:14 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 13:59:14 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 13:59:14 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 13:59:14 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 13:59:14 INFO - Downloading docopt-0.6.1.tar.gz 13:59:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:59:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 13:59:14 INFO - Installing collected packages: blobuploader, requests, docopt 13:59:14 INFO - Running setup.py install for blobuploader 13:59:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:59:14 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 13:59:14 INFO - Running setup.py install for requests 13:59:15 INFO - Running setup.py install for docopt 13:59:15 INFO - Successfully installed blobuploader requests docopt 13:59:15 INFO - Cleaning up... 13:59:15 INFO - Return code: 0 13:59:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:59:15 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')]} 13:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:15 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')]} 13:59:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:15 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 0x7f56dad84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfab840>, '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 0xf186b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf18b60>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1451416077.418951-498231862', '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 13:59:15 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 13:59:15 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 13:59:15 INFO - Using env: {'DISPLAY': ':0', 13:59:15 INFO - 'HOME': '/home/cltbld', 13:59:15 INFO - 'LANG': 'en_US.UTF-8', 13:59:15 INFO - 'LANGUAGE': 'en_US:en', 13:59:15 INFO - 'LOGNAME': 'cltbld', 13:59:15 INFO - 'MAIL': '/var/mail/cltbld', 13:59:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:15 INFO - 'MOZ_NO_REMOTE': '1', 13:59:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:15 INFO - 'NO_EM_RESTART': '1', 13:59:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:59:15 INFO - 'PWD': '/builds/slave/test-pgo', 13:59:15 INFO - 'SHELL': '/bin/bash', 13:59:15 INFO - 'SHLVL': '1', 13:59:15 INFO - 'TERM': 'linux', 13:59:15 INFO - 'TMOUT': '86400', 13:59:15 INFO - 'USER': 'cltbld', 13:59:15 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1451416077.418951-498231862', 13:59:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:15 INFO - '_': '/tools/buildbot/bin/python'} 13:59:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:59:15 INFO - Running setup.py (path:/tmp/pip-ZpPogJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:59:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:59:15 INFO - Running setup.py (path:/tmp/pip-M259gw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:59:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:59:15 INFO - Running setup.py (path:/tmp/pip-77f8a4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:59:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:59:15 INFO - Running setup.py (path:/tmp/pip-vVYeek-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:59:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:59:15 INFO - Running setup.py (path:/tmp/pip-LfOqXj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:59:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:59:15 INFO - Running setup.py (path:/tmp/pip-Tb3ZpH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:59:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:59:15 INFO - Running setup.py (path:/tmp/pip-yBP4iA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:59:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:59:15 INFO - Running setup.py (path:/tmp/pip-sQ812c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:59:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:59:15 INFO - Running setup.py (path:/tmp/pip-zdizdN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:59:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:59:16 INFO - Running setup.py (path:/tmp/pip-Q3yIha-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:59:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:59:16 INFO - Running setup.py (path:/tmp/pip-5gVApX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:59:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:59:16 INFO - Running setup.py (path:/tmp/pip-Hg_Mkd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:59:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:59:16 INFO - Running setup.py (path:/tmp/pip-RI4Nt6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:59:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:59:16 INFO - Running setup.py (path:/tmp/pip-LFmzlr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:59:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:59:16 INFO - Running setup.py (path:/tmp/pip-DpwgDz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:59:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:59:16 INFO - Running setup.py (path:/tmp/pip-Hyx71f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:59:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:59:16 INFO - Running setup.py (path:/tmp/pip-9e0Rp3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:59:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:59:16 INFO - Running setup.py install for manifestparser 13:59:16 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 13:59:16 INFO - Running setup.py install for mozcrash 13:59:16 INFO - Running setup.py install for mozdebug 13:59:16 INFO - Running setup.py install for mozdevice 13:59:17 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 13:59:17 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 13:59:17 INFO - Running setup.py install for mozfile 13:59:17 INFO - Running setup.py install for mozhttpd 13:59:17 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 13:59:17 INFO - Running setup.py install for mozinfo 13:59:17 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 13:59:17 INFO - Running setup.py install for mozInstall 13:59:17 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 13:59:17 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 13:59:17 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 13:59:17 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 13:59:17 INFO - Running setup.py install for mozleak 13:59:17 INFO - Running setup.py install for mozlog 13:59:17 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 13:59:17 INFO - Running setup.py install for moznetwork 13:59:17 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 13:59:17 INFO - Running setup.py install for mozprocess 13:59:17 INFO - Running setup.py install for mozprofile 13:59:17 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 13:59:17 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 13:59:17 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 13:59:17 INFO - Running setup.py install for mozrunner 13:59:18 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 13:59:18 INFO - Running setup.py install for mozscreenshot 13:59:18 INFO - Running setup.py install for moztest 13:59:18 INFO - Running setup.py install for mozversion 13:59:18 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 13:59:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:59:18 INFO - Cleaning up... 13:59:18 INFO - Return code: 0 13:59:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:59:18 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')]} 13:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:18 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')]} 13:59:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:18 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 0x7f56dad84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfab840>, '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 0xf186b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf18b60>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1451416077.418951-498231862', '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 13:59:18 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 13:59:18 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 13:59:18 INFO - Using env: {'DISPLAY': ':0', 13:59:18 INFO - 'HOME': '/home/cltbld', 13:59:18 INFO - 'LANG': 'en_US.UTF-8', 13:59:18 INFO - 'LANGUAGE': 'en_US:en', 13:59:18 INFO - 'LOGNAME': 'cltbld', 13:59:18 INFO - 'MAIL': '/var/mail/cltbld', 13:59:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:18 INFO - 'MOZ_NO_REMOTE': '1', 13:59:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:18 INFO - 'NO_EM_RESTART': '1', 13:59:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:59:18 INFO - 'PWD': '/builds/slave/test-pgo', 13:59:18 INFO - 'SHELL': '/bin/bash', 13:59:18 INFO - 'SHLVL': '1', 13:59:18 INFO - 'TERM': 'linux', 13:59:18 INFO - 'TMOUT': '86400', 13:59:18 INFO - 'USER': 'cltbld', 13:59:18 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1451416077.418951-498231862', 13:59:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:18 INFO - '_': '/tools/buildbot/bin/python'} 13:59:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:59:18 INFO - Running setup.py (path:/tmp/pip-KXHFdo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:59:18 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)) 13:59:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:59:18 INFO - Running setup.py (path:/tmp/pip-1UqlYs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:59:18 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)) 13:59:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:59:18 INFO - Running setup.py (path:/tmp/pip-VZrPMS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:59:18 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)) 13:59:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:59:18 INFO - Running setup.py (path:/tmp/pip-4HRQwj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:59:18 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)) 13:59:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:59:18 INFO - Running setup.py (path:/tmp/pip-QrSUVt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:59:19 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)) 13:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:59:19 INFO - Running setup.py (path:/tmp/pip-hcW4FH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:59:19 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)) 13:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:59:19 INFO - Running setup.py (path:/tmp/pip-Sfj9MR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:59:19 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)) 13:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:59:19 INFO - Running setup.py (path:/tmp/pip-okd_3b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:59:19 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)) 13:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:59:19 INFO - Running setup.py (path:/tmp/pip-5gFAL2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:59:19 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)) 13:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:59:19 INFO - Running setup.py (path:/tmp/pip-ZzQtwE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:59:19 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)) 13:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:59:19 INFO - Running setup.py (path:/tmp/pip-E7NnBO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:59:19 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)) 13:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:59:19 INFO - Running setup.py (path:/tmp/pip-aVUH6M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:59:19 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)) 13:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:59:19 INFO - Running setup.py (path:/tmp/pip-4L4LsK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:59:19 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)) 13:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:59:19 INFO - Running setup.py (path:/tmp/pip-6Mk2l6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:59:19 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)) 13:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:59:19 INFO - Running setup.py (path:/tmp/pip-wLVNuG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:59:19 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)) 13:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:59:19 INFO - Running setup.py (path:/tmp/pip-sg_fzR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:59:19 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)) 13:59:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:59:19 INFO - Running setup.py (path:/tmp/pip-cmOHw9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:59:19 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)) 13:59:19 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)) 13:59:19 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)) 13:59:19 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)) 13:59:19 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)) 13:59:19 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)) 13:59:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:59:19 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 13:59:19 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 13:59:19 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 13:59:19 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 13:59:19 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 13:59:19 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 13:59:21 INFO - Downloading blessings-1.5.1.tar.gz 13:59:21 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 13:59:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 13:59:21 INFO - Installing collected packages: blessings 13:59:21 INFO - Running setup.py install for blessings 13:59:21 INFO - Successfully installed blessings 13:59:21 INFO - Cleaning up... 13:59:21 INFO - Return code: 0 13:59:21 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 13:59:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:59:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:59:22 INFO - Reading from file tmpfile_stdout 13:59:22 INFO - Current package versions: 13:59:22 INFO - argparse == 1.2.1 13:59:22 INFO - blessings == 1.5.1 13:59:22 INFO - blobuploader == 1.2.4 13:59:22 INFO - docopt == 0.6.1 13:59:22 INFO - manifestparser == 1.1 13:59:22 INFO - mozInstall == 1.12 13:59:22 INFO - mozcrash == 0.16 13:59:22 INFO - mozdebug == 0.1 13:59:22 INFO - mozdevice == 0.47 13:59:22 INFO - mozfile == 1.2 13:59:22 INFO - mozhttpd == 0.7 13:59:22 INFO - mozinfo == 0.9 13:59:22 INFO - mozleak == 0.1 13:59:22 INFO - mozlog == 3.1 13:59:22 INFO - moznetwork == 0.27 13:59:22 INFO - mozprocess == 0.22 13:59:22 INFO - mozprofile == 0.28 13:59:22 INFO - mozrunner == 6.11 13:59:22 INFO - mozscreenshot == 0.1 13:59:22 INFO - mozsystemmonitor == 0.0 13:59:22 INFO - moztest == 0.7 13:59:22 INFO - mozversion == 1.4 13:59:22 INFO - psutil == 3.1.1 13:59:22 INFO - requests == 1.2.3 13:59:22 INFO - wsgiref == 0.1.2 13:59:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:59:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:59:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:22 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 0x7f56dad84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfab840>, '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 0xf186b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf18b60>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1451416077.418951-498231862', '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 13:59:22 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 13:59:22 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 13:59:22 INFO - Using env: {'DISPLAY': ':0', 13:59:22 INFO - 'HOME': '/home/cltbld', 13:59:22 INFO - 'LANG': 'en_US.UTF-8', 13:59:22 INFO - 'LANGUAGE': 'en_US:en', 13:59:22 INFO - 'LOGNAME': 'cltbld', 13:59:22 INFO - 'MAIL': '/var/mail/cltbld', 13:59:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:22 INFO - 'MOZ_NO_REMOTE': '1', 13:59:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:22 INFO - 'NO_EM_RESTART': '1', 13:59:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:59:22 INFO - 'PWD': '/builds/slave/test-pgo', 13:59:22 INFO - 'SHELL': '/bin/bash', 13:59:22 INFO - 'SHLVL': '1', 13:59:22 INFO - 'TERM': 'linux', 13:59:22 INFO - 'TMOUT': '86400', 13:59:22 INFO - 'USER': 'cltbld', 13:59:22 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1451416077.418951-498231862', 13:59:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:22 INFO - '_': '/tools/buildbot/bin/python'} 13:59:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:22 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)) 13:59:22 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)) 13:59:22 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)) 13:59:22 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)) 13:59:22 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)) 13:59:22 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)) 13:59:22 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)) 13:59:22 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)) 13:59:22 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)) 13:59:22 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)) 13:59:22 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)) 13:59:22 INFO - Cleaning up... 13:59:22 INFO - Return code: 0 13:59:22 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 13:59:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:59:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:22 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 0x7f56dad84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfab840>, '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 0xf186b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf18b60>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1451416077.418951-498231862', '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 13:59:22 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 13:59:22 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 13:59:22 INFO - Using env: {'DISPLAY': ':0', 13:59:22 INFO - 'HOME': '/home/cltbld', 13:59:22 INFO - 'LANG': 'en_US.UTF-8', 13:59:22 INFO - 'LANGUAGE': 'en_US:en', 13:59:22 INFO - 'LOGNAME': 'cltbld', 13:59:22 INFO - 'MAIL': '/var/mail/cltbld', 13:59:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:22 INFO - 'MOZ_NO_REMOTE': '1', 13:59:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:22 INFO - 'NO_EM_RESTART': '1', 13:59:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:59:22 INFO - 'PWD': '/builds/slave/test-pgo', 13:59:22 INFO - 'SHELL': '/bin/bash', 13:59:22 INFO - 'SHLVL': '1', 13:59:22 INFO - 'TERM': 'linux', 13:59:22 INFO - 'TMOUT': '86400', 13:59:22 INFO - 'USER': 'cltbld', 13:59:22 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1451416077.418951-498231862', 13:59:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:22 INFO - '_': '/tools/buildbot/bin/python'} 13:59:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:22 INFO - Downloading/unpacking jsonschema 13:59:22 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 13:59:22 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 13:59:22 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 13:59:22 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 13:59:22 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 13:59:22 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 13:59:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:59:24 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 13:59:24 INFO - Downloading/unpacking functools32 (from jsonschema) 13:59:24 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 13:59:24 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 13:59:24 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 13:59:24 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 13:59:24 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 13:59:24 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 13:59:24 INFO - Downloading functools32-3.2.3-2.tar.gz 13:59:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 13:59:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 13:59:24 INFO - warning: no files found matching '*.txt' 13:59:24 INFO - no previously-included directories found matching 'build' 13:59:24 INFO - no previously-included directories found matching 'dist' 13:59:24 INFO - no previously-included directories found matching '.git*' 13:59:24 INFO - Installing collected packages: jsonschema, functools32 13:59:24 INFO - Running setup.py install for functools32 13:59:24 INFO - warning: no files found matching '*.txt' 13:59:24 INFO - no previously-included directories found matching 'build' 13:59:24 INFO - no previously-included directories found matching 'dist' 13:59:24 INFO - no previously-included directories found matching '.git*' 13:59:24 INFO - Successfully installed jsonschema functools32 13:59:24 INFO - Cleaning up... 13:59:24 INFO - Return code: 0 13:59:24 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 13:59:24 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')]} 13:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:59:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:24 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')]} 13:59:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:59:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:59:24 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 0x7f56dad84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfab840>, '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 0xf186b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf18b60>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1451416077.418951-498231862', '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 13:59:24 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 13:59:24 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 13:59:24 INFO - Using env: {'DISPLAY': ':0', 13:59:24 INFO - 'HOME': '/home/cltbld', 13:59:24 INFO - 'LANG': 'en_US.UTF-8', 13:59:24 INFO - 'LANGUAGE': 'en_US:en', 13:59:24 INFO - 'LOGNAME': 'cltbld', 13:59:24 INFO - 'MAIL': '/var/mail/cltbld', 13:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:24 INFO - 'MOZ_NO_REMOTE': '1', 13:59:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:24 INFO - 'NO_EM_RESTART': '1', 13:59:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:59:24 INFO - 'PWD': '/builds/slave/test-pgo', 13:59:24 INFO - 'SHELL': '/bin/bash', 13:59:24 INFO - 'SHLVL': '1', 13:59:24 INFO - 'TERM': 'linux', 13:59:24 INFO - 'TMOUT': '86400', 13:59:24 INFO - 'USER': 'cltbld', 13:59:24 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1451416077.418951-498231862', 13:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:24 INFO - '_': '/tools/buildbot/bin/python'} 13:59:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:59:24 INFO - Downloading/unpacking flake8 13:59:24 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 13:59:24 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 13:59:24 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 13:59:24 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 13:59:24 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 13:59:24 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 13:59:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:59:26 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 13:59:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:59:26 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 13:59:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:26 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 13:59:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:59:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:59:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 13:59:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 13:59:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:59:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:59:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:59:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:59:27 INFO - no previously-included directories found matching 'docs/_build' 13:59:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:59:27 INFO - Running setup.py install for pep8 13:59:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:59:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:59:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:59:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:59:27 INFO - no previously-included directories found matching 'docs/_build' 13:59:27 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 13:59:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:59:27 INFO - Cleaning up... 13:59:27 INFO - Return code: 0 13:59:27 INFO - Running post-action listener: _resource_record_post_action 13:59:27 INFO - Running post-action listener: _start_resource_monitoring 13:59:27 INFO - Starting resource monitoring. 13:59:27 INFO - ##### 13:59:27 INFO - ##### Running install step. 13:59:27 INFO - ##### 13:59:27 INFO - Running pre-action listener: _resource_record_pre_action 13:59:27 INFO - Running main action method: install 13:59:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:59:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:59:27 INFO - Reading from file tmpfile_stdout 13:59:27 INFO - Detecting whether we're running mozinstall >=1.0... 13:59:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 13:59:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 13:59:27 INFO - Reading from file tmpfile_stdout 13:59:27 INFO - Output received: 13:59:27 INFO - Usage: mozinstall [options] installer 13:59:27 INFO - Options: 13:59:27 INFO - -h, --help show this help message and exit 13:59:27 INFO - -d DEST, --destination=DEST 13:59:27 INFO - Directory to install application into. [default: 13:59:27 INFO - "/builds/slave/test-pgo"] 13:59:27 INFO - --app=APP Application being installed. [default: firefox] 13:59:27 INFO - mkdir: /builds/slave/test-pgo/build/application 13:59:27 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'] 13:59:27 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 13:59:43 INFO - Reading from file tmpfile_stdout 13:59:43 INFO - Output received: 13:59:43 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 13:59:43 INFO - Running post-action listener: _resource_record_post_action 13:59:43 INFO - ##### 13:59:43 INFO - ##### Running run-tests step. 13:59:43 INFO - ##### 13:59:43 INFO - Running pre-action listener: _resource_record_pre_action 13:59:43 INFO - Running main action method: run_tests 13:59:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 13:59:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 13:59:43 INFO - Python 2.7.3 13:59:43 INFO - Return code: 0 13:59:43 INFO - grabbing minidump binary from tooltool 13:59: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')]} 13:59:43 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 0xfab840>, '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 0xf186b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf18b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 13:59:43 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 13:59:43 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 13:59:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:59:43 INFO - Return code: 0 13:59:43 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 13:59:43 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 13:59:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 13:59:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 13:59:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 13:59:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 13:59:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 13:59:44 INFO - Return code: 0 13:59:44 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 13:59:44 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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 13:59:44 INFO - Using env: {'DISPLAY': ':0', 13:59:44 INFO - 'HOME': '/home/cltbld', 13:59:44 INFO - 'LANG': 'en_US.UTF-8', 13:59:44 INFO - 'LANGUAGE': 'en_US:en', 13:59:44 INFO - 'LOGNAME': 'cltbld', 13:59:44 INFO - 'MAIL': '/var/mail/cltbld', 13:59:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:59:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 13:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:44 INFO - 'MOZ_NO_REMOTE': '1', 13:59:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:59:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:44 INFO - 'NO_EM_RESTART': '1', 13:59:44 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:59:44 INFO - 'PWD': '/builds/slave/test-pgo', 13:59:44 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 13:59:44 INFO - 'SHELL': '/bin/bash', 13:59:44 INFO - 'SHLVL': '1', 13:59:44 INFO - 'TERM': 'linux', 13:59:44 INFO - 'TMOUT': '86400', 13:59:44 INFO - 'USER': 'cltbld', 13:59:44 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1451416077.418951-498231862', 13:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:44 INFO - '_': '/tools/buildbot/bin/python'} 13:59:44 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:59:44 INFO - mozversion application_buildid: 20151229113008 13:59:44 INFO - mozversion application_changeset: 7d1b18c49d6599ec982477034e86c721ff7cff23 13:59:44 INFO - mozversion application_display_name: Nightly 13:59:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:59:44 INFO - mozversion application_name: Firefox 13:59:44 INFO - mozversion application_remotingname: firefox 13:59:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:59:44 INFO - mozversion application_vendor: Mozilla 13:59:44 INFO - mozversion application_version: 46.0a1 13:59:44 INFO - mozversion platform_buildid: 20151229113008 13:59:44 INFO - mozversion platform_changeset: 7d1b18c49d6599ec982477034e86c721ff7cff23 13:59:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:59:44 INFO - mozversion platform_version: 46.0a1 13:59:44 INFO - using testdate: 1451426384 13:59:44 INFO - actual date: 1451426384 13:59:44 INFO - starting webserver on 'localhost:32985' 13:59:44 INFO - SUITE-START | Running 3 tests 13:59:44 INFO - TEST-START | dromaeo_css 13:59:44 INFO - operating with platform_type : linux_ 13:59:44 INFO - Initialising browser for dromaeo_css test... 13:59:44 INFO - TEST-INFO | started process 25047 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCC_HGQ/profile http://localhost:32985/getInfo.html) 13:59:49 INFO - PROCESS | 25047 | __metrics Screen width/height:1600/1200 13:59:49 INFO - PROCESS | 25047 | colorDepth:24 13:59:49 INFO - PROCESS | 25047 | Browser inner width/height: 1024/697 13:59:49 INFO - PROCESS | 25047 | __metrics 13:59:49 INFO - PROCESS | 25047 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:59:49 INFO - PROCESS | 25047 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:59:50 INFO - TEST-INFO | 25047: exit 0 13:59:50 INFO - Browser initialized. 13:59:50 INFO - Running cycle 1/1 for dromaeo_css test... 13:59:50 INFO - TEST-INFO | started process 25138 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCC_HGQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:00:02 INFO - PROCESS | 25138 | RSS: Main: 148860928 14:00:02 INFO - PROCESS | 25138 | 14:00:53 INFO - PROCESS | 25138 | 1451426452998 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] 14:03:00 INFO - PROCESS | 25138 | Cycle 1(1): loaded http://localhost:32985/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32985/tests/dromaeo/cssquery-ext.html) 14:03:02 INFO - PROCESS | 25138 | RSS: Main: 365854720 14:03:02 INFO - PROCESS | 25138 | 14:06:05 INFO - PROCESS | 25138 | Cycle 1(1): loaded http://localhost:32985/tests/dromaeo/cssquery-ext.html (next: http://localhost:32985/tests/dromaeo/cssquery-jquery.html) 14:06:06 INFO - PROCESS | 25138 | RSS: Main: 240201728 14:06:06 INFO - PROCESS | 25138 | 14:09:08 INFO - PROCESS | 25138 | Cycle 1(1): loaded http://localhost:32985/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32985/tests/dromaeo/cssquery-mootools.html) 14:09:08 INFO - PROCESS | 25138 | RSS: Main: 235450368 14:09:08 INFO - PROCESS | 25138 | 14:12:10 INFO - PROCESS | 25138 | Cycle 1(1): loaded http://localhost:32985/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32985/tests/dromaeo/cssquery-prototype.html) 14:12:10 INFO - PROCESS | 25138 | RSS: Main: 217104384 14:12:10 INFO - PROCESS | 25138 | 14:15:13 INFO - PROCESS | 25138 | Cycle 1(1): loaded http://localhost:32985/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32985/tests/dromaeo/cssquery-yui.html) 14:15:14 INFO - PROCESS | 25138 | RSS: Main: 218943488 14:15:14 INFO - PROCESS | 25138 | 14:18:16 INFO - PROCESS | 25138 | Cycle 1(1): loaded http://localhost:32985/tests/dromaeo/cssquery-yui.html (next: http://localhost:32985/tests/dromaeo/cssquery-dojo.html) 14:18:16 INFO - PROCESS | 25138 | RSS: Main: 268447744 14:18:16 INFO - PROCESS | 25138 | 14:18:16 INFO - PROCESS | 25138 | __start_tp_report 14:18:16 INFO - PROCESS | 25138 | _x_x_mozilla_page_load 14:18:16 INFO - PROCESS | 25138 | _x_x_mozilla_page_load_details 14:18:16 INFO - PROCESS | 25138 | |i|pagename|runs| 14:18:16 INFO - PROCESS | 25138 | |0;dojo.html;3102.7362674172696;3187.968120318796;3227.790193637415;3228.54800327954;3253.902382928513;5108.948910510894;5188.325517682696;5236.136037553803;5275.683458992458;5309.946900530994;5168.560672342846;5181.4300426953005;5192.584593232542;5222.294990176325;5337.412884582693;4775.355327030849;4785.784639691205;4808.615310775147;4869.099216644914;4902.58328042115;443.4240390108097;4697.929531057037;4804.951950480503;4805.231163013918;4866.416030076396;4771.8091276348905;4786.52134786522;4814.446338671028;4817.349657796188;4872.123017856767;4767.189577771787;4780.689255198401;4791.688540244873;4792.616590672737;4829.299751536043;4725.952740472586;4744.952550474485;4790.209615413452;4809.5430934061205;4821.035792841446;5096.362954630671;5116.488351164891;5126.051680439131;5144.588432925357;5158.1746920492915;5631.690257035862;5632.718364081779;5637.548996080344;5643.153526970947;5666.943330566683;5560.304961879765;5659.40576239493;5681.630694004918;5686.0617998030275;5770.422957704238;5311.389190243133;5343.412224655285;5358.115910874701;5359.598030147716;5363.919541206885;5795.1017592273265;5812.331581868139;5826.038703613856;5826.388229235954;5881.1178323251;5438.238646589481;5466.835994920159;5535.6955367454375;5535.833924982257;5617.9719101404235;5603.215549823028;5632.070708333079;5640.210370548127;5642.097264437671;5653.293338332708;5581.246531718247;5611.382747897728;5626.1842032905;5627.155926610959;5638.04153293941;5485.753141108659;5589.74846131925;5624.859378515488;5658.094704847204;5720.856978575485;4388.670849686287;4390.429244198233;4391.494978077562;4393.080897586315;4398.758068306274;3889.6499315061214;3893.435451859521;3933.272344616255;3947.50656167979;3968.146848427602;5187.481251874858;5223.2948551945;5264.289320941624;5264.657797243167;5305.840824775263;5623.381428042912;5671.8865622688145;5677.460641239076;5677.886442271131;5679.432056794288;5179.093658609729;5247.816326428557;5268.868278292996;5274.630775845731;5325.121354976385;4804.447488538793;4804.95195048052;4811.903761924742;4828.686135401188;4882.5605695487575;5749.597528173072;5749.655020698688;5763.366029736726;5764.13537969308;5766.336871259775;5573.526250268773;5582.106862901916;5582.441755824385;5612.887742245214;5614.045612245846;5729.656220626775;5761.107028410603;5824.94175058244;5825.533957283492;5866.325372582037;5484.588655850747;5507.586930980273;5548.861278468071;5549.112142057252;5560.694161820977;5510.559155267649;5642.153676948491;5643.097104463266;5650.63270887391;5669.234653321749;5508;5541;5542.0301447245765;5542.445755424425;5546.473085056913;5411.972940135274;5439.646422982493;5454.699991500505;5459.535939445192;5465.59008074388;5440.537554307928;5457;5457.345118585795;5458.880929409541;5459.972700136474;5547.8890422192135;5566.137248726453;5575.972120139373;5684.857878553069;5688.061469857427;5424.810131645373;5429.457054294539;5459.535939445032;5464.890702186013;5509.256250406143 14:18:16 INFO - PROCESS | 25138 | |1;ext.html;502.7637010605016;514.7966553211481;527.5963887625966;534.0147427995349;555.9805406810757;28135;28923.566146507794;34531.30937381254;35260.294794104106;35480;37875.62124378755;38317.61682383182;38393.23213535728;38426.23147537054;38436.42345364822;7314.195438501761;8227.341812654988;8483.66065357385;8495.447795893278;8509.489430634181;7273.927260727378;10016.298859079867;10201.43892085935;10213.642522511713;10217.642382516613;9876.901230987705;10008.099271065603;10011.649592264272;10021.44882031488;10024.448655323955;7442.441816863757;7662.540247585107;9891.25815563832;9987.80024399508;10040.799184016352;9734.513274336256;9860.112589866874;9865.506724663737;9866.26003049767;9869.851952220723;35343;35733.821330893436;35829.10427239314;35851;35853.82073089644;3304.603447586281;3314.121757734202;3347.0795531228864;3635.600083990759;4083.632473077437;28652.426951460853;29544;29713.25716857074;30387.544186837215;30928.0721578353;3907.179492306619;3970.68234541236;3990.4014397840556;4100.815463304129;4158.6465150462245;247122;247519;248666;248775;249001.9999999982;49256.261156082684;50386.24420633693;54835;55182.72408637931;55195;59200;60793.69603151956;61266;61267;61270.38729612736;13728.65678358049;13860.722785544232;13946.790798138036;14003.929980350033;14016.929915350562;10145.492725363702;10184.287099903084;10233.641822536176;10234.795304093876;10249.692509224735;18454.723179152323;18507.537311567048;18570.164342604614;18622.53443663919;18628.16173272206;6834.1457317835275;6979.3718565328345;7132.500724949307;7132.857342853114;7179.246179151219;924.4330859193736;968.3560432312433;1003.8193125237527;1022.6880801355509;1038.948052597367;24886.751132488804;27917.441651166864;28288.43423131567;28381;28801.423971520453;1039.4646756920192;1039.6361273554196;1077.8922107789315;1088.4394536813547;1095.4686976816238;13920.685619060852;13986.86013139876;14135.15189088658;14197.503087391891;14247.643808904653;299569;301900;304395;304814;305764;48729.51270487321;49142;49149;49177.26234106491;49186.75406622944;1324.1062282958965;1326.933653317311;1333.4266265505926;1337.1375462826422;1342.3087110138288;25877.482450351265;27116.771978705096;27189.59215611807;27442.5883611742;27491.725082748915;43705.78147109244;44098.55901441073;44349.55650443583;44361.33457998197;44376;282677;288895;289550;290240;290424;26768.59847102256;27204.591931120653;29142.708572913998;30353;31060;35505.46741798927;35911.82044089763;36436.81781591075;36448.45327320039;38621.227575448895;33349.49975750414;33676.326473469904;33864.83067584646;33983.49024764581;34386.48420273648;27521.587176191973;31208.843955780078;33258.83370583132;33937.83031084829;34753;32435.675643243267;34277.828610856785;34520.136996574285;34645;34763;28480.715192848635;31166.844165779024;31264.687353126177;31504.684953150176;31670.841645792545;23975.880120599286;23998.640869843664;24040.75959240385;24112.638310425707;24263.636045459687 14:18:16 INFO - PROCESS | 25138 | |2;jquery.html;355.52714889197364;359.027145833644;360.3747498090814;362.6717820372563;363.29883325182385;14623.561293161196;14726.410943562272;16308.510744677664;16367.345306187754;16908.999999999985;14615.269236538157;15059.322330495126;15405.229738513057;15406.30671619777;15423.151726655029;5309.097453432916;5420.864478388052;5429.348478182624;5433.375161856377;5452.700101494416;4057.6348128668415;4164.146349998258;5383.81156659517;5426.267453893733;5786.305643322786;5952.464278214981;5974.8506287342725;5976.4919981801595;6013.398660133996;6026.216591843055;5833.416658334175;5974.074018527135;6003.789867354665;6004.489618382443;6005.849853753691;5214.634975551713;5302.946970530323;5312.335958005249;5322.175062865262;5329.0674132027125;19503.317383891495;20798.896005520026;21103.788962110488;21944.122235110575;21961.450963725874;2130.8295336373053;2223.2774348336693;2260.8304377171776;2297;2342.227065068523;12652.81020784689;13125.343732813417;13157.671058223525;13351.866481335159;13966.092204006809;1683.7137686593187;1782.1623836796684;1787.2046939112101;1823.717323814811;1826.5981484073482;57314;60753;62251;62467;62654.686726566986;9700.320977531504;9846.507674616241;9955.751106222402;10021.599136034623;10038.347507411994;13347.132436391603;13361.331933403291;13372.063955523214;13384.130031547918;13392.397342119628;6831.28271531492;7167.283271672791;7175.748848790267;7251.274872512707;7358.153812311546;6798.93201067983;6805.557638753465;6807;6808.557443766238;6809.353111454404;5975.25309336333;6004.669743164168;6036.185115009505;6072.908906366408;6172.9074063889075;1676.9664606707797;1728.2309372329444;1777.8577713782865;1785.3394244129495;1804.6932021556368;928.5032507608397;958.242988039455;968.874046373981;1024.5594394410475;1029.3000759483473;16817.41139060127;17986.370477033503;18195;18269.634607308046;18443.72334414985;866.6316815353575;898.1377877237794;907.9636814527477;989.6585677941099;1006.2000709436016;7808.5314881107315;9017;9059.547022648972;9116.1339672731;9176.8623470648;485846;488176;490661;491215;500789;71065.99999999897;71466;74327;75426;80686;1014.9847752283722;1039.4646756920192;1040.6773900090996;1108.695108845058;1144.7367105565766;14419.206943617783;14523.636909077357;14897.627559311104;15194.924025379802;15245;33407.331853363285;35303.823480882435;35771;36570.26859462743;36695.26609467849;42464.51702488476;42924.35613465738;43476.347854782834;45362.54637453715;45714.54285457103;9553.379030363005;9663.178629816544;9723.756906077404;9774.364666296668;9778.217742580435;13746.793798092836;16562.917185413997;17316.480505584852;17581.912090439466;17632.11839407999;14120.929395352958;14212.289385530888;14380.784288235895;14604.12375257488;14961.625959351104;13548.86451135476;13636.65908352299;13707.451701931812;14471.782923255949;14494.130352178903;14460.710785784015;14543.927280363954;14611.269436528344;14809;14920;9315.627374904929;9387.483688397204;9463.195628371666;9491.335606507479;9493.905060949579;11249.718757030812;14238.572842814732;14495.420183192977;14526.63683407881;14562.927185364006 14:18:16 INFO - PROCESS | 25138 | |3;mootools.html;1279.5649479177077;1437.1448987852232;1439.7408466476036;1549.3957356630915;1703.2250326101625;6201.565890387669;6626.834329141774;6666.366695163963;6668.666566671672;6675.232348279949;6563.507736919726;6743.561668491545;6753.02081198226;6775.356341147595;6777.966110169442;1926.1332400419867;1954.912028958693;2088.812006919377;2105.484156381681;2142.571485702858;2122.246602456129;2124.6919196716467;2127.8829664368454;2131.5949969505746;2135.1245989144454;2064.9070791814406;2136;2156.568686262746;2157.2665293800105;2158.9352319430363;2124.0547956159517;2131.5523740014537;2158.4927542027613;2160.8703477791228;2163.5456554123652;2097.4336929029078;2102.737157855268;2126.712893759338;2128.957420851574;2130.1372943957567;6919.723211071551;6977.05809715687;6998.7900362988685;6998.930010699879;7002.929970700278;4177.603127702863;4268.487781466213;4286.549912259199;4287.035417031174;4287.485501739811;2741.4791189674097;2763.157237042701;2785.7075007124163;2794.874230659605;2939.382729626781;972.1153750087386;978.2125389061803;997.1374760831901;1001.8847832499283;1016.755978565139;9129.589168487433;9159.679411220575;9166.083391660848;9186.989431162634;9189.540522973824;3749.2126653403093;3808.771473711586;3812.1422679897355;3816.3702989007056;3857.8842634721004;7830.960845195737;7873.173316801768;7958.045034595885;7973.122956474783;7976.322012628992;4161.729487583298;4193.832246710097;4214.978925105416;4230.5769423057445;4235.576442355801;3891;3892.4161375793856;3897.5517815451585;3898.7075969302414;3900.6294402031763;3139.9058028259187;3192.920176995547;3291.144302481372;3319.518669792915;3321.5848018997626;1056.1603525197486;1063.276971659279;1083.5557421457322;1110.5557776889148;1125.2292179856825;1026.3277553202665;1026.461107918334;1075.977821069971;1143.8055530559825;1280.1998750780763;6372.617642941438;6417.679116044179;6422.903656445157;6432.131662225634;6432.614043157426;1102.7629059752192;1109.2180013090751;1111.6720567432626;1132.8583927009124;1138.9829152562718;4981.775820088033;5038.622103342191;5042.470540593258;5049.96475722476;5063.443021267658;7962.761117166494;8103.635336409876;8260.091389947102;8274.255317021498;8282.71010514629;8157.2250636189465;8185.672573097128;8197.139300373494;8203.138670439517;8214.178582141738;6350.110984462179;6406.135171751847;6628.635425051572;6672;6672.466202703772;6274.780382686584;6318.178636777189;6323.7786677466065;6340.080688300263;6346.07981842621;7275.054242948383;7280.235575264733;7433.962830186031;7434.479586428898;7465.514741541782;7479.401647868049;7502.062242219723;7579.621018949141;7643.388528917784;7644.0827100748265;6101.6644084574;6148.846278843064;6215.409536094064;6251.843703907439;6259.812205633838;5923.289205295392;6299.496040316855;6451.806445806634;6503.349665033648;6688.431483323972;6160.815175544741;6206.534509911684;6240.656763878031;6316.557840951089;6319.557630965788;6099.207103076572;6109.75560977556;6170.598911070766;6187.659678717714;6215.347388524321;6162.414570615784;6178.505719542336;6207.782727604693;6256.124142620128;6256.5620406572925;5718.971405142947;5727.513161381329;5739.282589676291;5749.913751293818;5753.769849205984;5881.235439392852;5894.204282421818;5896.086106653475;5903.61265102692;5914.911276330945 14:18:16 INFO - PROCESS | 25138 | |4;prototype.html;332.710541828609;336.34077208671005;346.2175483407499;347.5655430711611;351.4096318185449;5913;5923.822285331442;5936.851578710534;5962.314333851608;5975.223220981277;5823.5341172706185;5891.057430811071;5891.410858914106;5893.968555502791;5903.321118071423;4596.632269418446;4600.861974140765;4606.769661516928;4609.262517997121;4612.469565999902;4505.414296141514;4609;4612.400387949562;4618.399608050965;4632.374629425035;4546.022605139894;4552.066826300617;4560.498345182027;4565.20108980927;4568.84009059683;4356.106998065421;4452.910941781146;4558.0428110096755;4564.657650676196;4568.565986231302;3910.393888947218;3965.3853652683592;3984.203159368138;3995.1210733638554;3995.380715989026;5600.719964001783;5606.24315717377;5609.1305847593685;5610.158476228557;5630.15547667849;5051.19180931053;5148.845534633967;5159.819406320761;5243.082460569385;5282.65662731925;6186.721597528122;6225.252969643671;6225.844353891143;6240.188775459162;6259.155014073087;4411.889702757425;4416.889577760549;4418.3372494125815;4419.712718673276;4426.62373698236;6479.125318082093;6511.4465270452065;6574.737010519573;6574.868502629968;6583;4478.507364189936;4487.878030492377;4543.704659197141;4544.522825103317;4545.0909818036525;4526.140033393644;4543.568361005699;4562.110388474216;4596.4254468191475;4602.746848923274;5280.973595132;5289.47105289468;5292.576593872481;5296.682199068068;5302.231176479466;6159;6311.779087731908;6324.177856878577;6348.904766428507;6378.712957916905;1637.2714142206842;1668.4077152610892;1669.8163202047765;1671.3231141387514;1671.9164041797862;1136.9204155709187;1140.7775483780583;1143.3025854228913;1144.027576559934;1169.3276366089533;5921.555883308769;5997.2803263607775;6003.21958145447;6012.458878700938;6020.277566692025;6454.935450645434;6459.321771214049;6463.095166676575;6468.838279043061;6470.935290647128;5955.67243801595;5999.340072592011;6009.609375390585;6015.3383127855905;6019.428154325332;3420.264643101695;3521.1373213562842;3524.242287908112;3524.7356448266482;3524.84138213781;6673.866522669519;6680.665966701646;6691.76578819739;6719.832004199934;6721.395074443226;6431.485481161496;6603.174603174603;6672.5329226953645;6691;6695.096162018162;6325.588836725598;6686.09737685416;6736.6631668416385;6777.559458635173;6796.286389928986;6540.084388185753;6547.70535325921;6550.868982620416;6551.44312733423;6569.57297775643;6473.352664733678;6481.254655714653;6483.481321494363;6484.027395890655;6490.707918143789;6625.105610742681;6766.560173588701;6767.35710107539;6774;6777.220619628806;4439.22313595126;4470.262406702857;4479.328100784908;4487.573680500347;4489.506154322957;6534.967325163344;6535.411812936859;6537.542372034102;6548.443382312556;6561.671916404256;6239.313675495601;6381;6382.106505089384;6387.744490220339;6403.29563747978;6288.937110629018;6336.841578960379;6338.112664227104;6354.332795056453;6362.363763623601;6253.593516421418;6264;6264.718087685974;6264.968675156595;6266.185395898687;6224.253089629274;6389.648569328731;6394.200724909387;6404.135441715495;6411.71147298382;6163.445289923929;6192.845178870564;6209.503239740719;6215.65813880241;6215.96892015537 14:18:16 INFO - PROCESS | 25138 | |5;yui.html;838.3083955736515;849.1720572441866;853.5305581929939;867.5185272173941;889.079802404511;13427.530036448727;13637.795433068512;13659.931700341509;13685.589432317034;13694.178349299036;10950.507227174776;12374.133810633259;12735.2995585243;12745.61763147107;12969.675758106052;815.759350991456;822.7531740477833;831.0567505880839;832.4089896173724;832.7127141136328;827.9047909490396;831.7380025292044;833.4832403909585;834.4617721569584;835.2733122183708;859.2266959736256;862.9741107766777;863.2662237098478;865.6580650642992;872.3806097670662;856.751542052804;858.1118542308711;859.5959898847562;860.3848248502288;861.961211745473;634.685830513894;635.7870113511979;636.0840389838618;636.3986033198629;637.3690046853582;11779;12190.81713774294;12193.512259509609;12195.756084878341;12198.451069701885;10760.461976901202;10989.450527473595;11440.19918605698;12300;12599.93700031503;10367.066963973279;10402.271840971134;10448.79102417955;10495.79008419835;10507.894921050845;3615.6565126312958;3666.926661466756;3684.889453316405;3695.6858667013335;3778.6410291022307;40019.199616007805;40874.591254087674;45593.54406455926;46753.29870051918;47724.761376192895;9654.75863103428;9903.851442228372;9923.900760992297;10109.848352274721;10279;16903.492895213163;17303.65392692139;17324;17346.65306693859;17369.2183851727;7629.237076292437;7661.540307581563;7967.442279040411;8038.236367545074;8277.296429803413;4467.419235499429;4512.111141052122;4546.136234115507;4560.065186636732;4613.976930115328;2953.2469220348676;2991.700829916991;2992.521196608576;2993.521036634128;2993.536001919706;572.193207577314;574.052812858778;588.0972706894896;593.4629160609655;594.7888499582673;571.4713889652138;638.0684201066495;650.847050943028;651.235505280089;693.8041099918802;7451.515651482637;7952.84094318122;7953.8409231816195;8029.678812847421;8243.505389676639;592.6562593695646;598.4673640459994;654.165938428498;675.6182756742425;693.2097408953797;3777.8111094445167;3812.4090765931323;3844.519435070616;3868.3423817951016;3921.470601468822;53355;53683.463165367844;57239.71380143073;58067.70966145142;61019;47124.293135602995;48057.27914081291;48499.5150048495;48876.75561622169;49774;41293.72884491322;46213.76893115513;46845.531544684796;47018.294725579144;47341.5265847344;8158.551279679675;8165.183481652025;8324.209200125979;8513.702020429255;8515.31877449815;32704.345913081128;32867.50698739569;34087.4886876702;34497.965061048206;35182.472262915566;42522;42570;42855.3571696431;43729.344059839765;43874.78062609667;9644.228461723185;9703.320767546204;10262.743431414274;10951.56193752241;11117.332960022424;11079.781224065508;11402.258853174517;11410.600628978278;11898.583549575724;11953.940230298793;9818.509074546388;10027.16498999969;10161.695149145537;10185;10353.9482302588;10637.414942178255;10728.463576821285;10742.40916749555;10854.837177442503;10883.510242038968;10859.348439093365;11108.277961932448;11123.110151188048;11301.26541774782;11440.427978601203;9252.907470925205;9418.246540276898;9454.810903782023;9657.613695452103;9724.513774311397;8353.58232088381;8986.955065224633;9232.492212928353;9324.906750932403;9390.154886060014 14:18:16 INFO - PROCESS | 25138 | __end_tp_report 14:18:16 INFO - PROCESS | 25138 | __start_cc_report 14:18:16 INFO - PROCESS | 25138 | _x_x_mozilla_cycle_collect,1847 14:18:16 INFO - PROCESS | 25138 | __end_cc_report 14:18:16 INFO - PROCESS | 25138 | __startTimestamp1451427496884__endTimestamp 14:18:16 INFO - PROCESS | 25138 | 14:18:16 INFO - PROCESS | 25138 | ------- Summary: start ------- 14:18:16 INFO - PROCESS | 25138 | Number of tests: 6 14:18:16 INFO - PROCESS | 25138 | 14:18:16 INFO - PROCESS | 25138 | [#0] dojo.html Cycles:165 Average:5209.58 Median:5457.00 stddev:677.30 (12.4%) stddev-sans-first:658.90 14:18:16 INFO - PROCESS | 25138 | Values: 3102.7 3188.0 3227.8 3228.5 3253.9 5108.9 5188.3 5236.1 5275.7 5309.9 5168.6 5181.4 5192.6 5222.3 5337.4 4775.4 4785.8 4808.6 4869.1 4902.6 443.4 4697.9 4805.0 4805.2 4866.4 4771.8 4786.5 4814.4 4817.3 4872.1 4767.2 4780.7 4791.7 4792.6 4829.3 4726.0 4745.0 4790.2 4809.5 4821.0 5096.4 5116.5 5126.1 5144.6 5158.2 5631.7 5632.7 5637.5 5643.2 5666.9 5560.3 5659.4 5681.6 5686.1 5770.4 5311.4 5343.4 5358.1 5359.6 5363.9 5795.1 5812.3 5826.0 5826.4 5881.1 5438.2 5466.8 5535.7 5535.8 5618.0 5603.2 5632.1 5640.2 5642.1 5653.3 5581.2 5611.4 5626.2 5627.2 5638.0 5485.8 5589.7 5624.9 5658.1 5720.9 4388.7 4390.4 4391.5 4393.1 4398.8 3889.6 3893.4 3933.3 3947.5 3968.1 5187.5 5223.3 5264.3 5264.7 5305.8 5623.4 5671.9 5677.5 5677.9 5679.4 5179.1 5247.8 5268.9 5274.6 5325.1 4804.4 4805.0 4811.9 4828.7 4882.6 5749.6 5749.7 5763.4 5764.1 5766.3 5573.5 5582.1 5582.4 5612.9 5614.0 5729.7 5761.1 5824.9 5825.5 5866.3 5484.6 5507.6 5548.9 5549.1 5560.7 5510.6 5642.2 5643.1 5650.6 5669.2 5508.0 5541.0 5542.0 5542.4 5546.5 5412.0 5439.6 5454.7 5459.5 5465.6 5440.5 5457.0 5457.3 5458.9 5460.0 5547.9 5566.1 5576.0 5684.9 5688.1 5424.8 5429.5 5459.5 5464.9 5509.3 14:18:16 INFO - PROCESS | 25138 | 14:18:16 INFO - PROCESS | 25138 | [#1] ext.html Cycles:180 Average:43896.80 Median:32053.26 stddev:73399.91 (229.0%) stddev-sans-first:73533.50 14:18:16 INFO - PROCESS | 25138 | Values: 502.8 514.8 527.6 534.0 556.0 28135.0 28923.6 34531.3 35260.3 35480.0 37875.6 38317.6 38393.2 38426.2 38436.4 7314.2 8227.3 8483.7 8495.4 8509.5 7273.9 10016.3 10201.4 10213.6 10217.6 9876.9 10008.1 10011.6 10021.4 10024.4 7442.4 7662.5 9891.3 9987.8 10040.8 9734.5 9860.1 9865.5 9866.3 9869.9 35343.0 35733.8 35829.1 35851.0 35853.8 3304.6 3314.1 3347.1 3635.6 4083.6 28652.4 29544.0 29713.3 30387.5 30928.1 3907.2 3970.7 3990.4 4100.8 4158.6 247122.0 247519.0 248666.0 248775.0 249002.0 49256.3 50386.2 54835.0 55182.7 55195.0 59200.0 60793.7 61266.0 61267.0 61270.4 13728.7 13860.7 13946.8 14003.9 14016.9 10145.5 10184.3 10233.6 10234.8 10249.7 18454.7 18507.5 18570.2 18622.5 18628.2 6834.1 6979.4 7132.5 7132.9 7179.2 924.4 968.4 1003.8 1022.7 1038.9 24886.8 27917.4 28288.4 28381.0 28801.4 1039.5 1039.6 1077.9 1088.4 1095.5 13920.7 13986.9 14135.2 14197.5 14247.6 299569.0 301900.0 304395.0 304814.0 305764.0 48729.5 49142.0 49149.0 49177.3 49186.8 1324.1 1326.9 1333.4 1337.1 1342.3 25877.5 27116.8 27189.6 27442.6 27491.7 43705.8 44098.6 44349.6 44361.3 44376.0 282677.0 288895.0 289550.0 290240.0 290424.0 26768.6 27204.6 29142.7 30353.0 31060.0 35505.5 35911.8 36436.8 36448.5 38621.2 33349.5 33676.3 33864.8 33983.5 34386.5 27521.6 31208.8 33258.8 33937.8 34753.0 32435.7 34277.8 34520.1 34645.0 34763.0 28480.7 31166.8 31264.7 31504.7 31670.8 23975.9 23998.6 24040.8 24112.6 24263.6 14:18:16 INFO - PROCESS | 25138 | 14:18:16 INFO - PROCESS | 25138 | [#2] jquery.html Cycles:180 Average:27392.62 Median:361.52 stddev:80242.88 (22195.8%) stddev-sans-first:80442.30 14:18:16 INFO - PROCESS | 25138 | Values: 355.5 359.0 360.4 362.7 363.3 14623.6 14726.4 16308.5 16367.3 16909.0 14615.3 15059.3 15405.2 15406.3 15423.2 5309.1 5420.9 5429.3 5433.4 5452.7 4057.6 4164.1 5383.8 5426.3 5786.3 5952.5 5974.9 5976.5 6013.4 6026.2 5833.4 5974.1 6003.8 6004.5 6005.8 5214.6 5302.9 5312.3 5322.2 5329.1 19503.3 20798.9 21103.8 21944.1 21961.5 2130.8 2223.3 2260.8 2297.0 2342.2 12652.8 13125.3 13157.7 13351.9 13966.1 1683.7 1782.2 1787.2 1823.7 1826.6 57314.0 60753.0 62251.0 62467.0 62654.7 9700.3 9846.5 9955.8 10021.6 10038.3 13347.1 13361.3 13372.1 13384.1 13392.4 6831.3 7167.3 7175.7 7251.3 7358.2 6798.9 6805.6 6807.0 6808.6 6809.4 5975.3 6004.7 6036.2 6072.9 6172.9 1677.0 1728.2 1777.9 1785.3 1804.7 928.5 958.2 968.9 1024.6 1029.3 16817.4 17986.4 18195.0 18269.6 18443.7 866.6 898.1 908.0 989.7 1006.2 7808.5 9017.0 9059.5 9116.1 9176.9 485846.0 488176.0 490661.0 491215.0 500789.0 71066.0 71466.0 74327.0 75426.0 80686.0 1015.0 1039.5 1040.7 1108.7 1144.7 14419.2 14523.6 14897.6 15194.9 15245.0 33407.3 35303.8 35771.0 36570.3 36695.3 42464.5 42924.4 43476.3 45362.5 45714.5 9553.4 9663.2 9723.8 9774.4 9778.2 13746.8 16562.9 17316.5 17581.9 17632.1 14120.9 14212.3 14380.8 14604.1 14961.6 13548.9 13636.7 13707.5 14471.8 14494.1 14460.7 14543.9 14611.3 14809.0 14920.0 9315.6 9387.5 9463.2 9491.3 9493.9 11249.7 14238.6 14495.4 14526.6 14562.9 14:18:16 INFO - PROCESS | 25138 | 14:18:16 INFO - PROCESS | 25138 | [#3] mootools.html Cycles:180 Average:4844.71 Median:5909.26 stddev:2419.41 (40.9%) stddev-sans-first:2411.35 14:18:16 INFO - PROCESS | 25138 | Values: 1279.6 1437.1 1439.7 1549.4 1703.2 6201.6 6626.8 6666.4 6668.7 6675.2 6563.5 6743.6 6753.0 6775.4 6778.0 1926.1 1954.9 2088.8 2105.5 2142.6 2122.2 2124.7 2127.9 2131.6 2135.1 2064.9 2136.0 2156.6 2157.3 2158.9 2124.1 2131.6 2158.5 2160.9 2163.5 2097.4 2102.7 2126.7 2129.0 2130.1 6919.7 6977.1 6998.8 6998.9 7002.9 4177.6 4268.5 4286.5 4287.0 4287.5 2741.5 2763.2 2785.7 2794.9 2939.4 972.1 978.2 997.1 1001.9 1016.8 9129.6 9159.7 9166.1 9187.0 9189.5 3749.2 3808.8 3812.1 3816.4 3857.9 7831.0 7873.2 7958.0 7973.1 7976.3 4161.7 4193.8 4215.0 4230.6 4235.6 3891.0 3892.4 3897.6 3898.7 3900.6 3139.9 3192.9 3291.1 3319.5 3321.6 1056.2 1063.3 1083.6 1110.6 1125.2 1026.3 1026.5 1076.0 1143.8 1280.2 6372.6 6417.7 6422.9 6432.1 6432.6 1102.8 1109.2 1111.7 1132.9 1139.0 4981.8 5038.6 5042.5 5050.0 5063.4 7962.8 8103.6 8260.1 8274.3 8282.7 8157.2 8185.7 8197.1 8203.1 8214.2 6350.1 6406.1 6628.6 6672.0 6672.5 6274.8 6318.2 6323.8 6340.1 6346.1 7275.1 7280.2 7434.0 7434.5 7465.5 7479.4 7502.1 7579.6 7643.4 7644.1 6101.7 6148.8 6215.4 6251.8 6259.8 5923.3 6299.5 6451.8 6503.3 6688.4 6160.8 6206.5 6240.7 6316.6 6319.6 6099.2 6109.8 6170.6 6187.7 6215.3 6162.4 6178.5 6207.8 6256.1 6256.6 5719.0 5727.5 5739.3 5749.9 5753.8 5881.2 5894.2 5896.1 5903.6 5914.9 14:18:16 INFO - PROCESS | 25138 | 14:18:16 INFO - PROCESS | 25138 | [#4] prototype.html Cycles:180 Average:5281.14 Median:5968.77 stddev:1574.07 (26.4%) stddev-sans-first:1534.04 14:18:16 INFO - PROCESS | 25138 | Values: 332.7 336.3 346.2 347.6 351.4 5913.0 5923.8 5936.9 5962.3 5975.2 5823.5 5891.1 5891.4 5894.0 5903.3 4596.6 4600.9 4606.8 4609.3 4612.5 4505.4 4609.0 4612.4 4618.4 4632.4 4546.0 4552.1 4560.5 4565.2 4568.8 4356.1 4452.9 4558.0 4564.7 4568.6 3910.4 3965.4 3984.2 3995.1 3995.4 5600.7 5606.2 5609.1 5610.2 5630.2 5051.2 5148.8 5159.8 5243.1 5282.7 6186.7 6225.3 6225.8 6240.2 6259.2 4411.9 4416.9 4418.3 4419.7 4426.6 6479.1 6511.4 6574.7 6574.9 6583.0 4478.5 4487.9 4543.7 4544.5 4545.1 4526.1 4543.6 4562.1 4596.4 4602.7 5281.0 5289.5 5292.6 5296.7 5302.2 6159.0 6311.8 6324.2 6348.9 6378.7 1637.3 1668.4 1669.8 1671.3 1671.9 1136.9 1140.8 1143.3 1144.0 1169.3 5921.6 5997.3 6003.2 6012.5 6020.3 6454.9 6459.3 6463.1 6468.8 6470.9 5955.7 5999.3 6009.6 6015.3 6019.4 3420.3 3521.1 3524.2 3524.7 3524.8 6673.9 6680.7 6691.8 6719.8 6721.4 6431.5 6603.2 6672.5 6691.0 6695.1 6325.6 6686.1 6736.7 6777.6 6796.3 6540.1 6547.7 6550.9 6551.4 6569.6 6473.4 6481.3 6483.5 6484.0 6490.7 6625.1 6766.6 6767.4 6774.0 6777.2 4439.2 4470.3 4479.3 4487.6 4489.5 6535.0 6535.4 6537.5 6548.4 6561.7 6239.3 6381.0 6382.1 6387.7 6403.3 6288.9 6336.8 6338.1 6354.3 6362.4 6253.6 6264.0 6264.7 6265.0 6266.2 6224.3 6389.6 6394.2 6404.1 6411.7 6163.4 6192.8 6209.5 6215.7 6216.0 14:18:16 INFO - PROCESS | 25138 | 14:18:16 INFO - PROCESS | 25138 | [#5] yui.html Cycles:180 Average:13274.95 Median:46931.91 stddev:15349.13 (32.7%) stddev-sans-first:15363.77 14:18:16 INFO - PROCESS | 25138 | Values: 838.3 849.2 853.5 867.5 889.1 13427.5 13637.8 13659.9 13685.6 13694.2 10950.5 12374.1 12735.3 12745.6 12969.7 815.8 822.8 831.1 832.4 832.7 827.9 831.7 833.5 834.5 835.3 859.2 863.0 863.3 865.7 872.4 856.8 858.1 859.6 860.4 862.0 634.7 635.8 636.1 636.4 637.4 11779.0 12190.8 12193.5 12195.8 12198.5 10760.5 10989.5 11440.2 12300.0 12599.9 10367.1 10402.3 10448.8 10495.8 10507.9 3615.7 3666.9 3684.9 3695.7 3778.6 40019.2 40874.6 45593.5 46753.3 47724.8 9654.8 9903.9 9923.9 10109.8 10279.0 16903.5 17303.7 17324.0 17346.7 17369.2 7629.2 7661.5 7967.4 8038.2 8277.3 4467.4 4512.1 4546.1 4560.1 4614.0 2953.2 2991.7 2992.5 2993.5 2993.5 572.2 574.1 588.1 593.5 594.8 571.5 638.1 650.8 651.2 693.8 7451.5 7952.8 7953.8 8029.7 8243.5 592.7 598.5 654.2 675.6 693.2 3777.8 3812.4 3844.5 3868.3 3921.5 53355.0 53683.5 57239.7 58067.7 61019.0 47124.3 48057.3 48499.5 48876.8 49774.0 41293.7 46213.8 46845.5 47018.3 47341.5 8158.6 8165.2 8324.2 8513.7 8515.3 32704.3 32867.5 34087.5 34498.0 35182.5 42522.0 42570.0 42855.4 43729.3 43874.8 9644.2 9703.3 10262.7 10951.6 11117.3 11079.8 11402.3 11410.6 11898.6 11953.9 9818.5 10027.2 10161.7 10185.0 10353.9 10637.4 10728.5 10742.4 10854.8 10883.5 10859.3 11108.3 11123.1 11301.3 11440.4 9252.9 9418.2 9454.8 9657.6 9724.5 8353.6 8987.0 9232.5 9324.9 9390.2 14:18:16 INFO - PROCESS | 25138 | -------- Summary: end -------- 14:18:16 INFO - PROCESS | 25138 | 14:18:17 INFO - TEST-INFO | 25138: exit 0 14:18:17 INFO - TEST-OK | dromaeo_css | took 1112874ms 14:18:17 INFO - TEST-START | kraken 14:18:17 INFO - operating with platform_type : linux_ 14:18:17 INFO - Initialising browser for kraken test... 14:18:17 INFO - TEST-INFO | started process 25331 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1YYIwu/profile http://localhost:32985/getInfo.html) 14:18:21 INFO - PROCESS | 25331 | __metrics Screen width/height:1600/1200 14:18:21 INFO - PROCESS | 25331 | colorDepth:24 14:18:21 INFO - PROCESS | 25331 | Browser inner width/height: 1024/697 14:18:21 INFO - PROCESS | 25331 | __metrics 14:18:21 INFO - PROCESS | 25331 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:18:21 INFO - PROCESS | 25331 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:18:22 INFO - TEST-INFO | 25331: exit 0 14:18:22 INFO - Browser initialized. 14:18:22 INFO - Running cycle 1/1 for kraken test... 14:18:22 INFO - TEST-INFO | started process 25413 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1YYIwu/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:18:34 INFO - PROCESS | 25413 | RSS: Main: 150454272 14:18:34 INFO - PROCESS | 25413 | 14:18:37 INFO - PROCESS | 25413 | Cycle 1(1): loaded http://localhost:32985/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32985/tests/kraken/driver.html?testName=audio-beat-detection) 14:18:37 INFO - PROCESS | 25413 | RSS: Main: 183287808 14:18:37 INFO - PROCESS | 25413 | 14:18:40 INFO - PROCESS | 25413 | Cycle 1(1): loaded http://localhost:32985/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32985/tests/kraken/driver.html?testName=audio-dft) 14:18:40 INFO - PROCESS | 25413 | RSS: Main: 172572672 14:18:40 INFO - PROCESS | 25413 | 14:18:43 INFO - PROCESS | 25413 | Cycle 1(1): loaded http://localhost:32985/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32985/tests/kraken/driver.html?testName=audio-fft) 14:18:44 INFO - PROCESS | 25413 | RSS: Main: 160624640 14:18:44 INFO - PROCESS | 25413 | 14:18:46 INFO - PROCESS | 25413 | Cycle 1(1): loaded http://localhost:32985/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32985/tests/kraken/driver.html?testName=audio-oscillator) 14:18:46 INFO - PROCESS | 25413 | RSS: Main: 161218560 14:18:46 INFO - PROCESS | 25413 | 14:18:49 INFO - PROCESS | 25413 | Cycle 1(1): loaded http://localhost:32985/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32985/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:18:49 INFO - PROCESS | 25413 | RSS: Main: 163139584 14:18:49 INFO - PROCESS | 25413 | 14:18:52 INFO - PROCESS | 25413 | Cycle 1(1): loaded http://localhost:32985/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32985/tests/kraken/driver.html?testName=imaging-darkroom) 14:18:53 INFO - PROCESS | 25413 | RSS: Main: 163540992 14:18:53 INFO - PROCESS | 25413 | 14:18:56 INFO - PROCESS | 25413 | Cycle 1(1): loaded http://localhost:32985/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32985/tests/kraken/driver.html?testName=imaging-desaturate) 14:18:57 INFO - PROCESS | 25413 | RSS: Main: 164503552 14:18:57 INFO - PROCESS | 25413 | 14:18:59 INFO - PROCESS | 25413 | Cycle 1(1): loaded http://localhost:32985/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32985/tests/kraken/driver.html?testName=json-parse-financial) 14:19:00 INFO - PROCESS | 25413 | RSS: Main: 164663296 14:19:00 INFO - PROCESS | 25413 | 14:19:02 INFO - PROCESS | 25413 | Cycle 1(1): loaded http://localhost:32985/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32985/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:19:02 INFO - PROCESS | 25413 | RSS: Main: 176848896 14:19:02 INFO - PROCESS | 25413 | 14:19:04 INFO - PROCESS | 25413 | Cycle 1(1): loaded http://localhost:32985/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32985/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:19:05 INFO - PROCESS | 25413 | RSS: Main: 174739456 14:19:05 INFO - PROCESS | 25413 | 14:19:07 INFO - PROCESS | 25413 | Cycle 1(1): loaded http://localhost:32985/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32985/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:19:07 INFO - PROCESS | 25413 | RSS: Main: 181919744 14:19:07 INFO - PROCESS | 25413 | 14:19:10 INFO - PROCESS | 25413 | Cycle 1(1): loaded http://localhost:32985/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32985/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:19:10 INFO - PROCESS | 25413 | RSS: Main: 191700992 14:19:10 INFO - PROCESS | 25413 | 14:19:13 INFO - PROCESS | 25413 | Cycle 1(1): loaded http://localhost:32985/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32985/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:19:13 INFO - PROCESS | 25413 | RSS: Main: 189136896 14:19:13 INFO - PROCESS | 25413 | 14:19:15 INFO - PROCESS | 25413 | Cycle 1(1): loaded http://localhost:32985/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32985/tests/kraken/driver.html?testName=ai-astar) 14:19:15 INFO - PROCESS | 25413 | RSS: Main: 247115776 14:19:15 INFO - PROCESS | 25413 | 14:19:15 INFO - PROCESS | 25413 | __start_tp_report 14:19:15 INFO - PROCESS | 25413 | _x_x_mozilla_page_load 14:19:15 INFO - PROCESS | 25413 | _x_x_mozilla_page_load_details 14:19:15 INFO - PROCESS | 25413 | |i|pagename|runs| 14:19:15 INFO - PROCESS | 25413 | |0;ai-astar;110;112;104;111;111;111;102;111;112;104 14:19:15 INFO - PROCESS | 25413 | |1;audio-beat-detection;150;124;148;161;128;150;157;124;166;131 14:19:15 INFO - PROCESS | 25413 | |2;audio-dft;161;161;160;161;165;161;161;160;161;161 14:19:15 INFO - PROCESS | 25413 | |3;audio-fft;74;72;86;94;74;73;71;100;98;71 14:19:15 INFO - PROCESS | 25413 | |4;audio-oscillator;98;96;139;96;96;98;142;98;96;136 14:19:15 INFO - PROCESS | 25413 | |5;imaging-gaussian-blur;109;109;109;109;110;110;109;109;109;110 14:19:15 INFO - PROCESS | 25413 | |6;imaging-darkroom;146;147;146;146;146;146;147;145;147;146 14:19:15 INFO - PROCESS | 25413 | |7;imaging-desaturate;95;96;96;96;96;96;97;97;96;96 14:19:15 INFO - PROCESS | 25413 | |8;json-parse-financial;66;58;58;57;58;57;58;58;60;57 14:19:15 INFO - PROCESS | 25413 | |9;json-stringify-tinderbox;69;69;68;68;67;68;68;68;68;68 14:19:15 INFO - PROCESS | 25413 | |10;stanford-crypto-aes;84;85;86;94;85;85;87;94;95;89 14:19:15 INFO - PROCESS | 25413 | |11;stanford-crypto-ccm;116;122;125;123;128;125;120;119;119;118 14:19:15 INFO - PROCESS | 25413 | |12;stanford-crypto-pbkdf2;141;152;152;152;150;140;150;152;150;142 14:19:15 INFO - PROCESS | 25413 | |13;stanford-crypto-sha256-iterative;70;71;67;68;69;68;69;67;67;68 14:19:15 INFO - PROCESS | 25413 | __end_tp_report 14:19:15 INFO - PROCESS | 25413 | __start_cc_report 14:19:15 INFO - PROCESS | 25413 | _x_x_mozilla_cycle_collect,934 14:19:15 INFO - PROCESS | 25413 | __end_cc_report 14:19:15 INFO - PROCESS | 25413 | __startTimestamp1451427555758__endTimestamp 14:19:15 INFO - PROCESS | 25413 | 14:19:15 INFO - PROCESS | 25413 | ------- Summary: start ------- 14:19:15 INFO - PROCESS | 25413 | Number of tests: 14 14:19:15 INFO - PROCESS | 25413 | 14:19:15 INFO - PROCESS | 25413 | [#0] ai-astar Cycles:10 Average:108.80 Median:111.00 stddev:3.85 (3.5%) stddev-sans-first:4.06 14:19:15 INFO - PROCESS | 25413 | Values: 110.0 112.0 104.0 111.0 111.0 111.0 102.0 111.0 112.0 104.0 14:19:15 INFO - PROCESS | 25413 | 14:19:15 INFO - PROCESS | 25413 | [#1] audio-beat-detection Cycles:10 Average:143.90 Median:150.00 stddev:15.83 (10.6%) stddev-sans-first:16.63 14:19:15 INFO - PROCESS | 25413 | Values: 150.0 124.0 148.0 161.0 128.0 150.0 157.0 124.0 166.0 131.0 14:19:15 INFO - PROCESS | 25413 | 14:19:15 INFO - PROCESS | 25413 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.40 (0.9%) stddev-sans-first:1.48 14:19:15 INFO - PROCESS | 25413 | Values: 161.0 161.0 160.0 161.0 165.0 161.0 161.0 160.0 161.0 161.0 14:19:15 INFO - PROCESS | 25413 | 14:19:15 INFO - PROCESS | 25413 | [#3] audio-fft Cycles:10 Average:81.30 Median:74.00 stddev:11.95 (16.2%) stddev-sans-first:12.38 14:19:15 INFO - PROCESS | 25413 | Values: 74.0 72.0 86.0 94.0 74.0 73.0 71.0 100.0 98.0 71.0 14:19:15 INFO - PROCESS | 25413 | 14:19:15 INFO - PROCESS | 25413 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:96.00 stddev:20.42 (21.3%) stddev-sans-first:21.24 14:19:15 INFO - PROCESS | 25413 | Values: 98.0 96.0 139.0 96.0 96.0 98.0 142.0 98.0 96.0 136.0 14:19:15 INFO - PROCESS | 25413 | 14:19:15 INFO - PROCESS | 25413 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 14:19:15 INFO - PROCESS | 25413 | Values: 109.0 109.0 109.0 109.0 110.0 110.0 109.0 109.0 109.0 110.0 14:19:15 INFO - PROCESS | 25413 | 14:19:15 INFO - PROCESS | 25413 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 14:19:15 INFO - PROCESS | 25413 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 147.0 145.0 147.0 146.0 14:19:15 INFO - PROCESS | 25413 | 14:19:15 INFO - PROCESS | 25413 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 14:19:15 INFO - PROCESS | 25413 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 97.0 97.0 96.0 96.0 14:19:15 INFO - PROCESS | 25413 | 14:19:15 INFO - PROCESS | 25413 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:58.00 stddev:2.71 (4.7%) stddev-sans-first:0.93 14:19:15 INFO - PROCESS | 25413 | Values: 66.0 58.0 58.0 57.0 58.0 57.0 58.0 58.0 60.0 57.0 14:19:15 INFO - PROCESS | 25413 | 14:19:15 INFO - PROCESS | 25413 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.50 14:19:15 INFO - PROCESS | 25413 | Values: 69.0 69.0 68.0 68.0 67.0 68.0 68.0 68.0 68.0 68.0 14:19:15 INFO - PROCESS | 25413 | 14:19:15 INFO - PROCESS | 25413 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:88.00 stddev:4.33 (4.9%) stddev-sans-first:4.28 14:19:15 INFO - PROCESS | 25413 | Values: 84.0 85.0 86.0 94.0 85.0 85.0 87.0 94.0 95.0 89.0 14:19:15 INFO - PROCESS | 25413 | 14:19:15 INFO - PROCESS | 25413 | [#11] stanford-crypto-ccm Cycles:10 Average:121.50 Median:122.50 stddev:3.75 (3.1%) stddev-sans-first:3.41 14:19:15 INFO - PROCESS | 25413 | Values: 116.0 122.0 125.0 123.0 128.0 125.0 120.0 119.0 119.0 118.0 14:19:15 INFO - PROCESS | 25413 | 14:19:15 INFO - PROCESS | 25413 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.10 Median:151.00 stddev:5.00 (3.3%) stddev-sans-first:4.59 14:19:15 INFO - PROCESS | 25413 | Values: 141.0 152.0 152.0 152.0 150.0 140.0 150.0 152.0 150.0 142.0 14:19:15 INFO - PROCESS | 25413 | 14:19:15 INFO - PROCESS | 25413 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:1.35 (2.0%) stddev-sans-first:1.30 14:19:15 INFO - PROCESS | 25413 | Values: 70.0 71.0 67.0 68.0 69.0 68.0 69.0 67.0 67.0 68.0 14:19:15 INFO - PROCESS | 25413 | -------- Summary: end -------- 14:19:15 INFO - PROCESS | 25413 | 14:19:16 INFO - TEST-INFO | 25413: exit 0 14:19:16 INFO - TEST-OK | kraken | took 59161ms 14:19:16 INFO - TEST-START | v8_7 14:19:16 INFO - operating with platform_type : linux_ 14:19:16 INFO - Initialising browser for v8_7 test... 14:19:16 INFO - TEST-INFO | started process 25660 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeK8hZu/profile http://localhost:32985/getInfo.html) 14:19:21 INFO - PROCESS | 25660 | __metrics Screen width/height:1600/1200 14:19:21 INFO - PROCESS | 25660 | colorDepth:24 14:19:21 INFO - PROCESS | 25660 | Browser inner width/height: 1024/697 14:19:21 INFO - PROCESS | 25660 | __metrics 14:19:21 INFO - PROCESS | 25660 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:19:21 INFO - PROCESS | 25660 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:19:21 INFO - TEST-INFO | 25660: exit 0 14:19:21 INFO - Browser initialized. 14:19:21 INFO - Running cycle 1/1 for v8_7 test... 14:19:21 INFO - TEST-INFO | started process 25745 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeK8hZu/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:19:33 INFO - PROCESS | 25745 | RSS: Main: 149426176 14:19:33 INFO - PROCESS | 25745 | 14:19:55 INFO - PROCESS | 25745 | Cycle 1(1): loaded http://localhost:32985/tests/v8_7/run.html (next: http://localhost:32985/tests/v8_7/run.html) 14:19:55 INFO - PROCESS | 25745 | RSS: Main: 543510528 14:19:55 INFO - PROCESS | 25745 | 14:19:55 INFO - PROCESS | 25745 | __start_tp_report 14:19:55 INFO - PROCESS | 25745 | _x_x_mozilla_page_load 14:19:55 INFO - PROCESS | 25745 | _x_x_mozilla_page_load_details 14:19:55 INFO - PROCESS | 25745 | |i|pagename|runs| 14:19:55 INFO - PROCESS | 25745 | |0;Richards;169.7792869269949 14:19:55 INFO - PROCESS | 25745 | |1;DeltaBlue;197.43336623889437 14:19:55 INFO - PROCESS | 25745 | |2;Encrypt;286.20492272467084 14:19:55 INFO - PROCESS | 25745 | |3;Decrypt;5268.421052631579 14:19:55 INFO - PROCESS | 25745 | |4;RayTrace;1118.5682326621925 14:19:55 INFO - PROCESS | 25745 | |5;Earley;799.3605115907275 14:19:55 INFO - PROCESS | 25745 | |6;Boyer;12329.268292682927 14:19:55 INFO - PROCESS | 25745 | |7;RegExp;26868.42105263158 14:19:55 INFO - PROCESS | 25745 | |8;Splay;597.0149253731344 14:19:55 INFO - PROCESS | 25745 | |9;NavierStokes;4850.241545893719 14:19:55 INFO - PROCESS | 25745 | __end_tp_report 14:19:55 INFO - PROCESS | 25745 | __startTimestamp1451427595323__endTimestamp 14:19:55 INFO - PROCESS | 25745 | 14:19:55 INFO - PROCESS | 25745 | ------- Summary: start ------- 14:19:55 INFO - PROCESS | 25745 | Number of tests: 10 14:19:55 INFO - PROCESS | 25745 | 14:19:55 INFO - PROCESS | 25745 | [#0] Richards Cycles:1 Average:169.78 Median:169.78 stddev:0.00 (0.0%) 14:19:55 INFO - PROCESS | 25745 | Values: 169.8 14:19:55 INFO - PROCESS | 25745 | 14:19:55 INFO - PROCESS | 25745 | [#1] DeltaBlue Cycles:1 Average:197.43 Median:197.43 stddev:0.00 (0.0%) 14:19:55 INFO - PROCESS | 25745 | Values: 197.4 14:19:55 INFO - PROCESS | 25745 | 14:19:55 INFO - PROCESS | 25745 | [#2] Encrypt Cycles:1 Average:286.20 Median:286.20 stddev:0.00 (0.0%) 14:19:55 INFO - PROCESS | 25745 | Values: 286.2 14:19:55 INFO - PROCESS | 25745 | 14:19:55 INFO - PROCESS | 25745 | [#3] Decrypt Cycles:1 Average:5268.42 Median:5268.42 stddev:0.00 (0.0%) 14:19:55 INFO - PROCESS | 25745 | Values: 5268.4 14:19:55 INFO - PROCESS | 25745 | 14:19:55 INFO - PROCESS | 25745 | [#4] RayTrace Cycles:1 Average:1118.57 Median:1118.57 stddev:0.00 (0.0%) 14:19:55 INFO - PROCESS | 25745 | Values: 1118.6 14:19:55 INFO - PROCESS | 25745 | 14:19:55 INFO - PROCESS | 25745 | [#5] Earley Cycles:1 Average:799.36 Median:799.36 stddev:0.00 (0.0%) 14:19:55 INFO - PROCESS | 25745 | Values: 799.4 14:19:55 INFO - PROCESS | 25745 | 14:19:55 INFO - PROCESS | 25745 | [#6] Boyer Cycles:1 Average:12329.27 Median:12329.27 stddev:0.00 (0.0%) 14:19:55 INFO - PROCESS | 25745 | Values: 12329.3 14:19:55 INFO - PROCESS | 25745 | 14:19:55 INFO - PROCESS | 25745 | [#7] RegExp Cycles:1 Average:26868.42 Median:26868.42 stddev:0.00 (0.0%) 14:19:55 INFO - PROCESS | 25745 | Values: 26868.4 14:19:55 INFO - PROCESS | 25745 | 14:19:55 INFO - PROCESS | 25745 | [#8] Splay Cycles:1 Average:597.01 Median:597.01 stddev:0.00 (0.0%) 14:19:55 INFO - PROCESS | 25745 | Values: 597.0 14:19:55 INFO - PROCESS | 25745 | 14:19:55 INFO - PROCESS | 25745 | [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 14:19:55 INFO - PROCESS | 25745 | Values: 4850.2 14:19:55 INFO - PROCESS | 25745 | -------- Summary: end -------- 14:19:55 INFO - PROCESS | 25745 | 14:19:56 INFO - TEST-INFO | 25745: exit 0 14:19:56 INFO - TEST-OK | v8_7 | took 39379ms 14:19:56 INFO - SUITE-END | took 1211s 14:19:56 INFO - Completed test suite (00:20:11) 14:19:56 INFO - Working with test: dromaeo_css 14:19:56 INFO - Generating results file: dromaeo_css 14:19:56 INFO - Working with test: kraken 14:19:56 INFO - Generating results file: kraken 14:19:56 INFO - javascript benchmark 14:19:56 INFO - Working with test: v8_7 14:19:56 INFO - Generating results file: v8_7 14:19:56 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:19:56 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 14:19:56 INFO - process_Request line: dromaeo_css 6786.13 graph.html#tests=[[72,64,35]] 14:19:56 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:19:56 INFO - process_Request line: kraken 1509.50 graph.html#tests=[[232,64,35]] 14:19:56 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:19:56 INFO - process_Request line: v8_7 20692.25 graph.html#tests=[[230,64,35]] 14:19:56 INFO - RETURN: dromaeo_css: 6786.13 14:19:56 INFO - RETURN: kraken: 1509.50 14:19:56 INFO - RETURN: v8_7: 20692.25 14:19:56 INFO - javascript benchmark 14:19:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3102.7362674172696, 3187.968120318796, 3227.790193637415, 3228.54800327954, 3253.902382928513, 5108.948910510894, 5188.325517682696, 5236.136037553803, 5275.683458992458, 5309.946900530994, 5168.560672342846, 5181.4300426953005, 5192.584593232542, 5222.294990176325, 5337.412884582693, 4775.355327030849, 4785.784639691205, 4808.615310775147, 4869.099216644914, 4902.58328042115, 443.4240390108097, 4697.929531057037, 4804.951950480503, 4805.231163013918, 4866.416030076396, 4771.8091276348905, 4786.52134786522, 4814.446338671028, 4817.349657796188, 4872.123017856767, 4767.189577771787, 4780.689255198401, 4791.688540244873, 4792.616590672737, 4829.299751536043, 4725.952740472586, 4744.952550474485, 4790.209615413452, 4809.5430934061205, 4821.035792841446, 5096.362954630671, 5116.488351164891, 5126.051680439131, 5144.588432925357, 5158.1746920492915, 5631.690257035862, 5632.718364081779, 5637.548996080344, 5643.153526970947, 5666.943330566683, 5560.304961879765, 5659.40576239493, 5681.630694004918, 5686.0617998030275, 5770.422957704238, 5311.389190243133, 5343.412224655285, 5358.115910874701, 5359.598030147716, 5363.919541206885, 5795.1017592273265, 5812.331581868139, 5826.038703613856, 5826.388229235954, 5881.1178323251, 5438.238646589481, 5466.835994920159, 5535.6955367454375, 5535.833924982257, 5617.9719101404235, 5603.215549823028, 5632.070708333079, 5640.210370548127, 5642.097264437671, 5653.293338332708, 5581.246531718247, 5611.382747897728, 5626.1842032905, 5627.155926610959, 5638.04153293941, 5485.753141108659, 5589.74846131925, 5624.859378515488, 5658.094704847204, 5720.856978575485, 4388.670849686287, 4390.429244198233, 4391.494978077562, 4393.080897586315, 4398.758068306274, 3889.6499315061214, 3893.435451859521, 3933.272344616255, 3947.50656167979, 3968.146848427602, 5187.481251874858, 5223.2948551945, 5264.289320941624, 5264.657797243167, 5305.840824775263, 5623.381428042912, 5671.8865622688145, 5677.460641239076, 5677.886442271131, 5679.432056794288, 5179.093658609729, 5247.816326428557, 5268.868278292996, 5274.630775845731, 5325.121354976385, 4804.447488538793, 4804.95195048052, 4811.903761924742, 4828.686135401188, 4882.5605695487575, 5749.597528173072, 5749.655020698688, 5763.366029736726, 5764.13537969308, 5766.336871259775, 5573.526250268773, 5582.106862901916, 5582.441755824385, 5612.887742245214, 5614.045612245846, 5729.656220626775, 5761.107028410603, 5824.94175058244, 5825.533957283492, 5866.325372582037, 5484.588655850747, 5507.586930980273, 5548.861278468071, 5549.112142057252, 5560.694161820977, 5510.559155267649, 5642.153676948491, 5643.097104463266, 5650.63270887391, 5669.234653321749, 5508.0, 5541.0, 5542.0301447245765, 5542.445755424425, 5546.473085056913, 5411.972940135274, 5439.646422982493, 5454.699991500505, 5459.535939445192, 5465.59008074388, 5440.537554307928, 5457.0, 5457.345118585795, 5458.880929409541, 5459.972700136474, 5547.8890422192135, 5566.137248726453, 5575.972120139373, 5684.857878553069, 5688.061469857427, 5424.810131645373, 5429.457054294539, 5459.535939445032, 5464.890702186013, 5509.256250406143], "unit": "score", "name": "dojo.html", "value": 5168.861538137569}, {"lowerIsBetter": false, "replicates": [502.7637010605016, 514.7966553211481, 527.5963887625966, 534.0147427995349, 555.9805406810757, 28135.0, 28923.566146507794, 34531.30937381254, 35260.294794104106, 35480.0, 37875.62124378755, 38317.61682383182, 38393.23213535728, 38426.23147537054, 38436.42345364822, 7314.195438501761, 8227.341812654988, 8483.66065357385, 8495.447795893278, 8509.489430634181, 7273.927260727378, 10016.298859079867, 10201.43892085935, 10213.642522511713, 10217.642382516613, 9876.901230987705, 10008.099271065603, 10011.649592264272, 10021.44882031488, 10024.448655323955, 7442.441816863757, 7662.540247585107, 9891.25815563832, 9987.80024399508, 10040.799184016352, 9734.513274336256, 9860.112589866874, 9865.506724663737, 9866.26003049767, 9869.851952220723, 35343.0, 35733.821330893436, 35829.10427239314, 35851.0, 35853.82073089644, 3304.603447586281, 3314.121757734202, 3347.0795531228864, 3635.600083990759, 4083.632473077437, 28652.426951460853, 29544.0, 29713.25716857074, 30387.544186837215, 30928.0721578353, 3907.179492306619, 3970.68234541236, 3990.4014397840556, 4100.815463304129, 4158.6465150462245, 247122.0, 247519.0, 248666.0, 248775.0, 249001.9999999982, 49256.261156082684, 50386.24420633693, 54835.0, 55182.72408637931, 55195.0, 59200.0, 60793.69603151956, 61266.0, 61267.0, 61270.38729612736, 13728.65678358049, 13860.722785544232, 13946.790798138036, 14003.929980350033, 14016.929915350562, 10145.492725363702, 10184.287099903084, 10233.641822536176, 10234.795304093876, 10249.692509224735, 18454.723179152323, 18507.537311567048, 18570.164342604614, 18622.53443663919, 18628.16173272206, 6834.1457317835275, 6979.3718565328345, 7132.500724949307, 7132.857342853114, 7179.246179151219, 924.4330859193736, 968.3560432312433, 1003.8193125237527, 1022.6880801355509, 1038.948052597367, 24886.751132488804, 27917.441651166864, 28288.43423131567, 28381.0, 28801.423971520453, 1039.4646756920192, 1039.6361273554196, 1077.8922107789315, 1088.4394536813547, 1095.4686976816238, 13920.685619060852, 13986.86013139876, 14135.15189088658, 14197.503087391891, 14247.643808904653, 299569.0, 301900.0, 304395.0, 304814.0, 305764.0, 48729.51270487321, 49142.0, 49149.0, 49177.26234106491, 49186.75406622944, 1324.1062282958965, 1326.933653317311, 1333.4266265505926, 1337.1375462826422, 1342.3087110138288, 25877.482450351265, 27116.771978705096, 27189.59215611807, 27442.5883611742, 27491.725082748915, 43705.78147109244, 44098.55901441073, 44349.55650443583, 44361.33457998197, 44376.0, 282677.0, 288895.0, 289550.0, 290240.0, 290424.0, 26768.59847102256, 27204.591931120653, 29142.708572913998, 30353.0, 31060.0, 35505.46741798927, 35911.82044089763, 36436.81781591075, 36448.45327320039, 38621.227575448895, 33349.49975750414, 33676.326473469904, 33864.83067584646, 33983.49024764581, 34386.48420273648, 27521.587176191973, 31208.843955780078, 33258.83370583132, 33937.83031084829, 34753.0, 32435.675643243267, 34277.828610856785, 34520.136996574285, 34645.0, 34763.0, 28480.715192848635, 31166.844165779024, 31264.687353126177, 31504.684953150176, 31670.841645792545, 23975.880120599286, 23998.640869843664, 24040.75959240385, 24112.638310425707, 24263.636045459687], "unit": "score", "name": "ext.html", "value": 17701.772069044382}, {"lowerIsBetter": false, "replicates": [355.52714889197364, 359.027145833644, 360.3747498090814, 362.6717820372563, 363.29883325182385, 14623.561293161196, 14726.410943562272, 16308.510744677664, 16367.345306187754, 16908.999999999985, 14615.269236538157, 15059.322330495126, 15405.229738513057, 15406.30671619777, 15423.151726655029, 5309.097453432916, 5420.864478388052, 5429.348478182624, 5433.375161856377, 5452.700101494416, 4057.6348128668415, 4164.146349998258, 5383.81156659517, 5426.267453893733, 5786.305643322786, 5952.464278214981, 5974.8506287342725, 5976.4919981801595, 6013.398660133996, 6026.216591843055, 5833.416658334175, 5974.074018527135, 6003.789867354665, 6004.489618382443, 6005.849853753691, 5214.634975551713, 5302.946970530323, 5312.335958005249, 5322.175062865262, 5329.0674132027125, 19503.317383891495, 20798.896005520026, 21103.788962110488, 21944.122235110575, 21961.450963725874, 2130.8295336373053, 2223.2774348336693, 2260.8304377171776, 2297.0, 2342.227065068523, 12652.81020784689, 13125.343732813417, 13157.671058223525, 13351.866481335159, 13966.092204006809, 1683.7137686593187, 1782.1623836796684, 1787.2046939112101, 1823.717323814811, 1826.5981484073482, 57314.0, 60753.0, 62251.0, 62467.0, 62654.686726566986, 9700.320977531504, 9846.507674616241, 9955.751106222402, 10021.599136034623, 10038.347507411994, 13347.132436391603, 13361.331933403291, 13372.063955523214, 13384.130031547918, 13392.397342119628, 6831.28271531492, 7167.283271672791, 7175.748848790267, 7251.274872512707, 7358.153812311546, 6798.93201067983, 6805.557638753465, 6807.0, 6808.557443766238, 6809.353111454404, 5975.25309336333, 6004.669743164168, 6036.185115009505, 6072.908906366408, 6172.9074063889075, 1676.9664606707797, 1728.2309372329444, 1777.8577713782865, 1785.3394244129495, 1804.6932021556368, 928.5032507608397, 958.242988039455, 968.874046373981, 1024.5594394410475, 1029.3000759483473, 16817.41139060127, 17986.370477033503, 18195.0, 18269.634607308046, 18443.72334414985, 866.6316815353575, 898.1377877237794, 907.9636814527477, 989.6585677941099, 1006.2000709436016, 7808.5314881107315, 9017.0, 9059.547022648972, 9116.1339672731, 9176.8623470648, 485846.0, 488176.0, 490661.0, 491215.0, 500789.0, 71065.99999999897, 71466.0, 74327.0, 75426.0, 80686.0, 1014.9847752283722, 1039.4646756920192, 1040.6773900090996, 1108.695108845058, 1144.7367105565766, 14419.206943617783, 14523.636909077357, 14897.627559311104, 15194.924025379802, 15245.0, 33407.331853363285, 35303.823480882435, 35771.0, 36570.26859462743, 36695.26609467849, 42464.51702488476, 42924.35613465738, 43476.347854782834, 45362.54637453715, 45714.54285457103, 9553.379030363005, 9663.178629816544, 9723.756906077404, 9774.364666296668, 9778.217742580435, 13746.793798092836, 16562.917185413997, 17316.480505584852, 17581.912090439466, 17632.11839407999, 14120.929395352958, 14212.289385530888, 14380.784288235895, 14604.12375257488, 14961.625959351104, 13548.86451135476, 13636.65908352299, 13707.451701931812, 14471.782923255949, 14494.130352178903, 14460.710785784015, 14543.927280363954, 14611.269436528344, 14809.0, 14920.0, 9315.627374904929, 9387.483688397204, 9463.195628371666, 9491.335606507479, 9493.905060949579, 11249.718757030812, 14238.572842814732, 14495.420183192977, 14526.63683407881, 14562.927185364006], "unit": "score", "name": "jquery.html", "value": 8929.400639255531}, {"lowerIsBetter": false, "replicates": [1279.5649479177077, 1437.1448987852232, 1439.7408466476036, 1549.3957356630915, 1703.2250326101625, 6201.565890387669, 6626.834329141774, 6666.366695163963, 6668.666566671672, 6675.232348279949, 6563.507736919726, 6743.561668491545, 6753.02081198226, 6775.356341147595, 6777.966110169442, 1926.1332400419867, 1954.912028958693, 2088.812006919377, 2105.484156381681, 2142.571485702858, 2122.246602456129, 2124.6919196716467, 2127.8829664368454, 2131.5949969505746, 2135.1245989144454, 2064.9070791814406, 2136.0, 2156.568686262746, 2157.2665293800105, 2158.9352319430363, 2124.0547956159517, 2131.5523740014537, 2158.4927542027613, 2160.8703477791228, 2163.5456554123652, 2097.4336929029078, 2102.737157855268, 2126.712893759338, 2128.957420851574, 2130.1372943957567, 6919.723211071551, 6977.05809715687, 6998.7900362988685, 6998.930010699879, 7002.929970700278, 4177.603127702863, 4268.487781466213, 4286.549912259199, 4287.035417031174, 4287.485501739811, 2741.4791189674097, 2763.157237042701, 2785.7075007124163, 2794.874230659605, 2939.382729626781, 972.1153750087386, 978.2125389061803, 997.1374760831901, 1001.8847832499283, 1016.755978565139, 9129.589168487433, 9159.679411220575, 9166.083391660848, 9186.989431162634, 9189.540522973824, 3749.2126653403093, 3808.771473711586, 3812.1422679897355, 3816.3702989007056, 3857.8842634721004, 7830.960845195737, 7873.173316801768, 7958.045034595885, 7973.122956474783, 7976.322012628992, 4161.729487583298, 4193.832246710097, 4214.978925105416, 4230.5769423057445, 4235.576442355801, 3891.0, 3892.4161375793856, 3897.5517815451585, 3898.7075969302414, 3900.6294402031763, 3139.9058028259187, 3192.920176995547, 3291.144302481372, 3319.518669792915, 3321.5848018997626, 1056.1603525197486, 1063.276971659279, 1083.5557421457322, 1110.5557776889148, 1125.2292179856825, 1026.3277553202665, 1026.461107918334, 1075.977821069971, 1143.8055530559825, 1280.1998750780763, 6372.617642941438, 6417.679116044179, 6422.903656445157, 6432.131662225634, 6432.614043157426, 1102.7629059752192, 1109.2180013090751, 1111.6720567432626, 1132.8583927009124, 1138.9829152562718, 4981.775820088033, 5038.622103342191, 5042.470540593258, 5049.96475722476, 5063.443021267658, 7962.761117166494, 8103.635336409876, 8260.091389947102, 8274.255317021498, 8282.71010514629, 8157.2250636189465, 8185.672573097128, 8197.139300373494, 8203.138670439517, 8214.178582141738, 6350.110984462179, 6406.135171751847, 6628.635425051572, 6672.0, 6672.466202703772, 6274.780382686584, 6318.178636777189, 6323.7786677466065, 6340.080688300263, 6346.07981842621, 7275.054242948383, 7280.235575264733, 7433.962830186031, 7434.479586428898, 7465.514741541782, 7479.401647868049, 7502.062242219723, 7579.621018949141, 7643.388528917784, 7644.0827100748265, 6101.6644084574, 6148.846278843064, 6215.409536094064, 6251.843703907439, 6259.812205633838, 5923.289205295392, 6299.496040316855, 6451.806445806634, 6503.349665033648, 6688.431483323972, 6160.815175544741, 6206.534509911684, 6240.656763878031, 6316.557840951089, 6319.557630965788, 6099.207103076572, 6109.75560977556, 6170.598911070766, 6187.659678717714, 6215.347388524321, 6162.414570615784, 6178.505719542336, 6207.782727604693, 6256.124142620128, 6256.5620406572925, 5718.971405142947, 5727.513161381329, 5739.282589676291, 5749.913751293818, 5753.769849205984, 5881.235439392852, 5894.204282421818, 5896.086106653475, 5903.61265102692, 5914.911276330945], "unit": "score", "name": "mootools.html", "value": 4048.7666658029684}, {"lowerIsBetter": false, "replicates": [332.710541828609, 336.34077208671005, 346.2175483407499, 347.5655430711611, 351.4096318185449, 5913.0, 5923.822285331442, 5936.851578710534, 5962.314333851608, 5975.223220981277, 5823.5341172706185, 5891.057430811071, 5891.410858914106, 5893.968555502791, 5903.321118071423, 4596.632269418446, 4600.861974140765, 4606.769661516928, 4609.262517997121, 4612.469565999902, 4505.414296141514, 4609.0, 4612.400387949562, 4618.399608050965, 4632.374629425035, 4546.022605139894, 4552.066826300617, 4560.498345182027, 4565.20108980927, 4568.84009059683, 4356.106998065421, 4452.910941781146, 4558.0428110096755, 4564.657650676196, 4568.565986231302, 3910.393888947218, 3965.3853652683592, 3984.203159368138, 3995.1210733638554, 3995.380715989026, 5600.719964001783, 5606.24315717377, 5609.1305847593685, 5610.158476228557, 5630.15547667849, 5051.19180931053, 5148.845534633967, 5159.819406320761, 5243.082460569385, 5282.65662731925, 6186.721597528122, 6225.252969643671, 6225.844353891143, 6240.188775459162, 6259.155014073087, 4411.889702757425, 4416.889577760549, 4418.3372494125815, 4419.712718673276, 4426.62373698236, 6479.125318082093, 6511.4465270452065, 6574.737010519573, 6574.868502629968, 6583.0, 4478.507364189936, 4487.878030492377, 4543.704659197141, 4544.522825103317, 4545.0909818036525, 4526.140033393644, 4543.568361005699, 4562.110388474216, 4596.4254468191475, 4602.746848923274, 5280.973595132, 5289.47105289468, 5292.576593872481, 5296.682199068068, 5302.231176479466, 6159.0, 6311.779087731908, 6324.177856878577, 6348.904766428507, 6378.712957916905, 1637.2714142206842, 1668.4077152610892, 1669.8163202047765, 1671.3231141387514, 1671.9164041797862, 1136.9204155709187, 1140.7775483780583, 1143.3025854228913, 1144.027576559934, 1169.3276366089533, 5921.555883308769, 5997.2803263607775, 6003.21958145447, 6012.458878700938, 6020.277566692025, 6454.935450645434, 6459.321771214049, 6463.095166676575, 6468.838279043061, 6470.935290647128, 5955.67243801595, 5999.340072592011, 6009.609375390585, 6015.3383127855905, 6019.428154325332, 3420.264643101695, 3521.1373213562842, 3524.242287908112, 3524.7356448266482, 3524.84138213781, 6673.866522669519, 6680.665966701646, 6691.76578819739, 6719.832004199934, 6721.395074443226, 6431.485481161496, 6603.174603174603, 6672.5329226953645, 6691.0, 6695.096162018162, 6325.588836725598, 6686.09737685416, 6736.6631668416385, 6777.559458635173, 6796.286389928986, 6540.084388185753, 6547.70535325921, 6550.868982620416, 6551.44312733423, 6569.57297775643, 6473.352664733678, 6481.254655714653, 6483.481321494363, 6484.027395890655, 6490.707918143789, 6625.105610742681, 6766.560173588701, 6767.35710107539, 6774.0, 6777.220619628806, 4439.22313595126, 4470.262406702857, 4479.328100784908, 4487.573680500347, 4489.506154322957, 6534.967325163344, 6535.411812936859, 6537.542372034102, 6548.443382312556, 6561.671916404256, 6239.313675495601, 6381.0, 6382.106505089384, 6387.744490220339, 6403.29563747978, 6288.937110629018, 6336.841578960379, 6338.112664227104, 6354.332795056453, 6362.363763623601, 6253.593516421418, 6264.0, 6264.718087685974, 6264.968675156595, 6266.185395898687, 6224.253089629274, 6389.648569328731, 6394.200724909387, 6404.135441715495, 6411.71147298382, 6163.445289923929, 6192.845178870564, 6209.503239740719, 6215.65813880241, 6215.96892015537], "unit": "score", "name": "prototype.html", "value": 4778.900761380917}, {"lowerIsBetter": false, "replicates": [838.3083955736515, 849.1720572441866, 853.5305581929939, 867.5185272173941, 889.079802404511, 13427.530036448727, 13637.795433068512, 13659.931700341509, 13685.589432317034, 13694.178349299036, 10950.507227174776, 12374.133810633259, 12735.2995585243, 12745.61763147107, 12969.675758106052, 815.759350991456, 822.7531740477833, 831.0567505880839, 832.4089896173724, 832.7127141136328, 827.9047909490396, 831.7380025292044, 833.4832403909585, 834.4617721569584, 835.2733122183708, 859.2266959736256, 862.9741107766777, 863.2662237098478, 865.6580650642992, 872.3806097670662, 856.751542052804, 858.1118542308711, 859.5959898847562, 860.3848248502288, 861.961211745473, 634.685830513894, 635.7870113511979, 636.0840389838618, 636.3986033198629, 637.3690046853582, 11779.0, 12190.81713774294, 12193.512259509609, 12195.756084878341, 12198.451069701885, 10760.461976901202, 10989.450527473595, 11440.19918605698, 12300.0, 12599.93700031503, 10367.066963973279, 10402.271840971134, 10448.79102417955, 10495.79008419835, 10507.894921050845, 3615.6565126312958, 3666.926661466756, 3684.889453316405, 3695.6858667013335, 3778.6410291022307, 40019.199616007805, 40874.591254087674, 45593.54406455926, 46753.29870051918, 47724.761376192895, 9654.75863103428, 9903.851442228372, 9923.900760992297, 10109.848352274721, 10279.0, 16903.492895213163, 17303.65392692139, 17324.0, 17346.65306693859, 17369.2183851727, 7629.237076292437, 7661.540307581563, 7967.442279040411, 8038.236367545074, 8277.296429803413, 4467.419235499429, 4512.111141052122, 4546.136234115507, 4560.065186636732, 4613.976930115328, 2953.2469220348676, 2991.700829916991, 2992.521196608576, 2993.521036634128, 2993.536001919706, 572.193207577314, 574.052812858778, 588.0972706894896, 593.4629160609655, 594.7888499582673, 571.4713889652138, 638.0684201066495, 650.847050943028, 651.235505280089, 693.8041099918802, 7451.515651482637, 7952.84094318122, 7953.8409231816195, 8029.678812847421, 8243.505389676639, 592.6562593695646, 598.4673640459994, 654.165938428498, 675.6182756742425, 693.2097408953797, 3777.8111094445167, 3812.4090765931323, 3844.519435070616, 3868.3423817951016, 3921.470601468822, 53355.0, 53683.463165367844, 57239.71380143073, 58067.70966145142, 61019.0, 47124.293135602995, 48057.27914081291, 48499.5150048495, 48876.75561622169, 49774.0, 41293.72884491322, 46213.76893115513, 46845.531544684796, 47018.294725579144, 47341.5265847344, 8158.551279679675, 8165.183481652025, 8324.209200125979, 8513.702020429255, 8515.31877449815, 32704.345913081128, 32867.50698739569, 34087.4886876702, 34497.965061048206, 35182.472262915566, 42522.0, 42570.0, 42855.3571696431, 43729.344059839765, 43874.78062609667, 9644.228461723185, 9703.320767546204, 10262.743431414274, 10951.56193752241, 11117.332960022424, 11079.781224065508, 11402.258853174517, 11410.600628978278, 11898.583549575724, 11953.940230298793, 9818.509074546388, 10027.16498999969, 10161.695149145537, 10185.0, 10353.9482302588, 10637.414942178255, 10728.463576821285, 10742.40916749555, 10854.837177442503, 10883.510242038968, 10859.348439093365, 11108.277961932448, 11123.110151188048, 11301.26541774782, 11440.427978601203, 9252.907470925205, 9418.246540276898, 9454.810903782023, 9657.613695452103, 9724.513774311397, 8353.58232088381, 8986.955065224633, 9232.492212928353, 9324.906750932403, 9390.154886060014], "unit": "score", "name": "yui.html", "value": 6177.392125823094}], "name": "dromaeo_css", "value": 6786.126029741002}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 104.0, 111.0, 111.0, 111.0, 102.0, 111.0, 112.0, 104.0], "unit": "score", "name": "ai-astar", "value": 108.8}, {"lowerIsBetter": true, "replicates": [150.0, 124.0, 148.0, 161.0, 128.0, 150.0, 157.0, 124.0, 166.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 143.9}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 161.0, 165.0, 161.0, 161.0, 160.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 86.0, 94.0, 74.0, 73.0, 71.0, 100.0, 98.0, 71.0], "unit": "score", "name": "audio-fft", "value": 81.3}, {"lowerIsBetter": true, "replicates": [98.0, 96.0, 139.0, 96.0, 96.0, 98.0, 142.0, 98.0, 96.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 109.5}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 145.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [66.0, 58.0, 58.0, 57.0, 58.0, 57.0, 58.0, 58.0, 60.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 58.7}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 68.0, 67.0, 68.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 86.0, 94.0, 85.0, 85.0, 87.0, 94.0, 95.0, 89.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.4}, {"lowerIsBetter": true, "replicates": [116.0, 122.0, 125.0, 123.0, 128.0, 125.0, 120.0, 119.0, 119.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.5}, {"lowerIsBetter": true, "replicates": [141.0, 152.0, 152.0, 152.0, 150.0, 140.0, 150.0, 152.0, 150.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.1}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 67.0, 68.0, 69.0, 68.0, 69.0, 67.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.4}], "name": "kraken", "value": 1509.5000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.7792869269949], "unit": "score", "name": "Richards", "value": 207.92877999999993}, {"lowerIsBetter": false, "replicates": [197.43336623889437], "unit": "score", "name": "DeltaBlue", "value": 334.88766999999984}, {"lowerIsBetter": false, "replicates": [286.20492272467084], "unit": "score", "name": "Encrypt", "value": 930.036414}, {"lowerIsBetter": false, "replicates": [5268.421052631579], "unit": "score", "name": "Decrypt", "value": 50.52386613386611}, {"lowerIsBetter": false, "replicates": [1118.5682326621925], "unit": "score", "name": "RayTrace", "value": 661.550166}, {"lowerIsBetter": false, "replicates": [799.3605115907275], "unit": "score", "name": "Earley", "value": 833.7452129999997}, {"lowerIsBetter": false, "replicates": [12329.268292682927], "unit": "score", "name": "Boyer", "value": 54.05535707220569}, {"lowerIsBetter": false, "replicates": [26868.42105263158], "unit": "score", "name": "RegExp", "value": 33.90541625857002}, {"lowerIsBetter": false, "replicates": [597.0149253731344], "unit": "score", "name": "Splay", "value": 136.497425}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 20692.24942352793}]} 14:19:56 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20692.25"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1509.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6786.13"}}} 14:19:56 INFO - Return code: 0 14:19:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:19:56 INFO - # TBPL SUCCESS # 14:19:56 INFO - Running post-action listener: _resource_record_post_action 14:19:56 INFO - Running post-run listener: _resource_record_post_run 14:19:57 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 4096; Write bytes: 572829696; Read time: 8; Write time: 688192 14:19:57 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 252760064; Read time: 0; Write time: 447444 14:19:57 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 320069632; Read time: 8; Write time: 240748 14:19:57 INFO - Running post-run listener: _upload_blobber_files 14:19:57 INFO - Blob upload gear active. 14:19:57 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:19:57 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 14:19:57 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'] 14:19:57 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 14:19:58 INFO - (blobuploader) - INFO - Open directory for files ... 14:19:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 14:19:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:19:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:19:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:19:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:19:59 INFO - (blobuploader) - INFO - Done attempting. 14:19:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:19:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:19:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:19:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:19:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:19:59 INFO - (blobuploader) - INFO - Done attempting. 14:19:59 INFO - (blobuploader) - INFO - Iteration through files over. 14:19:59 INFO - Return code: 0 14:19:59 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:19:59 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:19:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cd4311821c33600b3f4080a128669b0576d56e23495d223711bdda04e780e1da22a9dbe04beb4e0146bb44cdbc90a86af07d65368cda9e5d71b0a0f7650765b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b989611bc88527a68d095cc65faedf5d35325916430117c7accb661d3cf1e4de9366442b68143b1555cd48f597babc0b0515c03016fd85228c02efeb3e85184f"} 14:19:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:19:59 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:19:59 INFO - Contents: 14:19:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cd4311821c33600b3f4080a128669b0576d56e23495d223711bdda04e780e1da22a9dbe04beb4e0146bb44cdbc90a86af07d65368cda9e5d71b0a0f7650765b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b989611bc88527a68d095cc65faedf5d35325916430117c7accb661d3cf1e4de9366442b68143b1555cd48f597babc0b0515c03016fd85228c02efeb3e85184f"} 14:19:59 INFO - Copying logs to upload dir... 14:19:59 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1268.449439 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-29 14:19:59.009722) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 14:19:59.012986) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1451416077.418951-498231862 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cd4311821c33600b3f4080a128669b0576d56e23495d223711bdda04e780e1da22a9dbe04beb4e0146bb44cdbc90a86af07d65368cda9e5d71b0a0f7650765b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b989611bc88527a68d095cc65faedf5d35325916430117c7accb661d3cf1e4de9366442b68143b1555cd48f597babc0b0515c03016fd85228c02efeb3e85184f"} build_url:https://queue.taskcluster.net/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011114 build_url: 'https://queue.taskcluster.net/v1/task/ZJ2TfC2vTZygi-ZCHe3Qdw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cd4311821c33600b3f4080a128669b0576d56e23495d223711bdda04e780e1da22a9dbe04beb4e0146bb44cdbc90a86af07d65368cda9e5d71b0a0f7650765b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b989611bc88527a68d095cc65faedf5d35325916430117c7accb661d3cf1e4de9366442b68143b1555cd48f597babc0b0515c03016fd85228c02efeb3e85184f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 14:19:59.039955) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 14:19:59.040472) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1451416077.418951-498231862 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004697 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 14:19:59.124210) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 14:19:59.124960) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 14:19:59.125646) ========= ========= Total master_lag: 0.23 =========