builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-044 starttime: 1452225569.55 results: success (0) buildid: 20160107173005 builduid: 3629ba631b7c45d4bc51f5549f6bf381 revision: b6d733b1a688a55548d4754de99bbc6e8636fbdb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 19:59:29.552862) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 19:59:29.553343) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 19:59:29.553637) ========= 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=574dc5aafe09851ec43d388c000001b6-1452223546.273737-1484167495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006341 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 19:59:29.576626) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 19:59:29.576907) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 19:59:29.615452) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 19:59:29.615711) ========= 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=574dc5aafe09851ec43d388c000001b6-1452223546.273737-1484167495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004665 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 19:59:29.664534) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 19:59:29.664809) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 19:59:29.665179) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 19:59:29.665453) ========= 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=574dc5aafe09851ec43d388c000001b6-1452223546.273737-1484167495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-07 19:59:30-- 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% 73.0M=0s 2016-01-07 19:59:30 (73.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.156583 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 19:59:29.840545) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 19:59:29.840837) ========= 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=574dc5aafe09851ec43d388c000001b6-1452223546.273737-1484167495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018661 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 19:59:29.906653) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 19:59:29.906952) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b6d733b1a688a55548d4754de99bbc6e8636fbdb --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 b6d733b1a688a55548d4754de99bbc6e8636fbdb --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=574dc5aafe09851ec43d388c000001b6-1452223546.273737-1484167495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-07 19:59:30,621 truncating revision to first 12 chars 2016-01-07 19:59:30,621 Setting DEBUG logging. 2016-01-07 19:59:30,621 attempt 1/10 2016-01-07 19:59:30,621 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b6d733b1a688?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-07 19:59:31,213 unpacking tar archive at: fx-team-b6d733b1a688/testing/mozharness/ program finished with exit code 0 elapsedTime=0.890962 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 19:59:30.813355) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 19:59:30.813635) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 19:59:30.820765) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 19:59:30.821032) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 19:59:30.821402) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-07 19:59:30.821682) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1452223546.273737-1484167495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:59:31 INFO - MultiFileLogger online at 20160107 19:59:31 in /builds/slave/test-pgo 19:59:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:59:31 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:59:31 INFO - {'append_to_log': False, 19:59:31 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:59:31 INFO - 'blob_upload_branch': 'Fx-Team', 19:59:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:59:31 INFO - 'branch': 'Fx-Team', 19:59:31 INFO - 'buildbot_json_path': 'buildprops.json', 19:59:31 INFO - 'config_files': ('talos/linux_config.py',), 19:59:31 INFO - 'default_actions': ('clobber', 19:59:31 INFO - 'read-buildbot-config', 19:59:31 INFO - 'download-and-extract', 19:59:31 INFO - 'populate-webroot', 19:59:31 INFO - 'create-virtualenv', 19:59:31 INFO - 'install', 19:59:31 INFO - 'run-tests'), 19:59:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:59:31 INFO - 'download_minidump_stackwalk': True, 19:59:31 INFO - 'download_symbols': 'ondemand', 19:59:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:59:31 INFO - 'tooltool.py': '/tools/tooltool.py', 19:59:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:59:31 INFO - '/tools/misc-python/virtualenv.py')}, 19:59:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:59:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:59:31 INFO - 'installer_path': 'installer.exe', 19:59:31 INFO - 'log_level': 'info', 19:59:31 INFO - 'log_name': 'talos', 19:59:31 INFO - 'log_to_console': True, 19:59:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:59:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:59:31 INFO - 'opt_config_files': (), 19:59:31 INFO - 'pip_index': False, 19:59:31 INFO - 'sps_profile': False, 19:59:31 INFO - 'sps_profile_interval': 0, 19:59:31 INFO - 'suite': 'dromaeojs-e10s', 19:59:31 INFO - 'system_bits': '32', 19:59:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:59:31 INFO - 'title': 'talos-linux64-ix-044', 19:59:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:59:31 INFO - 'use_talos_json': True, 19:59:31 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:59:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:59:31 INFO - 'work_dir': 'build'} 19:59:31 INFO - ##### 19:59:31 INFO - ##### Running clobber step. 19:59:31 INFO - ##### 19:59:31 INFO - Running pre-action listener: _resource_record_pre_action 19:59:31 INFO - Running main action method: clobber 19:59:31 INFO - rmtree: /builds/slave/test-pgo/build 19:59:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:59:32 INFO - Running post-action listener: _resource_record_post_action 19:59:32 INFO - ##### 19:59:32 INFO - ##### Running read-buildbot-config step. 19:59:32 INFO - ##### 19:59:32 INFO - Running pre-action listener: _resource_record_pre_action 19:59:32 INFO - Running main action method: read_buildbot_config 19:59:32 INFO - Using buildbot properties: 19:59:32 INFO - { 19:59:32 INFO - "project": "", 19:59:32 INFO - "product": "firefox", 19:59:32 INFO - "script_repo_revision": "production", 19:59:32 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 19:59:32 INFO - "repository": "", 19:59:32 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 19:59:32 INFO - "buildid": "20160107173005", 19:59:32 INFO - "pgo_build": "True", 19:59:32 INFO - "basedir": "/builds/slave/test-pgo", 19:59:32 INFO - "buildnumber": 192, 19:59:32 INFO - "slavename": "talos-linux64-ix-044", 19:59:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:59:32 INFO - "platform": "ubuntu64_hw", 19:59:32 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:59:32 INFO - "branch": "fx-team", 19:59:32 INFO - "repo_path": "integration/fx-team", 19:59:32 INFO - "revision": "b6d733b1a688a55548d4754de99bbc6e8636fbdb", 19:59:32 INFO - "stage_platform": "linux64-pgo", 19:59:32 INFO - "builduid": "3629ba631b7c45d4bc51f5549f6bf381", 19:59:32 INFO - "slavebuilddir": "test" 19:59:32 INFO - } 19:59:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/D_PgXomTQjWn7LUDQlBntg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:59:32 INFO - Running post-action listener: _resource_record_post_action 19:59:32 INFO - ##### 19:59:32 INFO - ##### Running download-and-extract step. 19:59:32 INFO - ##### 19:59:32 INFO - Running pre-action listener: _resource_record_pre_action 19:59:32 INFO - Running main action method: download_and_extract 19:59:32 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:59:32 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')]} 19:59:32 INFO - https://queue.taskcluster.net/v1/task/D_PgXomTQjWn7LUDQlBntg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:59:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_PgXomTQjWn7LUDQlBntg/artifacts/public/build/test_packages.json 19:59:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_PgXomTQjWn7LUDQlBntg/artifacts/public/build/test_packages.json 19:59:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_PgXomTQjWn7LUDQlBntg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:59:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_PgXomTQjWn7LUDQlBntg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:59:35 INFO - Downloaded 1302 bytes. 19:59:35 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:59:35 INFO - Using the following test package requirements: 19:59:35 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:59:35 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:59:35 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:35 INFO - u'jsshell-linux-x86_64.zip'], 19:59:35 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:59:35 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:59:35 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:59:35 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:59:35 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:59:35 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:59:35 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:59:35 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:35 INFO - https://queue.taskcluster.net/v1/task/D_PgXomTQjWn7LUDQlBntg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:59:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_PgXomTQjWn7LUDQlBntg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:59:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_PgXomTQjWn7LUDQlBntg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:59:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_PgXomTQjWn7LUDQlBntg/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 19:59:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_PgXomTQjWn7LUDQlBntg/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 19:59:37 INFO - Downloaded 24018302 bytes. 19:59:37 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 19:59:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:59:37 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 19:59:38 INFO - Return code: 0 19:59:38 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 19:59:38 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')]} 19:59:38 INFO - https://queue.taskcluster.net/v1/task/D_PgXomTQjWn7LUDQlBntg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:59:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_PgXomTQjWn7LUDQlBntg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:59:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_PgXomTQjWn7LUDQlBntg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:59:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_PgXomTQjWn7LUDQlBntg/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 19:59:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_PgXomTQjWn7LUDQlBntg/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 19:59:40 INFO - Downloaded 24018302 bytes. 19:59:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 19:59:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:59:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 19:59:41 INFO - Return code: 0 19:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:41 INFO - https://queue.taskcluster.net/v1/task/D_PgXomTQjWn7LUDQlBntg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:59:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_PgXomTQjWn7LUDQlBntg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:59:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_PgXomTQjWn7LUDQlBntg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:59:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_PgXomTQjWn7LUDQlBntg/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 19:59:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_PgXomTQjWn7LUDQlBntg/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 19:59:42 INFO - Downloaded 11132285 bytes. 19:59:42 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 19:59:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:59:42 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 19:59:42 INFO - Return code: 0 19:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:59:42 INFO - https://queue.taskcluster.net/v1/task/D_PgXomTQjWn7LUDQlBntg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:59:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_PgXomTQjWn7LUDQlBntg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:59:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_PgXomTQjWn7LUDQlBntg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:59:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_PgXomTQjWn7LUDQlBntg/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 19:59:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_PgXomTQjWn7LUDQlBntg/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 19:59:44 INFO - Downloaded 55908242 bytes. 19:59:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D_PgXomTQjWn7LUDQlBntg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:59:44 INFO - mkdir: /builds/slave/test-pgo/properties 19:59:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:59:44 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:59:44 INFO - Contents: 19:59:44 INFO - build_url:https://queue.taskcluster.net/v1/task/D_PgXomTQjWn7LUDQlBntg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:59:44 INFO - Running post-action listener: _resource_record_post_action 19:59:44 INFO - Running post-action listener: set_extra_try_arguments 19:59:44 INFO - ##### 19:59:44 INFO - ##### Running populate-webroot step. 19:59:44 INFO - ##### 19:59:44 INFO - Running pre-action listener: _resource_record_pre_action 19:59:44 INFO - Running main action method: populate_webroot 19:59:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:59:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:59:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:59:44 INFO - '--tppagecycles', 19:59:44 INFO - '7'], 19:59:44 INFO - 'tests': ['tsvgm']}}, 19:59:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:59:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:59:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:59:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:59:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:59:44 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:59:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:59:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:44 INFO - 'talos_options': ['--e10s'], 19:59:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:59:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:44 INFO - 'tests': ['damp', 'tps']}, 19:59:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:44 INFO - 'talos_options': ['--e10s'], 19:59:44 INFO - 'tests': ['damp', 'tps']}, 19:59:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:59:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:59:44 INFO - 'other': {'tests': ['a11yr', 19:59:44 INFO - 'ts_paint', 19:59:44 INFO - 'tpaint', 19:59:44 INFO - 'sessionrestore', 19:59:44 INFO - 'sessionrestore_no_auto_restore']}, 19:59:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:59:44 INFO - 'tests': ['a11yr', 19:59:44 INFO - 'ts_paint', 19:59:44 INFO - 'tpaint', 19:59:44 INFO - 'sessionrestore', 19:59:44 INFO - 'sessionrestore_no_auto_restore']}, 19:59:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:59:44 INFO - 'tests': ['a11yr', 19:59:44 INFO - 'ts_paint', 19:59:44 INFO - 'tpaint', 19:59:44 INFO - 'sessionrestore', 19:59:44 INFO - 'sessionrestore_no_auto_restore']}, 19:59:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:59:44 INFO - 'tests': ['a11yr', 19:59:44 INFO - 'ts_paint', 19:59:44 INFO - 'tpaint', 19:59:44 INFO - 'sessionrestore', 19:59:44 INFO - 'sessionrestore_no_auto_restore']}, 19:59:44 INFO - 'other_l64': {'tests': ['a11yr', 19:59:44 INFO - 'ts_paint', 19:59:44 INFO - 'tpaint', 19:59:44 INFO - 'sessionrestore', 19:59:44 INFO - 'sessionrestore_no_auto_restore']}, 19:59:44 INFO - 'other_nol64': {'tests': ['a11yr', 19:59:44 INFO - 'ts_paint', 19:59:44 INFO - 'tpaint', 19:59:44 INFO - 'sessionrestore', 19:59:44 INFO - 'sessionrestore_no_auto_restore']}, 19:59:44 INFO - 'svgr': {'tests': ['tsvgx', 19:59:44 INFO - 'tsvgr_opacity', 19:59:44 INFO - 'tart', 19:59:44 INFO - 'tscrollx', 19:59:44 INFO - 'cart']}, 19:59:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:59:44 INFO - 'tests': ['tsvgx', 19:59:44 INFO - 'tsvgr_opacity', 19:59:44 INFO - 'tart', 19:59:44 INFO - 'tscrollx', 19:59:44 INFO - 'cart']}, 19:59:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:44 INFO - 'tests': ['tp5o']}, 19:59:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:44 INFO - 'talos_options': ['--e10s'], 19:59:44 INFO - 'tests': ['tp5o']}, 19:59:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:44 INFO - 'talos_options': ['--xperf_path', 19:59:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:59:44 INFO - 'tests': ['tp5n']}, 19:59:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:44 INFO - 'talos_options': ['--e10s', 19:59:44 INFO - '--xperf_path', 19:59:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:59:44 INFO - 'tests': ['tp5n']}}, 19:59:44 INFO - 'talos.zip': {'path': '', 19:59:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:59:44 INFO - Running post-action listener: _resource_record_post_action 19:59:44 INFO - ##### 19:59:44 INFO - ##### Running create-virtualenv step. 19:59:44 INFO - ##### 19:59:44 INFO - Running pre-action listener: _resource_record_pre_action 19:59:44 INFO - Running main action method: create_virtualenv 19:59:44 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:59:44 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 19:59:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:59:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:59:44 INFO - Using real prefix '/usr' 19:59:44 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:59:44 INFO - Installing distribute.............................................................................................................................................................................................done. 19:59:47 INFO - Installing pip.................done. 19:59:47 INFO - Return code: 0 19:59:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:47 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 0x7f546fea5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1551630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e2840>, '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 0x154f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x154fb60>, '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': '574dc5aafe09851ec43d388c000001b6-1452223546.273737-1484167495', '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 19:59:47 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 19:59:47 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 19:59:47 INFO - Using env: {'DISPLAY': ':0', 19:59:47 INFO - 'HOME': '/home/cltbld', 19:59:47 INFO - 'LANG': 'en_US.UTF-8', 19:59:47 INFO - 'LANGUAGE': 'en_US:en', 19:59:47 INFO - 'LOGNAME': 'cltbld', 19:59:47 INFO - 'MAIL': '/var/mail/cltbld', 19:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:47 INFO - 'MOZ_NO_REMOTE': '1', 19:59:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:47 INFO - 'NO_EM_RESTART': '1', 19:59:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:47 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:47 INFO - 'SHELL': '/bin/bash', 19:59:47 INFO - 'SHLVL': '1', 19:59:47 INFO - 'TERM': 'linux', 19:59:47 INFO - 'TMOUT': '86400', 19:59:47 INFO - 'USER': 'cltbld', 19:59:47 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452223546.273737-1484167495', 19:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:47 INFO - '_': '/tools/buildbot/bin/python'} 19:59:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:47 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 19:59:47 INFO - Cleaning up... 19:59:47 INFO - Return code: 0 19:59:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:47 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 0x7f546fea5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1551630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e2840>, '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 0x154f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x154fb60>, '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': '574dc5aafe09851ec43d388c000001b6-1452223546.273737-1484167495', '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 19:59:47 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 19:59:47 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 19:59:47 INFO - Using env: {'DISPLAY': ':0', 19:59:47 INFO - 'HOME': '/home/cltbld', 19:59:47 INFO - 'LANG': 'en_US.UTF-8', 19:59:47 INFO - 'LANGUAGE': 'en_US:en', 19:59:47 INFO - 'LOGNAME': 'cltbld', 19:59:47 INFO - 'MAIL': '/var/mail/cltbld', 19:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:47 INFO - 'MOZ_NO_REMOTE': '1', 19:59:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:47 INFO - 'NO_EM_RESTART': '1', 19:59:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:47 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:47 INFO - 'SHELL': '/bin/bash', 19:59:47 INFO - 'SHLVL': '1', 19:59:47 INFO - 'TERM': 'linux', 19:59:47 INFO - 'TMOUT': '86400', 19:59:47 INFO - 'USER': 'cltbld', 19:59:47 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452223546.273737-1484167495', 19:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:47 INFO - '_': '/tools/buildbot/bin/python'} 19:59:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:47 INFO - Downloading/unpacking psutil>=0.7.1 19:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:49 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:59:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:59:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:59:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:59:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:59:49 INFO - Installing collected packages: psutil 19:59:49 INFO - Running setup.py install for psutil 19:59:49 INFO - building 'psutil._psutil_linux' extension 19:59:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:59:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:59:49 INFO - building 'psutil._psutil_posix' extension 19:59:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:59:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:59:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:59:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:59:49 INFO - Successfully installed psutil 19:59:49 INFO - Cleaning up... 19:59:49 INFO - Return code: 0 19:59:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f546fea5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1551630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e2840>, '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 0x154f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x154fb60>, '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': '574dc5aafe09851ec43d388c000001b6-1452223546.273737-1484167495', '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 19:59:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 19:59:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:59:49 INFO - Using env: {'DISPLAY': ':0', 19:59:49 INFO - 'HOME': '/home/cltbld', 19:59:49 INFO - 'LANG': 'en_US.UTF-8', 19:59:49 INFO - 'LANGUAGE': 'en_US:en', 19:59:49 INFO - 'LOGNAME': 'cltbld', 19:59:49 INFO - 'MAIL': '/var/mail/cltbld', 19:59:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:49 INFO - 'MOZ_NO_REMOTE': '1', 19:59:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:49 INFO - 'NO_EM_RESTART': '1', 19:59:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:49 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:49 INFO - 'SHELL': '/bin/bash', 19:59:49 INFO - 'SHLVL': '1', 19:59:49 INFO - 'TERM': 'linux', 19:59:49 INFO - 'TMOUT': '86400', 19:59:49 INFO - 'USER': 'cltbld', 19:59:49 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452223546.273737-1484167495', 19:59:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:49 INFO - '_': '/tools/buildbot/bin/python'} 19:59:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:59:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:59:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:59:51 INFO - Installing collected packages: mozsystemmonitor 19:59:51 INFO - Running setup.py install for mozsystemmonitor 19:59:52 INFO - Successfully installed mozsystemmonitor 19:59:52 INFO - Cleaning up... 19:59:52 INFO - Return code: 0 19:59:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:59: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')]} 19:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59: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')]} 19:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f546fea5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1551630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e2840>, '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 0x154f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x154fb60>, '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': '574dc5aafe09851ec43d388c000001b6-1452223546.273737-1484167495', '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 19:59:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 19:59:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:59:52 INFO - Using env: {'DISPLAY': ':0', 19:59:52 INFO - 'HOME': '/home/cltbld', 19:59:52 INFO - 'LANG': 'en_US.UTF-8', 19:59:52 INFO - 'LANGUAGE': 'en_US:en', 19:59:52 INFO - 'LOGNAME': 'cltbld', 19:59:52 INFO - 'MAIL': '/var/mail/cltbld', 19:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:52 INFO - 'MOZ_NO_REMOTE': '1', 19:59:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:52 INFO - 'NO_EM_RESTART': '1', 19:59:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:52 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:52 INFO - 'SHELL': '/bin/bash', 19:59:52 INFO - 'SHLVL': '1', 19:59:52 INFO - 'TERM': 'linux', 19:59:52 INFO - 'TMOUT': '86400', 19:59:52 INFO - 'USER': 'cltbld', 19:59:52 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452223546.273737-1484167495', 19:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:52 INFO - '_': '/tools/buildbot/bin/python'} 19:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:52 INFO - Downloading/unpacking blobuploader==1.2.4 19:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:53 INFO - Downloading blobuploader-1.2.4.tar.gz 19:59:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:59:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:59:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:59:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:59:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:54 INFO - Downloading docopt-0.6.1.tar.gz 19:59:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:59:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:59:54 INFO - Installing collected packages: blobuploader, requests, docopt 19:59:54 INFO - Running setup.py install for blobuploader 19:59:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:59:54 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:59:54 INFO - Running setup.py install for requests 19:59:55 INFO - Running setup.py install for docopt 19:59:55 INFO - Successfully installed blobuploader requests docopt 19:59:55 INFO - Cleaning up... 19:59:55 INFO - Return code: 0 19:59:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:55 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 0x7f546fea5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1551630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e2840>, '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 0x154f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x154fb60>, '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': '574dc5aafe09851ec43d388c000001b6-1452223546.273737-1484167495', '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 19:59:55 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 19:59:55 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 19:59:55 INFO - Using env: {'DISPLAY': ':0', 19:59:55 INFO - 'HOME': '/home/cltbld', 19:59:55 INFO - 'LANG': 'en_US.UTF-8', 19:59:55 INFO - 'LANGUAGE': 'en_US:en', 19:59:55 INFO - 'LOGNAME': 'cltbld', 19:59:55 INFO - 'MAIL': '/var/mail/cltbld', 19:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:55 INFO - 'MOZ_NO_REMOTE': '1', 19:59:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:55 INFO - 'NO_EM_RESTART': '1', 19:59:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:55 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:55 INFO - 'SHELL': '/bin/bash', 19:59:55 INFO - 'SHLVL': '1', 19:59:55 INFO - 'TERM': 'linux', 19:59:55 INFO - 'TMOUT': '86400', 19:59:55 INFO - 'USER': 'cltbld', 19:59:55 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452223546.273737-1484167495', 19:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:55 INFO - '_': '/tools/buildbot/bin/python'} 19:59:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:59:55 INFO - Running setup.py (path:/tmp/pip-nE2Of0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:59:55 INFO - Running setup.py (path:/tmp/pip-1mdgpX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:59:55 INFO - Running setup.py (path:/tmp/pip-KPCbgJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:59:55 INFO - Running setup.py (path:/tmp/pip-JSMgYQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:59:55 INFO - Running setup.py (path:/tmp/pip-1maMMD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:59:55 INFO - Running setup.py (path:/tmp/pip-j8eCaN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:59:55 INFO - Running setup.py (path:/tmp/pip-ykDB0P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:59:56 INFO - Running setup.py (path:/tmp/pip-Vh5d49-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:59:56 INFO - Running setup.py (path:/tmp/pip-VIUOca-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:59:56 INFO - Running setup.py (path:/tmp/pip-MUPlAu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:59:56 INFO - Running setup.py (path:/tmp/pip-mZWxLB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:59:56 INFO - Running setup.py (path:/tmp/pip-ZwALJ5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:59:56 INFO - Running setup.py (path:/tmp/pip-pH7tBg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:59:56 INFO - Running setup.py (path:/tmp/pip-JuHK2S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:59:56 INFO - Running setup.py (path:/tmp/pip-ltukQL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:59:56 INFO - Running setup.py (path:/tmp/pip-Qvcv2L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:59:56 INFO - Running setup.py (path:/tmp/pip-hGIusx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:59:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:59:56 INFO - Running setup.py install for manifestparser 19:59:56 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:59:56 INFO - Running setup.py install for mozcrash 19:59:56 INFO - Running setup.py install for mozdebug 19:59:57 INFO - Running setup.py install for mozdevice 19:59:57 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:59:57 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:59:57 INFO - Running setup.py install for mozfile 19:59:57 INFO - Running setup.py install for mozhttpd 19:59:57 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:59:57 INFO - Running setup.py install for mozinfo 19:59:57 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:59:57 INFO - Running setup.py install for mozInstall 19:59:57 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:59:57 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:59:57 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:59:57 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:59:57 INFO - Running setup.py install for mozleak 19:59:57 INFO - Running setup.py install for mozlog 19:59:57 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:59:57 INFO - Running setup.py install for moznetwork 19:59:57 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:59:57 INFO - Running setup.py install for mozprocess 19:59:58 INFO - Running setup.py install for mozprofile 19:59:58 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:59:58 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:59:58 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:59:58 INFO - Running setup.py install for mozrunner 19:59:58 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:59:58 INFO - Running setup.py install for mozscreenshot 19:59:58 INFO - Running setup.py install for moztest 19:59:58 INFO - Running setup.py install for mozversion 19:59:58 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:59:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:59:58 INFO - Cleaning up... 19:59:58 INFO - Return code: 0 19:59:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:58 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 0x7f546fea5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1551630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e2840>, '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 0x154f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x154fb60>, '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': '574dc5aafe09851ec43d388c000001b6-1452223546.273737-1484167495', '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 19:59:58 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 19:59:58 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 19:59:58 INFO - Using env: {'DISPLAY': ':0', 19:59:58 INFO - 'HOME': '/home/cltbld', 19:59:58 INFO - 'LANG': 'en_US.UTF-8', 19:59:58 INFO - 'LANGUAGE': 'en_US:en', 19:59:58 INFO - 'LOGNAME': 'cltbld', 19:59:58 INFO - 'MAIL': '/var/mail/cltbld', 19:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:58 INFO - 'MOZ_NO_REMOTE': '1', 19:59:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:58 INFO - 'NO_EM_RESTART': '1', 19:59:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:58 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:58 INFO - 'SHELL': '/bin/bash', 19:59:58 INFO - 'SHLVL': '1', 19:59:58 INFO - 'TERM': 'linux', 19:59:58 INFO - 'TMOUT': '86400', 19:59:58 INFO - 'USER': 'cltbld', 19:59:58 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452223546.273737-1484167495', 19:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:58 INFO - '_': '/tools/buildbot/bin/python'} 19:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:59:58 INFO - Running setup.py (path:/tmp/pip-sOYxZ3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:59:58 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)) 19:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:59:58 INFO - Running setup.py (path:/tmp/pip-Yd1_EG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:59:58 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)) 19:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:59:58 INFO - Running setup.py (path:/tmp/pip-ylJluc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:59:58 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)) 19:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:59:58 INFO - Running setup.py (path:/tmp/pip-s2nYF_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:59:59 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)) 19:59:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:59:59 INFO - Running setup.py (path:/tmp/pip-qRZUal-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:59:59 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)) 19:59:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:59:59 INFO - Running setup.py (path:/tmp/pip-zrVz0d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:59:59 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)) 19:59:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:59:59 INFO - Running setup.py (path:/tmp/pip-84Wz5m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:59:59 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)) 19:59:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:59:59 INFO - Running setup.py (path:/tmp/pip-ejkSkP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:59:59 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)) 19:59:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:59:59 INFO - Running setup.py (path:/tmp/pip-J_CbNB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:59:59 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)) 19:59:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:59:59 INFO - Running setup.py (path:/tmp/pip-S1UsP8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:59:59 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)) 19:59:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:59:59 INFO - Running setup.py (path:/tmp/pip-1TJRsN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:59:59 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)) 19:59:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:59:59 INFO - Running setup.py (path:/tmp/pip-DLIIuv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:59:59 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)) 19:59:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:59:59 INFO - Running setup.py (path:/tmp/pip-OFvCzE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:59:59 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)) 19:59:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:59:59 INFO - Running setup.py (path:/tmp/pip-NIPzCo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:59:59 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)) 19:59:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:59:59 INFO - Running setup.py (path:/tmp/pip-wL4o3H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:59:59 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)) 19:59:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:59:59 INFO - Running setup.py (path:/tmp/pip-stQOmE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:59:59 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)) 19:59:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:59:59 INFO - Running setup.py (path:/tmp/pip-NzkpTP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:00:00 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)) 20:00:00 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)) 20:00:00 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)) 20:00:00 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)) 20:00:00 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)) 20:00:00 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)) 20:00:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 20:00:00 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 20:00:00 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 20:00:00 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 20:00:00 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 20:00:00 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 20:00:00 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 20:00:01 INFO - Downloading blessings-1.5.1.tar.gz 20:00:01 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 20:00:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 20:00:01 INFO - Installing collected packages: blessings 20:00:01 INFO - Running setup.py install for blessings 20:00:01 INFO - Successfully installed blessings 20:00:01 INFO - Cleaning up... 20:00:01 INFO - Return code: 0 20:00:01 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 20:00:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:00:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:00:02 INFO - Reading from file tmpfile_stdout 20:00:02 INFO - Current package versions: 20:00:02 INFO - argparse == 1.2.1 20:00:02 INFO - blessings == 1.5.1 20:00:02 INFO - blobuploader == 1.2.4 20:00:02 INFO - docopt == 0.6.1 20:00:02 INFO - manifestparser == 1.1 20:00:02 INFO - mozInstall == 1.12 20:00:02 INFO - mozcrash == 0.16 20:00:02 INFO - mozdebug == 0.1 20:00:02 INFO - mozdevice == 0.47 20:00:02 INFO - mozfile == 1.2 20:00:02 INFO - mozhttpd == 0.7 20:00:02 INFO - mozinfo == 0.9 20:00:02 INFO - mozleak == 0.1 20:00:02 INFO - mozlog == 3.1 20:00:02 INFO - moznetwork == 0.27 20:00:02 INFO - mozprocess == 0.22 20:00:02 INFO - mozprofile == 0.28 20:00:02 INFO - mozrunner == 6.11 20:00:02 INFO - mozscreenshot == 0.1 20:00:02 INFO - mozsystemmonitor == 0.0 20:00:02 INFO - moztest == 0.7 20:00:02 INFO - mozversion == 1.4 20:00:02 INFO - psutil == 3.1.1 20:00:02 INFO - requests == 1.2.3 20:00:02 INFO - wsgiref == 0.1.2 20:00:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f546fea5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1551630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e2840>, '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 0x154f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x154fb60>, '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': '574dc5aafe09851ec43d388c000001b6-1452223546.273737-1484167495', '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 20:00:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 20:00:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 20:00:02 INFO - Using env: {'DISPLAY': ':0', 20:00:02 INFO - 'HOME': '/home/cltbld', 20:00:02 INFO - 'LANG': 'en_US.UTF-8', 20:00:02 INFO - 'LANGUAGE': 'en_US:en', 20:00:02 INFO - 'LOGNAME': 'cltbld', 20:00:02 INFO - 'MAIL': '/var/mail/cltbld', 20:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:02 INFO - 'MOZ_NO_REMOTE': '1', 20:00:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:02 INFO - 'NO_EM_RESTART': '1', 20:00:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:00:02 INFO - 'PWD': '/builds/slave/test-pgo', 20:00:02 INFO - 'SHELL': '/bin/bash', 20:00:02 INFO - 'SHLVL': '1', 20:00:02 INFO - 'TERM': 'linux', 20:00:02 INFO - 'TMOUT': '86400', 20:00:02 INFO - 'USER': 'cltbld', 20:00:02 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452223546.273737-1484167495', 20:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:02 INFO - '_': '/tools/buildbot/bin/python'} 20:00:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:02 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)) 20:00:02 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)) 20:00:02 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)) 20:00:02 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)) 20:00:02 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)) 20:00:02 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)) 20:00:02 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)) 20:00:02 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)) 20:00:02 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)) 20:00:02 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)) 20:00:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 20:00:02 INFO - Cleaning up... 20:00:02 INFO - Return code: 0 20:00:02 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 20:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f546fea5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1551630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e2840>, '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 0x154f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x154fb60>, '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': '574dc5aafe09851ec43d388c000001b6-1452223546.273737-1484167495', '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 20:00:02 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 20:00:02 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 20:00:02 INFO - Using env: {'DISPLAY': ':0', 20:00:02 INFO - 'HOME': '/home/cltbld', 20:00:02 INFO - 'LANG': 'en_US.UTF-8', 20:00:02 INFO - 'LANGUAGE': 'en_US:en', 20:00:02 INFO - 'LOGNAME': 'cltbld', 20:00:02 INFO - 'MAIL': '/var/mail/cltbld', 20:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:02 INFO - 'MOZ_NO_REMOTE': '1', 20:00:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:02 INFO - 'NO_EM_RESTART': '1', 20:00:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:00:02 INFO - 'PWD': '/builds/slave/test-pgo', 20:00:02 INFO - 'SHELL': '/bin/bash', 20:00:02 INFO - 'SHLVL': '1', 20:00:02 INFO - 'TERM': 'linux', 20:00:02 INFO - 'TMOUT': '86400', 20:00:02 INFO - 'USER': 'cltbld', 20:00:02 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452223546.273737-1484167495', 20:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:02 INFO - '_': '/tools/buildbot/bin/python'} 20:00:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:02 INFO - Downloading/unpacking jsonschema 20:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:00:04 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 20:00:04 INFO - Downloading/unpacking functools32 (from jsonschema) 20:00:04 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 20:00:04 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 20:00:04 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 20:00:04 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 20:00:04 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 20:00:04 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 20:00:04 INFO - Downloading functools32-3.2.3-2.tar.gz 20:00:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 20:00:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 20:00:04 INFO - warning: no files found matching '*.txt' 20:00:04 INFO - no previously-included directories found matching 'build' 20:00:04 INFO - no previously-included directories found matching 'dist' 20:00:04 INFO - no previously-included directories found matching '.git*' 20:00:04 INFO - Installing collected packages: jsonschema, functools32 20:00:04 INFO - Running setup.py install for functools32 20:00:04 INFO - warning: no files found matching '*.txt' 20:00:04 INFO - no previously-included directories found matching 'build' 20:00:04 INFO - no previously-included directories found matching 'dist' 20:00:04 INFO - no previously-included directories found matching '.git*' 20:00:04 INFO - Successfully installed jsonschema functools32 20:00:04 INFO - Cleaning up... 20:00:04 INFO - Return code: 0 20:00:04 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 20:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f546fea5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1551630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e2840>, '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 0x154f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x154fb60>, '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': '574dc5aafe09851ec43d388c000001b6-1452223546.273737-1484167495', '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 20:00:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 20:00:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 20:00:04 INFO - Using env: {'DISPLAY': ':0', 20:00:04 INFO - 'HOME': '/home/cltbld', 20:00:04 INFO - 'LANG': 'en_US.UTF-8', 20:00:04 INFO - 'LANGUAGE': 'en_US:en', 20:00:04 INFO - 'LOGNAME': 'cltbld', 20:00:04 INFO - 'MAIL': '/var/mail/cltbld', 20:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:04 INFO - 'MOZ_NO_REMOTE': '1', 20:00:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:04 INFO - 'NO_EM_RESTART': '1', 20:00:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:00:04 INFO - 'PWD': '/builds/slave/test-pgo', 20:00:04 INFO - 'SHELL': '/bin/bash', 20:00:04 INFO - 'SHLVL': '1', 20:00:04 INFO - 'TERM': 'linux', 20:00:04 INFO - 'TMOUT': '86400', 20:00:04 INFO - 'USER': 'cltbld', 20:00:04 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452223546.273737-1484167495', 20:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:04 INFO - '_': '/tools/buildbot/bin/python'} 20:00:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:05 INFO - Downloading/unpacking flake8 20:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:00:06 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 20:00:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:00:06 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 20:00:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:07 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 20:00:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:00: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 20:00: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 20:00: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 20:00: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 20:00: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 20:00: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 20:00:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 20:00:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 20:00:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:00:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:00:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:00:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:00:07 INFO - no previously-included directories found matching 'docs/_build' 20:00:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:00:07 INFO - Running setup.py install for pep8 20:00:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:00:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:00:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:00:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:00:07 INFO - no previously-included directories found matching 'docs/_build' 20:00:07 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 20:00:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:00:07 INFO - Cleaning up... 20:00:07 INFO - Return code: 0 20:00:07 INFO - Running post-action listener: _resource_record_post_action 20:00:07 INFO - Running post-action listener: _start_resource_monitoring 20:00:07 INFO - Starting resource monitoring. 20:00:07 INFO - ##### 20:00:07 INFO - ##### Running install step. 20:00:07 INFO - ##### 20:00:07 INFO - Running pre-action listener: _resource_record_pre_action 20:00:07 INFO - Running main action method: install 20:00:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:00:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:00:07 INFO - Reading from file tmpfile_stdout 20:00:07 INFO - Detecting whether we're running mozinstall >=1.0... 20:00:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 20:00:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 20:00:07 INFO - Reading from file tmpfile_stdout 20:00:07 INFO - Output received: 20:00:07 INFO - Usage: mozinstall [options] installer 20:00:07 INFO - Options: 20:00:07 INFO - -h, --help show this help message and exit 20:00:07 INFO - -d DEST, --destination=DEST 20:00:07 INFO - Directory to install application into. [default: 20:00:07 INFO - "/builds/slave/test-pgo"] 20:00:07 INFO - --app=APP Application being installed. [default: firefox] 20:00:07 INFO - mkdir: /builds/slave/test-pgo/build/application 20:00:07 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'] 20:00:08 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 20:00:24 INFO - Reading from file tmpfile_stdout 20:00:24 INFO - Output received: 20:00:24 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 20:00:24 INFO - Running post-action listener: _resource_record_post_action 20:00:24 INFO - ##### 20:00:24 INFO - ##### Running run-tests step. 20:00:24 INFO - ##### 20:00:24 INFO - Running pre-action listener: _resource_record_pre_action 20:00:24 INFO - Running main action method: run_tests 20:00:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 20:00:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 20:00:24 INFO - Python 2.7.3 20:00:24 INFO - Return code: 0 20:00:24 INFO - grabbing minidump binary from tooltool 20:00: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')]} 20:00:24 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 0x15e2840>, '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 0x154f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x154fb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 20:00:24 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 20:00:24 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 20:00:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:00:24 INFO - Return code: 0 20:00:24 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 20:00:24 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 20:00:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 20:00:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 20:00:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 20:00:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 20:00:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 20:00:25 INFO - Return code: 0 20:00:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D_PgXomTQjWn7LUDQlBntg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 20:00:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D_PgXomTQjWn7LUDQlBntg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:00:25 INFO - Using env: {'DISPLAY': ':0', 20:00:25 INFO - 'HOME': '/home/cltbld', 20:00:25 INFO - 'LANG': 'en_US.UTF-8', 20:00:25 INFO - 'LANGUAGE': 'en_US:en', 20:00:25 INFO - 'LOGNAME': 'cltbld', 20:00:25 INFO - 'MAIL': '/var/mail/cltbld', 20:00:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:00:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 20:00:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:25 INFO - 'MOZ_NO_REMOTE': '1', 20:00:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:00:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:25 INFO - 'NO_EM_RESTART': '1', 20:00:25 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:00:25 INFO - 'PWD': '/builds/slave/test-pgo', 20:00:25 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 20:00:25 INFO - 'SHELL': '/bin/bash', 20:00:25 INFO - 'SHLVL': '1', 20:00:25 INFO - 'TERM': 'linux', 20:00:25 INFO - 'TMOUT': '86400', 20:00:25 INFO - 'USER': 'cltbld', 20:00:25 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452223546.273737-1484167495', 20:00:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:25 INFO - '_': '/tools/buildbot/bin/python'} 20:00:25 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D_PgXomTQjWn7LUDQlBntg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:00:25 INFO - mozversion application_buildid: 20160107173005 20:00:25 INFO - mozversion application_changeset: b6d733b1a688a55548d4754de99bbc6e8636fbdb 20:00:25 INFO - mozversion application_display_name: Nightly 20:00:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:00:25 INFO - mozversion application_name: Firefox 20:00:25 INFO - mozversion application_remotingname: firefox 20:00:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:00:25 INFO - mozversion application_vendor: Mozilla 20:00:25 INFO - mozversion application_version: 46.0a1 20:00:25 INFO - mozversion platform_buildid: 20160107173005 20:00:25 INFO - mozversion platform_changeset: b6d733b1a688a55548d4754de99bbc6e8636fbdb 20:00:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:00:25 INFO - mozversion platform_version: 46.0a1 20:00:25 INFO - using testdate: 1452225625 20:00:25 INFO - actual date: 1452225625 20:00:25 INFO - starting webserver on 'localhost:43426' 20:00:25 INFO - SUITE-START | Running 3 tests 20:00:25 INFO - TEST-START | dromaeo_css 20:00:25 INFO - operating with platform_type : linux_ 20:00:25 INFO - Initialising browser for dromaeo_css test... 20:00:25 INFO - TEST-INFO | started process 19053 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpY13VzG/profile http://localhost:43426/getInfo.html) 20:00:29 INFO - PROCESS | 19053 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 20:00:30 INFO - PROCESS | 19053 | __metrics Screen width/height:1600/1200 20:00:30 INFO - PROCESS | 19053 | colorDepth:24 20:00:30 INFO - PROCESS | 19053 | Browser inner width/height: 1024/697 20:00:30 INFO - PROCESS | 19053 | __metrics 20:00:30 INFO - PROCESS | 19053 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:00:31 INFO - TEST-INFO | 19053: exit 0 20:00:31 INFO - Browser initialized. 20:00:31 INFO - Running cycle 1/1 for dromaeo_css test... 20:00:31 INFO - TEST-INFO | started process 19186 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpY13VzG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:00:42 INFO - PROCESS | 19186 | RSS: Main: 150171648 20:00:42 INFO - PROCESS | 19186 | 20:01:32 INFO - PROCESS | 19186 | 1452225692464 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] 20:03:41 INFO - PROCESS | 19186 | Cycle 1(1): loaded http://localhost:43426/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43426/tests/dromaeo/cssquery-ext.html) 20:03:42 INFO - PROCESS | 19186 | RSS: Main: 156979200 20:03:42 INFO - PROCESS | 19186 | 20:06:44 INFO - PROCESS | 19186 | Cycle 1(1): loaded http://localhost:43426/tests/dromaeo/cssquery-ext.html (next: http://localhost:43426/tests/dromaeo/cssquery-jquery.html) 20:06:45 INFO - PROCESS | 19186 | RSS: Main: 153128960 20:06:45 INFO - PROCESS | 19186 | 20:09:46 INFO - PROCESS | 19186 | Cycle 1(1): loaded http://localhost:43426/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43426/tests/dromaeo/cssquery-mootools.html) 20:09:47 INFO - PROCESS | 19186 | RSS: Main: 153444352 20:09:47 INFO - PROCESS | 19186 | 20:12:49 INFO - PROCESS | 19186 | Cycle 1(1): loaded http://localhost:43426/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43426/tests/dromaeo/cssquery-prototype.html) 20:12:49 INFO - PROCESS | 19186 | RSS: Main: 152952832 20:12:49 INFO - PROCESS | 19186 | 20:15:52 INFO - PROCESS | 19186 | Cycle 1(1): loaded http://localhost:43426/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43426/tests/dromaeo/cssquery-yui.html) 20:15:52 INFO - PROCESS | 19186 | RSS: Main: 152719360 20:15:52 INFO - PROCESS | 19186 | 20:18:55 INFO - PROCESS | 19186 | Cycle 1(1): loaded http://localhost:43426/tests/dromaeo/cssquery-yui.html (next: http://localhost:43426/tests/dromaeo/cssquery-dojo.html) 20:18:55 INFO - PROCESS | 19186 | RSS: Main: 155680768 20:18:55 INFO - PROCESS | 19186 | 20:18:55 INFO - PROCESS | 19186 | __start_tp_report 20:18:55 INFO - PROCESS | 19186 | _x_x_mozilla_page_load 20:18:55 INFO - PROCESS | 19186 | _x_x_mozilla_page_load_details 20:18:55 INFO - PROCESS | 19186 | |i|pagename|runs| 20:18:55 INFO - PROCESS | 19186 | |0;dojo.html;3187.8087314761115;3226.774125811193;3250.28493731379;3261.494468357405;3276.8689252429904;5230.267762513251;5245.082110630638;5249.107651699206;5254.133068043778;5278.604104692149;5177.948220517794;5278.076336641092;5308.097623404021;5310.176922577007;5319.175527793189;4553.635709143261;4798.088363210979;4946.109700253953;4956.7769450374635;4964.379452568429;4737.12363212805;4877.244027175793;4937.654364194508;4964.180910149821;4972.154733695263;4723.952760472403;4792.257200133985;4799.3760811094335;4816.4461086974925;4857.1742803723455;4820.349252850855;4869.050535145648;4878.146324393217;4886.096072226649;4900.338454308659;4715.174844402216;4808.687435316693;4812.085703716318;4853.126437241295;4872.902541949141;5151.356080489939;5168.819091331786;5189.403218629868;5201.167813149916;5218;5686.800961966353;5699.401562835884;5721.6853073080965;5723.7996670116345;5757.712114394263;5634.239377684001;5727.341355744059;5764.16419619157;5777.046787280094;5783.5951483396175;5287.47125287472;5357.169638705968;5360.973195134077;5370.785168593252;5416.674999500043;5812.79655212074;5819.505342045889;5838.182654428383;5842.853928651818;5862.94137058624;5510.311211098613;5601.859953501195;5629.577781666391;5630.042892708249;5660.801871934545;5604.747786349542;5605.495505404533;5631.521320687705;5631.7747290108755;5712;5562.471565201299;5582.134769110794;5603.803866864721;5609.551235901118;5624.268845050199;5562;5618.410066942994;5628.831135065954;5663.292088488939;5742.712864356766;4356.934645980313;4375.671824613167;4376.956230437719;4382.320740285197;4412.867613971586;3968.7420317679257;3978.204359128186;3983.063979964706;4016.3975403689096;4035.5762644922447;5267.130923397596;5328.49379308965;5365.141577347606;5391.3799913009725;5432.158015507603;5769.249997500382;5776;5787.305523337226;5792.710364481759;5817.94182058174;5229.241759944786;5349.384820745586;5386.111291636836;5390.245365648812;5441.5102640762525;4810.39870016248;4851;4907.312976183337;4915.827946021872;4955.4796746341835;5865.794697185578;5886.941130588725;5887.3523912370465;5887.61730487517;5894.381089985575;5630.718464076698;5682.6306290091015;5689.77240910359;5728.2266893970445;5742.2535070442245;5893.528517718487;5936.050231962865;5969;5972.552058595709;5987.221661184019;5582.078956972054;5634.915476267941;5651.378348381757;5651.85870353228;5655.519280861173;5597.104463285855;5705.657660540381;5727.8568035799435;5734.082546792493;5773.393793651606;5614.494695477427;5627.324721033502;5628.690422026828;5636.802711905064;5663.32040155184;5625.915611265752;5630.690312032713;5635.577331700057;5638.097904335286;5638.126090455986;5374.7312634367345;5480.671159730429;5518.78586710923;5528.668279903219;5615.410381909841;5599.384067752462;5615.859603509782;5615.887682246251;5648.689322087324;5661.2923384576925;5504.972475137759;5510.201020851874;5529.419410961791;5533.5849811263515;5579.553635709052 20:18:55 INFO - PROCESS | 19186 | |1;ext.html;487.4151018777468;521.244195915922;551.5284431810801;561.9550435965123;567.3843879390861;24843.50312993739;35861;35970.8201458993;36215.63784362155;36287.09282267945;38343.80828095863;38800.41799373004;39245.803770981176;39274.80362598183;39280.80359598205;8287.461315014534;8564.657413703444;8578.78553036176;8582.399232053758;8589.785255368603;8204.097549269576;8419.70531031414;8421.957890210571;8440.915590844075;8462.15378462152;8443.95778021109;8511.82976340476;8524.573771311441;8537.658493660278;8561;8415.873761893547;8463.74608761735;8540.103289154642;8640.740777776677;8683.869741953877;8451.830963380698;8604.612792424356;8614.56927153646;8639.65441382344;8654.826903461959;38259.80870095632;38432.807835960644;38447;38516.229675406335;38607.806960965296;2892.652881654194;2938.720821521952;2942.7204415580486;2987.626546681665;3443.276911848515;28360.14919552417;29203.12390628263;29348.11955641334;29408.11775646734;29836;3630.945535816965;3663.7984910829896;3681.208540163878;3791.393377059685;3804.8478060877533;261132;262157;263436.9999999981;264227;265146;41800.37299440511;42202.577974219865;42263.366049509284;56380.43619563752;56687.43312566904;40609.1878162441;40712.18575628471;40814.79592602018;40821.79589102035;41279.58720412818;13946.511872084631;14006.649833754238;14120.082194657314;14132.364043618061;14137.717245655234;11079.778404432027;11156.888431115747;11165.162612804072;11182.832257516144;11183.776324473465;14195.219262940638;14284.71444568864;14354.49759258442;14363.784543231859;14419.42322307096;5663.745131469093;5726.656400615976;5727.885442291131;5743;5768.077107662753;941.2893265584577;969.1132613658424;989.7638108893946;1013.6097602423121;1032.932859364139;28599.57100643492;28703.712962870522;28913;29196.124116276547;29272.414551708847;1040.2198351236573;1051.379685985257;1059.9523021464054;1064.090202876545;1157.8147496400536;15783.368665253261;16230.837691622932;16399.262033208535;16891.23989420479;16938.661226775643;370680;372677;373666;373962;376182;54128.72935635375;54558;54615.45384546183;54744;54806.725966369915;1275.1201670847086;1281.525835440893;1285.8714128587067;1290.993545032269;1307.2483322089836;28945;29011;29772.702272976992;30154;30393.544096838123;44666.776666116464;44896.77551612352;45111.32333014942;45405.54594454145;45483.54516454926;300281;302625;304620;305010;306438;30937.226569335948;40874;42566.78716606397;42730.35904461373;42812.78593607012;40964;41674.37488437615;42093;42357.57642423536;42447.3632895513;35057;35233.1191720209;35381.82309088438;36246;36280.27439451249;35623.46564801478;36873.63126368809;37552;38174.435310081455;39313.41029884497;33409.83295083509;33818.154546136546;33847.83076084702;34120.82939585286;34135.65864341325;29266.414671706872;29881.252968675955;34110.65889341174;35518.644813552564;35893.64106358903;23406.531869362178;23931.401714957265;24129.39676508031;26805.463890721687;27291.454170916073 20:18:55 INFO - PROCESS | 19186 | |2;jquery.html;341.1488336600183;345.3679766028169;351.2097779995011;351.6413258476354;353.87968090849114;16382.344706211767;16439;16512.66974660506;17130.914345428286;17485.300587976464;14972.700545989073;15271.236438178103;15438.768418473732;15961.600959976007;16010.119443430607;4740;4892.510748925097;4929.433115191745;4934.876628084291;4938.925916111261;4341.674374421915;4831.589314908237;4912.48418916014;4917.164082106033;5413.593980451462;5390.110631745757;5391.757370918318;5411.756470958797;5420.6747595144225;5422.864428389283;4805.399325084364;4868.123737727207;4877.8780530486665;4889.853304400855;5379.139337705968;4682.8126874924965;4683;4720.527947205286;4734.153680064743;4739.265413860857;17146.742798858028;17769.822301776945;17828.286868525243;17841.46475605734;18464.63070738578;1874.2315650583196;2066.2354928676486;2091.7176181215495;2125.532382875765;2157.7302837145357;9246.35275530713;9978.900210997943;12198.207116537396;12350.691232719164;12455.875441245562;1874.4189301316635;1896.1277812206401;1990.233760002395;2024.5141166120172;2030.2995466564012;50595.74702126466;52326.47673523254;53222.467775322526;53642.73178634121;54139.458605413834;9175.265978721687;9217.354785164975;9298.814023719488;9302.395344302598;9356.532173391302;11834.940825295818;11999.64001079969;12432.689182770504;12545.937270313772;12564.120511564286;6935.826604334932;7168.139823221247;7364.521306115085;7374.373178279799;7407.6666550005375;7107.822304442327;7155.427565794724;7171.820704482429;7188.460865435009;7188.640567971581;4106.178764247163;4243.342281946241;4246.8301267949555;4269.4449721536;4297.226499230169;1688.7213609754253;1695.203254470397;1726.7927848658242;1741.7126174181371;1746.3538490758247;439.16120210397986;441.94696636403836;882.5102068351998;911.3165126155384;929.4423345992485;9682.419054856731;10175.592976281014;10254;10355.223358248162;10523.473826308807;873.3100850328296;926.8424367857481;943.0333907744616;1008.5461542305992;1015.8863084645537;5463.453654634504;5482.506574408322;5522.364928033247;5611.607187496836;9183.357164998519;385147;386993;410035;411439;420065;61050;63483;72860.27139728535;74032;77858;441.32917964694127;446.5244514591949;450.87150162203613;453.42867986336796;455.3647661512238;9590.232781377612;9632.95183524106;9790.902090979283;10026.448545330077;10153.746156346151;20228;30188.69811301859;30268;30709.539356909216;30815.61329740122;41356.379654304605;41501.58498414977;42543.57456425396;45617.31574026459;45640.31539526844;2924.883004679789;5678.7728490861555;6745.898811517929;6767.64647070578;7223.061002069908;9987.750306242402;10012.098911098035;10725.410102444128;10907.563697452331;10927.235093543375;8687.348448866234;9337.159655631025;9589.376690515093;9664.9033509664;9674.177694896012;9421.576029078846;9678.467684277432;9727.07592778685;9885.456299903575;9936.99441893449;8708.78228044304;9541.379810312308;9708;9773.511324433608;9901.900980990386;7207.963960180376;7220.566765994057;7285.162206346338;7298.854022919406;7324.340809327186;8344.749657510285;9213.12475314844;9333.859992099988;9620.95189524048;9737.659181928599 20:18:55 INFO - PROCESS | 19186 | |3;mootools.html;1381.6338670252385;1382.7096309774943;1475.4393330534394;1636.0919689572283;1649.9935039625834;7194.0647715797;7236.674349654265;7357.448191385641;7382.741604043859;7405.740799072034;7292.489525733201;7312.488125831194;7361.595112268823;7400.518966267189;7404.074490688664;2227.354067320475;2249.5613355395703;2256.029907139937;2262.242148880127;2263.3323169664905;2217.090992692996;2236.8769717665523;2237.85453945493;2242.3385101395047;2242.9775702242932;2172.16371696897;2191.079746506463;2200.273909609833;2238.529908719171;2250.4036430345973;2235;2267.1724820440586;2291.049214575949;2291.8510296830736;2293.3922510534803;2248.3929339078522;2262.1064679451524;2264.4565304327007;2264.5810525052752;2274.0676322707777;7279.526830755984;7289.2346303638415;7295.744648937261;7295.744648937261;7328.890066649004;4405.647548196137;4543.068670922486;4556.931646025312;4569;4569.177548041352;2994.431058098976;2999.895003674861;3053.084074777558;3056.2664960409566;3085.3674996625864;1070.8714954205545;1071.7427817323864;1800.6398720256002;1847.214933653192;1886.2737845929416;9578.6647467339;9585.281103917234;9598.328117031811;9632.614695412245;9702.708918732378;3849.095462566295;3901.2782635212575;3931.488906442144;3973.562908080109;3980.5422376426504;7679.769606911802;7685.615719214017;7725.381969442431;7743.922560774433;7762.611869406507;4383.408239887638;4387.034852332482;4407.162639098561;4412.227860124465;4433.268510695763;4097.037196258877;4102.323116685713;4103.815328310233;4118.9588104118575;4128.855490057834;3282.7373810095137;3305.9173520662175;3336.366090442808;3365.865365385357;3366.0911553880314;1009.3842755918884;1017.9287449878585;1024.1653052761976;1024.329064462778;1049.076812405094;1021.8518314844306;1023.6621914768109;1075.7955988362187;1157.438642258504;1299.9025073119553;6764.763233286812;6808.863822723617;6844.349786770249;6864.073350097673;6877.65611719422;1031.664708969588;1044.081208536483;1083.539495714334;1105.9557617695202;1110.7889500994786;5482.972585137049;5500.50495455411;5574.749136288877;5608.607397482218;5610.579206559524;8687.522186279815;8758.824823503493;8769.473831570127;8777.122287771299;8830.514321712368;8631.352648551258;8649.437786543855;8687.478751274944;8709.782255443537;8711.91288087111;6723.746915368656;6949.409300209438;6962.860742785218;6964.233934267227;6976.058232138596;6758.459323254227;6781.457483401217;6782.762603308861;6801.557898736566;6818.795436136924;7691.2308769124875;7866.488678235896;7871.134175240833;7904.881426778488;7978.643630582931;7986.440949133505;8099.109097999333;8101.068377136469;8127.471714338549;8153.9184608153155;6106.938930610637;6190.876182476235;6313.326968353482;6400.743970241325;6421.646809425526;6824.249332573314;6852.314768523108;6866.141732283465;6867.484938629523;6882.965585172042;6599.835004124935;6658;6750.561213521106;6755.831104222434;6833.043373927555;5927.733252003756;5972.223610930551;6269.686515674107;6456.903146452901;6457.580257283262;6429.7428102875365;6430.356964303533;6445.774397896051;6476.902846457401;6498.610083395011;6046.697665116814;6094.542909281733;6131.386861314011;6141.477974372228;6144.846378840565;6127.3566275540425;6135.202423684892;6162.291336496361;6165.876682466415;6169.1054797053275 20:18:55 INFO - PROCESS | 19186 | |4;prototype.html;328.08137215795773;335.74818885835623;337.17056042136346;338.6241272187872;340.57768367224634;6255.249370075586;6277.058441233811;6284.214473190851;6298.842528936773;6348;6169.3830616938285;6174.6912654367325;6175.783847565336;6200.658963756991;6329.386006568318;4687.320338550908;4699.976500117495;4702.036082603076;4708.317293992369;4711.340412342275;4683.88290292742;4695.812167513295;4695.8356457524;4702.036082603058;4708.387909571751;4562;4575.633949284049;4612.308153776943;4677.719336839784;4702.623790096801;4656.348111264426;4676.7193968361835;4684.297355396684;4692.483826779052;4696.718196908179;4067.0849058961794;4068.593140685937;4071.470708807866;4073.124278280184;4080.061585835245;5908.8227353179045;5963.671998040106;5971.910421343683;5973.313068997078;5981.880362392728;5459.863503412446;5476.863078423032;5522.889542209174;5532.419095994943;5539.753555450032;6633;6634.170728658918;6649.202095748541;6653.933460665428;6657.367550082783;4514.864554063383;4522.570355816225;4543.636509079266;4555.726656400627;4562.726236425825;6839.487038472134;6930.61881596512;6941.548799328028;6988.405985491188;7021.578705277649;4606.216943119678;4608.5621865922685;4613.5386461354265;4619.491855895849;4630.374899388539;4661.627069834405;4669.136209801198;4670.7664616769025;4672.299155126758;4683.601893838993;5469.890602188014;5475.397706252309;5478.945210547923;5482.671039737628;5486.91769623456;6464.288928217892;6674.365935236242;6685.565438246498;6709.865802683919;6720.092787473726;1635.419426103716;1669.8831081824155;1670.0146913321198;1673.5481420016526;1674.5729838891004;1073.4042606353548;1077.8383242513685;1092.9508172132273;1095.780843831237;1102.685734565645;6265.655388953652;6271.7804876830005;6302.369763023753;6313.652749098844;6351.587146835441;6906.758263460755;6911.550749201286;6914.101166848378;6937.861242775116;6942.201646810681;6146.907796383058;6305.747770089145;6311.305756366796;6359.713812878432;6383.872322553523;3764.7741135531955;3782.659560639501;3786.772793632336;3788.204477059848;3802.8288727007352;7244.746433874894;7291.30732580404;7301.452391070691;7305.196428392873;7305.963470182615;7012.649367531603;7143.749968751069;7145.642717864086;7151.106111736033;7160.498765086498;7270.454715896329;7274.127104747464;7274.59989700561;7275.272472752682;7311.853762924712;6912.135983002125;6914.135733033371;6933.16801983745;6937.132858392701;6966.582005079711;6744.696488657924;6865.622390768555;6892.172939247323;6900.171979362509;6905.551139175937;7215.783526494213;7257.854842903218;7305.634718264172;7316.597587132759;7335.963320183365;4604.976975115103;4624.052069325713;4626.005408837116;4640.095181439587;4657.93013104797;6809.591424514545;6925.134358205224;6930.826729331606;6954.3045695430055;6955.513114082168;6747.831304217238;6750.9873518972545;6751.358620931003;6758.290379510081;6760.08738820253;6603.108580341593;6698.296678848846;6724.4284235840505;6744.595324280559;6751.3248675134055;6542.280349161493;6581.243157037002;6596.571222870498;6610.173728283965;6611.834704132435;6758.797236082925;6762.526623136333;6764.966175169093;6773.424258938046;6777.8983315249325;6340.651264180515;6506.154199953976;6620.073189753534;6626.204855417381;6626.734930602722 20:18:55 INFO - PROCESS | 19186 | |5;yui.html;725.2348772045492;765.3379826450122;819.3281509162485;823.6375994562392;831.2892476932227;13083.738325233502;13217.07480476367;13222.801657975138;13250.33748312583;13272.137311074786;12345.074119441033;12411.255324680526;12416.875831241685;12419;12446.43991020404;445.16531503431065;452.8460323490013;770.2413123073768;781.8827175923615;782.4249176855036;794.1700922535935;795.824918517928;800.7877912353231;802.4543310548825;803.3051410529908;828.9336853051772;832.4921797703396;834.7913021744564;837.7696133563288;839.5172775654023;824.6824972385615;829.5603330234954;829.6432534010373;836.786619412049;837.7151768398743;607.7720854679495;608.9299730531002;613.1446631948407;614.9169862068608;616.134331264574;12910.677233069155;12953.740925181537;12959.222446653232;12983.156094853804;12984.610461686165;12136.635900922987;12297.631071067794;12305.44625491846;12598.55905043319;12805.359732013456;10467.685969420929;10499.947500262526;10611.946940265327;10615.203859710553;10668.14654827612;3595.9280814383565;3620.5112309838096;3626.873059442933;3644.726645501598;3655.670989610948;45817.312740308924;46313.30530042052;46464.53535464636;46622.30066549039;46633.30050049252;9809.362391444532;9942.801143977225;10067.748306292402;10144.898551014543;10147.594096236067;16006.199690015452;16015.519534413987;16025.759613605805;16046.839531604535;16062.357505699641;7204.387627051759;7376.557406555624;7487.438442116863;7533.171351151369;7621.199774023758;4290.678199135077;4302.612764851178;4319.200947824663;4380.7371557706;4549.9317510236715;2871.7271859173347;2875.511163102278;2884.1924261206896;2893.85530723463;2897.6812550619416;539.4093467652914;539.7085573790188;547.8849441617305;551.1127085392515;553.7840242305504;494.39930484461553;604.6493034040334;646.4795839349275;682.668905580793;714.7212587091038;8488.405811593253;8571.957140214383;8650.956745216234;8659.48043117415;8777.648894044294;544.363095178642;659.3910857507666;686.7630667419733;694;697.5396238482577;3713.702903767692;3799.4110912808005;3916.804159792056;4070.430139780433;4073.9592604073578;54738;57917.131243031385;58668.70665646644;58738.70630646819;58969;51273.23090153651;52066;52308.21537676938;52559.474405256224;52820;45082;45126.77436612796;46025.07949840985;46410.07179856452;47428.525714743104;8194;8211.38414618894;8216.34269258446;8357.749267521984;8702.390832641655;33551.32897342088;33657.83171084129;34457.31085378329;34472.310553789284;34483;45782;45891.77054114708;45902.31146532871;46026.30960535662;46131.53868461272;10410.323328983592;10551.472426378497;10568.101711354313;11182.66452006441;11560.30638161713;11201.271917325348;11291.887081129084;11433;11762.764744704888;11848.940755296167;10667.093297069836;10749.89250107489;11104.5558177672;11106.047396369811;11124;11374.886251137714;11376.317420954769;11534.538618455168;11546.94226528862;11761.705957350792;11007.61473348429;11455.484503197209;11510.712232193928;11776.882231177578;11797.115216358636;9011.2790976723;9216.400933939272;9263.120003599648;9472.242220622196;9612.75968100803;9167.220786233245;9250.843644544431;9431.386959847589;9433.24534037289;9634.181094607036 20:18:55 INFO - PROCESS | 19186 | __end_tp_report 20:18:55 INFO - PROCESS | 19186 | __start_cc_report 20:18:55 INFO - PROCESS | 19186 | _x_x_mozilla_cycle_collect,316 20:18:55 INFO - PROCESS | 19186 | __end_cc_report 20:18:55 INFO - PROCESS | 19186 | __startTimestamp1452226735271__endTimestamp 20:18:55 INFO - PROCESS | 19186 | 20:18:55 INFO - PROCESS | 19186 | ------- Summary: start ------- 20:18:55 INFO - PROCESS | 19186 | Number of tests: 6 20:18:55 INFO - PROCESS | 19186 | 20:18:55 INFO - PROCESS | 19186 | [#0] dojo.html Cycles:165 Average:5299.58 Median:5529.42 stddev:580.12 (10.5%) stddev-sans-first:557.74 20:18:55 INFO - PROCESS | 19186 | Values: 3187.8 3226.8 3250.3 3261.5 3276.9 5230.3 5245.1 5249.1 5254.1 5278.6 5177.9 5278.1 5308.1 5310.2 5319.2 4553.6 4798.1 4946.1 4956.8 4964.4 4737.1 4877.2 4937.7 4964.2 4972.2 4724.0 4792.3 4799.4 4816.4 4857.2 4820.3 4869.1 4878.1 4886.1 4900.3 4715.2 4808.7 4812.1 4853.1 4872.9 5151.4 5168.8 5189.4 5201.2 5218.0 5686.8 5699.4 5721.7 5723.8 5757.7 5634.2 5727.3 5764.2 5777.0 5783.6 5287.5 5357.2 5361.0 5370.8 5416.7 5812.8 5819.5 5838.2 5842.9 5862.9 5510.3 5601.9 5629.6 5630.0 5660.8 5604.7 5605.5 5631.5 5631.8 5712.0 5562.5 5582.1 5603.8 5609.6 5624.3 5562.0 5618.4 5628.8 5663.3 5742.7 4356.9 4375.7 4377.0 4382.3 4412.9 3968.7 3978.2 3983.1 4016.4 4035.6 5267.1 5328.5 5365.1 5391.4 5432.2 5769.2 5776.0 5787.3 5792.7 5817.9 5229.2 5349.4 5386.1 5390.2 5441.5 4810.4 4851.0 4907.3 4915.8 4955.5 5865.8 5886.9 5887.4 5887.6 5894.4 5630.7 5682.6 5689.8 5728.2 5742.3 5893.5 5936.1 5969.0 5972.6 5987.2 5582.1 5634.9 5651.4 5651.9 5655.5 5597.1 5705.7 5727.9 5734.1 5773.4 5614.5 5627.3 5628.7 5636.8 5663.3 5625.9 5630.7 5635.6 5638.1 5638.1 5374.7 5480.7 5518.8 5528.7 5615.4 5599.4 5615.9 5615.9 5648.7 5661.3 5505.0 5510.2 5529.4 5533.6 5579.6 20:18:55 INFO - PROCESS | 19186 | 20:18:55 INFO - PROCESS | 19186 | [#1] ext.html Cycles:180 Average:46939.79 Median:3672.50 stddev:83167.98 (2264.6%) stddev-sans-first:83328.16 20:18:55 INFO - PROCESS | 19186 | Values: 487.4 521.2 551.5 562.0 567.4 24843.5 35861.0 35970.8 36215.6 36287.1 38343.8 38800.4 39245.8 39274.8 39280.8 8287.5 8564.7 8578.8 8582.4 8589.8 8204.1 8419.7 8422.0 8440.9 8462.2 8444.0 8511.8 8524.6 8537.7 8561.0 8415.9 8463.7 8540.1 8640.7 8683.9 8451.8 8604.6 8614.6 8639.7 8654.8 38259.8 38432.8 38447.0 38516.2 38607.8 2892.7 2938.7 2942.7 2987.6 3443.3 28360.1 29203.1 29348.1 29408.1 29836.0 3630.9 3663.8 3681.2 3791.4 3804.8 261132.0 262157.0 263437.0 264227.0 265146.0 41800.4 42202.6 42263.4 56380.4 56687.4 40609.2 40712.2 40814.8 40821.8 41279.6 13946.5 14006.6 14120.1 14132.4 14137.7 11079.8 11156.9 11165.2 11182.8 11183.8 14195.2 14284.7 14354.5 14363.8 14419.4 5663.7 5726.7 5727.9 5743.0 5768.1 941.3 969.1 989.8 1013.6 1032.9 28599.6 28703.7 28913.0 29196.1 29272.4 1040.2 1051.4 1060.0 1064.1 1157.8 15783.4 16230.8 16399.3 16891.2 16938.7 370680.0 372677.0 373666.0 373962.0 376182.0 54128.7 54558.0 54615.5 54744.0 54806.7 1275.1 1281.5 1285.9 1291.0 1307.2 28945.0 29011.0 29772.7 30154.0 30393.5 44666.8 44896.8 45111.3 45405.5 45483.5 300281.0 302625.0 304620.0 305010.0 306438.0 30937.2 40874.0 42566.8 42730.4 42812.8 40964.0 41674.4 42093.0 42357.6 42447.4 35057.0 35233.1 35381.8 36246.0 36280.3 35623.5 36873.6 37552.0 38174.4 39313.4 33409.8 33818.2 33847.8 34120.8 34135.7 29266.4 29881.3 34110.7 35518.6 35893.6 23406.5 23931.4 24129.4 26805.5 27291.5 20:18:55 INFO - PROCESS | 19186 | 20:18:55 INFO - PROCESS | 19186 | [#2] jquery.html Cycles:180 Average:22767.40 Median:4818.49 stddev:66099.70 (1371.8%) stddev-sans-first:66263.67 20:18:55 INFO - PROCESS | 19186 | Values: 341.1 345.4 351.2 351.6 353.9 16382.3 16439.0 16512.7 17130.9 17485.3 14972.7 15271.2 15438.8 15961.6 16010.1 4740.0 4892.5 4929.4 4934.9 4938.9 4341.7 4831.6 4912.5 4917.2 5413.6 5390.1 5391.8 5411.8 5420.7 5422.9 4805.4 4868.1 4877.9 4889.9 5379.1 4682.8 4683.0 4720.5 4734.2 4739.3 17146.7 17769.8 17828.3 17841.5 18464.6 1874.2 2066.2 2091.7 2125.5 2157.7 9246.4 9978.9 12198.2 12350.7 12455.9 1874.4 1896.1 1990.2 2024.5 2030.3 50595.7 52326.5 53222.5 53642.7 54139.5 9175.3 9217.4 9298.8 9302.4 9356.5 11834.9 11999.6 12432.7 12545.9 12564.1 6935.8 7168.1 7364.5 7374.4 7407.7 7107.8 7155.4 7171.8 7188.5 7188.6 4106.2 4243.3 4246.8 4269.4 4297.2 1688.7 1695.2 1726.8 1741.7 1746.4 439.2 441.9 882.5 911.3 929.4 9682.4 10175.6 10254.0 10355.2 10523.5 873.3 926.8 943.0 1008.5 1015.9 5463.5 5482.5 5522.4 5611.6 9183.4 385147.0 386993.0 410035.0 411439.0 420065.0 61050.0 63483.0 72860.3 74032.0 77858.0 441.3 446.5 450.9 453.4 455.4 9590.2 9633.0 9790.9 10026.4 10153.7 20228.0 30188.7 30268.0 30709.5 30815.6 41356.4 41501.6 42543.6 45617.3 45640.3 2924.9 5678.8 6745.9 6767.6 7223.1 9987.8 10012.1 10725.4 10907.6 10927.2 8687.3 9337.2 9589.4 9664.9 9674.2 9421.6 9678.5 9727.1 9885.5 9937.0 8708.8 9541.4 9708.0 9773.5 9901.9 7208.0 7220.6 7285.2 7298.9 7324.3 8344.7 9213.1 9333.9 9621.0 9737.7 20:18:55 INFO - PROCESS | 19186 | 20:18:55 INFO - PROCESS | 19186 | [#3] mootools.html Cycles:180 Average:5123.07 Median:6129.37 stddev:2548.17 (41.6%) stddev-sans-first:2539.80 20:18:55 INFO - PROCESS | 19186 | Values: 1381.6 1382.7 1475.4 1636.1 1650.0 7194.1 7236.7 7357.4 7382.7 7405.7 7292.5 7312.5 7361.6 7400.5 7404.1 2227.4 2249.6 2256.0 2262.2 2263.3 2217.1 2236.9 2237.9 2242.3 2243.0 2172.2 2191.1 2200.3 2238.5 2250.4 2235.0 2267.2 2291.0 2291.9 2293.4 2248.4 2262.1 2264.5 2264.6 2274.1 7279.5 7289.2 7295.7 7295.7 7328.9 4405.6 4543.1 4556.9 4569.0 4569.2 2994.4 2999.9 3053.1 3056.3 3085.4 1070.9 1071.7 1800.6 1847.2 1886.3 9578.7 9585.3 9598.3 9632.6 9702.7 3849.1 3901.3 3931.5 3973.6 3980.5 7679.8 7685.6 7725.4 7743.9 7762.6 4383.4 4387.0 4407.2 4412.2 4433.3 4097.0 4102.3 4103.8 4119.0 4128.9 3282.7 3305.9 3336.4 3365.9 3366.1 1009.4 1017.9 1024.2 1024.3 1049.1 1021.9 1023.7 1075.8 1157.4 1299.9 6764.8 6808.9 6844.3 6864.1 6877.7 1031.7 1044.1 1083.5 1106.0 1110.8 5483.0 5500.5 5574.7 5608.6 5610.6 8687.5 8758.8 8769.5 8777.1 8830.5 8631.4 8649.4 8687.5 8709.8 8711.9 6723.7 6949.4 6962.9 6964.2 6976.1 6758.5 6781.5 6782.8 6801.6 6818.8 7691.2 7866.5 7871.1 7904.9 7978.6 7986.4 8099.1 8101.1 8127.5 8153.9 6106.9 6190.9 6313.3 6400.7 6421.6 6824.2 6852.3 6866.1 6867.5 6883.0 6599.8 6658.0 6750.6 6755.8 6833.0 5927.7 5972.2 6269.7 6456.9 6457.6 6429.7 6430.4 6445.8 6476.9 6498.6 6046.7 6094.5 6131.4 6141.5 6144.8 6127.4 6135.2 6162.3 6165.9 6169.1 20:18:55 INFO - PROCESS | 19186 | 20:18:55 INFO - PROCESS | 19186 | [#4] prototype.html Cycles:180 Average:5565.87 Median:6300.61 stddev:1720.49 (27.3%) stddev-sans-first:1679.80 20:18:55 INFO - PROCESS | 19186 | Values: 328.1 335.7 337.2 338.6 340.6 6255.2 6277.1 6284.2 6298.8 6348.0 6169.4 6174.7 6175.8 6200.7 6329.4 4687.3 4700.0 4702.0 4708.3 4711.3 4683.9 4695.8 4695.8 4702.0 4708.4 4562.0 4575.6 4612.3 4677.7 4702.6 4656.3 4676.7 4684.3 4692.5 4696.7 4067.1 4068.6 4071.5 4073.1 4080.1 5908.8 5963.7 5971.9 5973.3 5981.9 5459.9 5476.9 5522.9 5532.4 5539.8 6633.0 6634.2 6649.2 6653.9 6657.4 4514.9 4522.6 4543.6 4555.7 4562.7 6839.5 6930.6 6941.5 6988.4 7021.6 4606.2 4608.6 4613.5 4619.5 4630.4 4661.6 4669.1 4670.8 4672.3 4683.6 5469.9 5475.4 5478.9 5482.7 5486.9 6464.3 6674.4 6685.6 6709.9 6720.1 1635.4 1669.9 1670.0 1673.5 1674.6 1073.4 1077.8 1093.0 1095.8 1102.7 6265.7 6271.8 6302.4 6313.7 6351.6 6906.8 6911.6 6914.1 6937.9 6942.2 6146.9 6305.7 6311.3 6359.7 6383.9 3764.8 3782.7 3786.8 3788.2 3802.8 7244.7 7291.3 7301.5 7305.2 7306.0 7012.6 7143.7 7145.6 7151.1 7160.5 7270.5 7274.1 7274.6 7275.3 7311.9 6912.1 6914.1 6933.2 6937.1 6966.6 6744.7 6865.6 6892.2 6900.2 6905.6 7215.8 7257.9 7305.6 7316.6 7336.0 4605.0 4624.1 4626.0 4640.1 4657.9 6809.6 6925.1 6930.8 6954.3 6955.5 6747.8 6751.0 6751.4 6758.3 6760.1 6603.1 6698.3 6724.4 6744.6 6751.3 6542.3 6581.2 6596.6 6610.2 6611.8 6758.8 6762.5 6765.0 6773.4 6777.9 6340.7 6506.2 6620.1 6626.2 6626.7 20:18:55 INFO - PROCESS | 19186 | 20:18:55 INFO - PROCESS | 19186 | [#5] yui.html Cycles:180 Average:13630.37 Median:45963.70 stddev:15957.60 (34.7%) stddev-sans-first:15972.94 20:18:55 INFO - PROCESS | 19186 | Values: 725.2 765.3 819.3 823.6 831.3 13083.7 13217.1 13222.8 13250.3 13272.1 12345.1 12411.3 12416.9 12419.0 12446.4 445.2 452.8 770.2 781.9 782.4 794.2 795.8 800.8 802.5 803.3 828.9 832.5 834.8 837.8 839.5 824.7 829.6 829.6 836.8 837.7 607.8 608.9 613.1 614.9 616.1 12910.7 12953.7 12959.2 12983.2 12984.6 12136.6 12297.6 12305.4 12598.6 12805.4 10467.7 10499.9 10611.9 10615.2 10668.1 3595.9 3620.5 3626.9 3644.7 3655.7 45817.3 46313.3 46464.5 46622.3 46633.3 9809.4 9942.8 10067.7 10144.9 10147.6 16006.2 16015.5 16025.8 16046.8 16062.4 7204.4 7376.6 7487.4 7533.2 7621.2 4290.7 4302.6 4319.2 4380.7 4549.9 2871.7 2875.5 2884.2 2893.9 2897.7 539.4 539.7 547.9 551.1 553.8 494.4 604.6 646.5 682.7 714.7 8488.4 8572.0 8651.0 8659.5 8777.6 544.4 659.4 686.8 694.0 697.5 3713.7 3799.4 3916.8 4070.4 4074.0 54738.0 57917.1 58668.7 58738.7 58969.0 51273.2 52066.0 52308.2 52559.5 52820.0 45082.0 45126.8 46025.1 46410.1 47428.5 8194.0 8211.4 8216.3 8357.7 8702.4 33551.3 33657.8 34457.3 34472.3 34483.0 45782.0 45891.8 45902.3 46026.3 46131.5 10410.3 10551.5 10568.1 11182.7 11560.3 11201.3 11291.9 11433.0 11762.8 11848.9 10667.1 10749.9 11104.6 11106.0 11124.0 11374.9 11376.3 11534.5 11546.9 11761.7 11007.6 11455.5 11510.7 11776.9 11797.1 9011.3 9216.4 9263.1 9472.2 9612.8 9167.2 9250.8 9431.4 9433.2 9634.2 20:18:55 INFO - PROCESS | 19186 | -------- Summary: end -------- 20:18:55 INFO - PROCESS | 19186 | 20:18:55 INFO - TEST-INFO | 19186: exit 0 20:18:55 INFO - TEST-OK | dromaeo_css | took 1110557ms 20:18:55 INFO - TEST-START | kraken 20:18:55 INFO - operating with platform_type : linux_ 20:18:55 INFO - Initialising browser for kraken test... 20:18:55 INFO - TEST-INFO | started process 19429 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4qvGT3/profile http://localhost:43426/getInfo.html) 20:18:59 INFO - PROCESS | 19429 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 20:19:00 INFO - PROCESS | 19429 | __metrics Screen width/height:1600/1200 20:19:00 INFO - PROCESS | 19429 | colorDepth:24 20:19:00 INFO - PROCESS | 19429 | Browser inner width/height: 1024/697 20:19:00 INFO - PROCESS | 19429 | __metrics 20:19:00 INFO - PROCESS | 19429 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:19:01 INFO - TEST-INFO | 19429: exit 0 20:19:01 INFO - Browser initialized. 20:19:01 INFO - Running cycle 1/1 for kraken test... 20:19:01 INFO - TEST-INFO | started process 19551 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4qvGT3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:19:13 INFO - PROCESS | 19551 | RSS: Main: 150704128 20:19:13 INFO - PROCESS | 19551 | 20:19:15 INFO - PROCESS | 19551 | Cycle 1(1): loaded http://localhost:43426/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43426/tests/kraken/driver.html?testName=audio-beat-detection) 20:19:16 INFO - PROCESS | 19551 | RSS: Main: 151121920 20:19:16 INFO - PROCESS | 19551 | 20:19:18 INFO - PROCESS | 19551 | Cycle 1(1): loaded http://localhost:43426/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43426/tests/kraken/driver.html?testName=audio-dft) 20:19:19 INFO - PROCESS | 19551 | RSS: Main: 151814144 20:19:19 INFO - PROCESS | 19551 | 20:19:22 INFO - PROCESS | 19551 | Cycle 1(1): loaded http://localhost:43426/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43426/tests/kraken/driver.html?testName=audio-fft) 20:19:22 INFO - PROCESS | 19551 | RSS: Main: 145600512 20:19:22 INFO - PROCESS | 19551 | 20:19:25 INFO - PROCESS | 19551 | Cycle 1(1): loaded http://localhost:43426/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43426/tests/kraken/driver.html?testName=audio-oscillator) 20:19:25 INFO - PROCESS | 19551 | RSS: Main: 146423808 20:19:25 INFO - PROCESS | 19551 | 20:19:27 INFO - PROCESS | 19551 | Cycle 1(1): loaded http://localhost:43426/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43426/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:19:28 INFO - PROCESS | 19551 | RSS: Main: 147296256 20:19:28 INFO - PROCESS | 19551 | 20:19:31 INFO - PROCESS | 19551 | Cycle 1(1): loaded http://localhost:43426/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43426/tests/kraken/driver.html?testName=imaging-darkroom) 20:19:32 INFO - PROCESS | 19551 | RSS: Main: 147050496 20:19:32 INFO - PROCESS | 19551 | 20:19:35 INFO - PROCESS | 19551 | Cycle 1(1): loaded http://localhost:43426/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43426/tests/kraken/driver.html?testName=imaging-desaturate) 20:19:36 INFO - PROCESS | 19551 | RSS: Main: 148430848 20:19:36 INFO - PROCESS | 19551 | 20:19:38 INFO - PROCESS | 19551 | Cycle 1(1): loaded http://localhost:43426/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43426/tests/kraken/driver.html?testName=json-parse-financial) 20:19:39 INFO - PROCESS | 19551 | RSS: Main: 149102592 20:19:39 INFO - PROCESS | 19551 | 20:19:41 INFO - PROCESS | 19551 | Cycle 1(1): loaded http://localhost:43426/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43426/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:19:41 INFO - PROCESS | 19551 | RSS: Main: 148385792 20:19:41 INFO - PROCESS | 19551 | 20:19:43 INFO - PROCESS | 19551 | Cycle 1(1): loaded http://localhost:43426/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43426/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:19:44 INFO - PROCESS | 19551 | RSS: Main: 148865024 20:19:44 INFO - PROCESS | 19551 | 20:19:46 INFO - PROCESS | 19551 | Cycle 1(1): loaded http://localhost:43426/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43426/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:19:46 INFO - PROCESS | 19551 | RSS: Main: 148819968 20:19:46 INFO - PROCESS | 19551 | 20:19:49 INFO - PROCESS | 19551 | Cycle 1(1): loaded http://localhost:43426/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43426/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:19:49 INFO - PROCESS | 19551 | RSS: Main: 148963328 20:19:49 INFO - PROCESS | 19551 | 20:19:52 INFO - PROCESS | 19551 | Cycle 1(1): loaded http://localhost:43426/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43426/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:19:53 INFO - PROCESS | 19551 | RSS: Main: 148303872 20:19:53 INFO - PROCESS | 19551 | 20:19:54 INFO - PROCESS | 19551 | Cycle 1(1): loaded http://localhost:43426/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43426/tests/kraken/driver.html?testName=ai-astar) 20:19:55 INFO - PROCESS | 19551 | RSS: Main: 148434944 20:19:55 INFO - PROCESS | 19551 | 20:19:55 INFO - PROCESS | 19551 | __start_tp_report 20:19:55 INFO - PROCESS | 19551 | _x_x_mozilla_page_load 20:19:55 INFO - PROCESS | 19551 | _x_x_mozilla_page_load_details 20:19:55 INFO - PROCESS | 19551 | |i|pagename|runs| 20:19:55 INFO - PROCESS | 19551 | |0;ai-astar;112;106;112;111;112;124;112;111;111;112 20:19:55 INFO - PROCESS | 19551 | |1;audio-beat-detection;157;129;152;163;127;154;162;127;171;128 20:19:55 INFO - PROCESS | 19551 | |2;audio-dft;163;165;163;162;160;161;162;167;179;163 20:19:55 INFO - PROCESS | 19551 | |3;audio-fft;71;76;74;71;73;77;128;72;75;73 20:19:55 INFO - PROCESS | 19551 | |4;audio-oscillator;97;98;139;96;96;96;141;97;98;144 20:19:55 INFO - PROCESS | 19551 | |5;imaging-gaussian-blur;109;110;110;110;110;110;109;110;110;110 20:19:55 INFO - PROCESS | 19551 | |6;imaging-darkroom;146;146;147;146;148;147;147;146;146;147 20:19:55 INFO - PROCESS | 19551 | |7;imaging-desaturate;95;96;96;97;96;97;97;96;96;95 20:19:55 INFO - PROCESS | 19551 | |8;json-parse-financial;59;58;57;58;61;61;59;58;59;56 20:19:55 INFO - PROCESS | 19551 | |9;json-stringify-tinderbox;69;67;68;68;66;67;68;67;68;68 20:19:55 INFO - PROCESS | 19551 | |10;stanford-crypto-aes;84;87;86;86;85;87;88;86;86;85 20:19:55 INFO - PROCESS | 19551 | |11;stanford-crypto-ccm;116;119;128;123;127;129;128;119;122;119 20:19:55 INFO - PROCESS | 19551 | |12;stanford-crypto-pbkdf2;144;157;152;155;146;143;155;150;154;144 20:19:55 INFO - PROCESS | 19551 | |13;stanford-crypto-sha256-iterative;70;67;68;69;67;71;68;67;68;67 20:19:55 INFO - PROCESS | 19551 | __end_tp_report 20:19:55 INFO - PROCESS | 19551 | __start_cc_report 20:19:55 INFO - PROCESS | 19551 | _x_x_mozilla_cycle_collect,780 20:19:55 INFO - PROCESS | 19551 | __end_cc_report 20:19:55 INFO - PROCESS | 19551 | __startTimestamp1452226795008__endTimestamp 20:19:55 INFO - PROCESS | 19551 | 20:19:55 INFO - PROCESS | 19551 | ------- Summary: start ------- 20:19:55 INFO - PROCESS | 19551 | Number of tests: 14 20:19:55 INFO - PROCESS | 19551 | 20:19:55 INFO - PROCESS | 19551 | [#0] ai-astar Cycles:10 Average:112.30 Median:112.00 stddev:4.50 (4.0%) stddev-sans-first:4.77 20:19:55 INFO - PROCESS | 19551 | Values: 112.0 106.0 112.0 111.0 112.0 124.0 112.0 111.0 111.0 112.0 20:19:55 INFO - PROCESS | 19551 | 20:19:55 INFO - PROCESS | 19551 | [#1] audio-beat-detection Cycles:10 Average:147.00 Median:155.50 stddev:17.37 (11.2%) stddev-sans-first:18.04 20:19:55 INFO - PROCESS | 19551 | Values: 157.0 129.0 152.0 163.0 127.0 154.0 162.0 127.0 171.0 128.0 20:19:55 INFO - PROCESS | 19551 | 20:19:55 INFO - PROCESS | 19551 | [#2] audio-dft Cycles:10 Average:164.50 Median:163.00 stddev:5.46 (3.4%) stddev-sans-first:5.77 20:19:55 INFO - PROCESS | 19551 | Values: 163.0 165.0 163.0 162.0 160.0 161.0 162.0 167.0 179.0 163.0 20:19:55 INFO - PROCESS | 19551 | 20:19:55 INFO - PROCESS | 19551 | [#3] audio-fft Cycles:10 Average:79.00 Median:73.50 stddev:17.33 (23.6%) stddev-sans-first:18.14 20:19:55 INFO - PROCESS | 19551 | Values: 71.0 76.0 74.0 71.0 73.0 77.0 128.0 72.0 75.0 73.0 20:19:55 INFO - PROCESS | 19551 | 20:19:55 INFO - PROCESS | 19551 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:96.50 stddev:21.53 (22.3%) stddev-sans-first:22.30 20:19:55 INFO - PROCESS | 19551 | Values: 97.0 98.0 139.0 96.0 96.0 96.0 141.0 97.0 98.0 144.0 20:19:55 INFO - PROCESS | 19551 | 20:19:55 INFO - PROCESS | 19551 | [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 20:19:55 INFO - PROCESS | 19551 | Values: 109.0 110.0 110.0 110.0 110.0 110.0 109.0 110.0 110.0 110.0 20:19:55 INFO - PROCESS | 19551 | 20:19:55 INFO - PROCESS | 19551 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 20:19:55 INFO - PROCESS | 19551 | Values: 146.0 146.0 147.0 146.0 148.0 147.0 147.0 146.0 146.0 147.0 20:19:55 INFO - PROCESS | 19551 | 20:19:55 INFO - PROCESS | 19551 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 20:19:55 INFO - PROCESS | 19551 | Values: 95.0 96.0 96.0 97.0 96.0 97.0 97.0 96.0 96.0 95.0 20:19:55 INFO - PROCESS | 19551 | 20:19:55 INFO - PROCESS | 19551 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:59.00 stddev:1.58 (2.7%) stddev-sans-first:1.67 20:19:55 INFO - PROCESS | 19551 | Values: 59.0 58.0 57.0 58.0 61.0 61.0 59.0 58.0 59.0 56.0 20:19:55 INFO - PROCESS | 19551 | 20:19:55 INFO - PROCESS | 19551 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:0.84 (1.2%) stddev-sans-first:0.73 20:19:55 INFO - PROCESS | 19551 | Values: 69.0 67.0 68.0 68.0 66.0 67.0 68.0 67.0 68.0 68.0 20:19:55 INFO - PROCESS | 19551 | 20:19:55 INFO - PROCESS | 19551 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:86.00 stddev:1.15 (1.3%) stddev-sans-first:0.97 20:19:55 INFO - PROCESS | 19551 | Values: 84.0 87.0 86.0 86.0 85.0 87.0 88.0 86.0 86.0 85.0 20:19:55 INFO - PROCESS | 19551 | 20:19:55 INFO - PROCESS | 19551 | [#11] stanford-crypto-ccm Cycles:10 Average:123.00 Median:125.00 stddev:4.71 (3.8%) stddev-sans-first:4.27 20:19:55 INFO - PROCESS | 19551 | Values: 116.0 119.0 128.0 123.0 127.0 129.0 128.0 119.0 122.0 119.0 20:19:55 INFO - PROCESS | 19551 | 20:19:55 INFO - PROCESS | 19551 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.00 Median:153.00 stddev:5.33 (3.5%) stddev-sans-first:5.20 20:19:55 INFO - PROCESS | 19551 | Values: 144.0 157.0 152.0 155.0 146.0 143.0 155.0 150.0 154.0 144.0 20:19:55 INFO - PROCESS | 19551 | 20:19:55 INFO - PROCESS | 19551 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:1.40 (2.1%) stddev-sans-first:1.32 20:19:55 INFO - PROCESS | 19551 | Values: 70.0 67.0 68.0 69.0 67.0 71.0 68.0 67.0 68.0 67.0 20:19:55 INFO - PROCESS | 19551 | -------- Summary: end -------- 20:19:55 INFO - PROCESS | 19551 | 20:19:55 INFO - TEST-INFO | 19551: exit 0 20:19:55 INFO - TEST-OK | kraken | took 60010ms 20:19:55 INFO - TEST-START | v8_7 20:19:55 INFO - operating with platform_type : linux_ 20:19:55 INFO - Initialising browser for v8_7 test... 20:19:55 INFO - TEST-INFO | started process 19840 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptewj0v/profile http://localhost:43426/getInfo.html) 20:19:59 INFO - PROCESS | 19840 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 20:20:00 INFO - PROCESS | 19840 | __metrics Screen width/height:1600/1200 20:20:00 INFO - PROCESS | 19840 | colorDepth:24 20:20:00 INFO - PROCESS | 19840 | Browser inner width/height: 1024/697 20:20:00 INFO - PROCESS | 19840 | __metrics 20:20:00 INFO - PROCESS | 19840 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:20:01 INFO - TEST-INFO | 19840: exit 0 20:20:01 INFO - Browser initialized. 20:20:01 INFO - Running cycle 1/1 for v8_7 test... 20:20:01 INFO - TEST-INFO | started process 19960 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptewj0v/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:20:13 INFO - PROCESS | 19960 | RSS: Main: 150671360 20:20:13 INFO - PROCESS | 19960 | 20:20:35 INFO - PROCESS | 19960 | Cycle 1(1): loaded http://localhost:43426/tests/v8_7/run.html (next: http://localhost:43426/tests/v8_7/run.html) 20:20:35 INFO - PROCESS | 19960 | RSS: Main: 147009536 20:20:35 INFO - PROCESS | 19960 | 20:20:35 INFO - PROCESS | 19960 | __start_tp_report 20:20:35 INFO - PROCESS | 19960 | _x_x_mozilla_page_load 20:20:35 INFO - PROCESS | 19960 | _x_x_mozilla_page_load_details 20:20:35 INFO - PROCESS | 19960 | |i|pagename|runs| 20:20:35 INFO - PROCESS | 19960 | |0;Richards;166.77785190126752 20:20:35 INFO - PROCESS | 19960 | |1;DeltaBlue;191.27773527161438 20:20:35 INFO - PROCESS | 19960 | |2;Encrypt;282.326369282891 20:20:35 INFO - PROCESS | 19960 | |3;Decrypt;5268.421052631579 20:20:35 INFO - PROCESS | 19960 | |4;RayTrace;1092.896174863388 20:20:35 INFO - PROCESS | 19960 | |5;Earley;717.5627240143369 20:20:35 INFO - PROCESS | 19960 | |6;Boyer;12345.67901234568 20:20:35 INFO - PROCESS | 19960 | |7;RegExp;40039.21568627451 20:20:35 INFO - PROCESS | 19960 | |8;Splay;567.2149744753261 20:20:35 INFO - PROCESS | 19960 | |9;NavierStokes;4826.923076923077 20:20:35 INFO - PROCESS | 19960 | __end_tp_report 20:20:35 INFO - PROCESS | 19960 | __startTimestamp1452226835863__endTimestamp 20:20:35 INFO - PROCESS | 19960 | 20:20:35 INFO - PROCESS | 19960 | ------- Summary: start ------- 20:20:35 INFO - PROCESS | 19960 | Number of tests: 10 20:20:35 INFO - PROCESS | 19960 | 20:20:35 INFO - PROCESS | 19960 | [#0] Richards Cycles:1 Average:166.78 Median:166.78 stddev:0.00 (0.0%) 20:20:35 INFO - PROCESS | 19960 | Values: 166.8 20:20:35 INFO - PROCESS | 19960 | 20:20:35 INFO - PROCESS | 19960 | [#1] DeltaBlue Cycles:1 Average:191.28 Median:191.28 stddev:0.00 (0.0%) 20:20:35 INFO - PROCESS | 19960 | Values: 191.3 20:20:35 INFO - PROCESS | 19960 | 20:20:35 INFO - PROCESS | 19960 | [#2] Encrypt Cycles:1 Average:282.33 Median:282.33 stddev:0.00 (0.0%) 20:20:35 INFO - PROCESS | 19960 | Values: 282.3 20:20:35 INFO - PROCESS | 19960 | 20:20:35 INFO - PROCESS | 19960 | [#3] Decrypt Cycles:1 Average:5268.42 Median:5268.42 stddev:0.00 (0.0%) 20:20:35 INFO - PROCESS | 19960 | Values: 5268.4 20:20:35 INFO - PROCESS | 19960 | 20:20:35 INFO - PROCESS | 19960 | [#4] RayTrace Cycles:1 Average:1092.90 Median:1092.90 stddev:0.00 (0.0%) 20:20:35 INFO - PROCESS | 19960 | Values: 1092.9 20:20:35 INFO - PROCESS | 19960 | 20:20:35 INFO - PROCESS | 19960 | [#5] Earley Cycles:1 Average:717.56 Median:717.56 stddev:0.00 (0.0%) 20:20:35 INFO - PROCESS | 19960 | Values: 717.6 20:20:35 INFO - PROCESS | 19960 | 20:20:35 INFO - PROCESS | 19960 | [#6] Boyer Cycles:1 Average:12345.68 Median:12345.68 stddev:0.00 (0.0%) 20:20:35 INFO - PROCESS | 19960 | Values: 12345.7 20:20:35 INFO - PROCESS | 19960 | 20:20:35 INFO - PROCESS | 19960 | [#7] RegExp Cycles:1 Average:40039.22 Median:40039.22 stddev:0.00 (0.0%) 20:20:35 INFO - PROCESS | 19960 | Values: 40039.2 20:20:35 INFO - PROCESS | 19960 | 20:20:35 INFO - PROCESS | 19960 | [#8] Splay Cycles:1 Average:567.21 Median:567.21 stddev:0.00 (0.0%) 20:20:35 INFO - PROCESS | 19960 | Values: 567.2 20:20:35 INFO - PROCESS | 19960 | 20:20:35 INFO - PROCESS | 19960 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 20:20:35 INFO - PROCESS | 19960 | Values: 4826.9 20:20:35 INFO - PROCESS | 19960 | -------- Summary: end -------- 20:20:35 INFO - PROCESS | 19960 | 20:20:36 INFO - TEST-INFO | 19960: exit 0 20:20:36 INFO - TEST-OK | v8_7 | took 40777ms 20:20:36 INFO - SUITE-END | took 1211s 20:20:36 INFO - Completed test suite (00:20:11) 20:20:36 INFO - Working with test: dromaeo_css 20:20:36 INFO - Generating results file: dromaeo_css 20:20:36 INFO - Working with test: kraken 20:20:36 INFO - Generating results file: kraken 20:20:36 INFO - javascript benchmark 20:20:36 INFO - Working with test: v8_7 20:20:36 INFO - Generating results file: v8_7 20:20:36 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:20:37 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 20:20:37 INFO - process_Request line: dromaeo_css 6696.19 graph.html#tests=[[72,64,43]] 20:20:37 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:20:37 INFO - process_Request line: kraken 1518.90 graph.html#tests=[[232,64,43]] 20:20:37 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:20:37 INFO - process_Request line: v8_7 20410.06 graph.html#tests=[[230,64,43]] 20:20:37 INFO - RETURN: dromaeo_css: 6696.19 20:20:37 INFO - RETURN: kraken: 1518.90 20:20:37 INFO - RETURN: v8_7: 20410.06 20:20:37 INFO - javascript benchmark 20:20:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3187.8087314761115, 3226.774125811193, 3250.28493731379, 3261.494468357405, 3276.8689252429904, 5230.267762513251, 5245.082110630638, 5249.107651699206, 5254.133068043778, 5278.604104692149, 5177.948220517794, 5278.076336641092, 5308.097623404021, 5310.176922577007, 5319.175527793189, 4553.635709143261, 4798.088363210979, 4946.109700253953, 4956.7769450374635, 4964.379452568429, 4737.12363212805, 4877.244027175793, 4937.654364194508, 4964.180910149821, 4972.154733695263, 4723.952760472403, 4792.257200133985, 4799.3760811094335, 4816.4461086974925, 4857.1742803723455, 4820.349252850855, 4869.050535145648, 4878.146324393217, 4886.096072226649, 4900.338454308659, 4715.174844402216, 4808.687435316693, 4812.085703716318, 4853.126437241295, 4872.902541949141, 5151.356080489939, 5168.819091331786, 5189.403218629868, 5201.167813149916, 5218.0, 5686.800961966353, 5699.401562835884, 5721.6853073080965, 5723.7996670116345, 5757.712114394263, 5634.239377684001, 5727.341355744059, 5764.16419619157, 5777.046787280094, 5783.5951483396175, 5287.47125287472, 5357.169638705968, 5360.973195134077, 5370.785168593252, 5416.674999500043, 5812.79655212074, 5819.505342045889, 5838.182654428383, 5842.853928651818, 5862.94137058624, 5510.311211098613, 5601.859953501195, 5629.577781666391, 5630.042892708249, 5660.801871934545, 5604.747786349542, 5605.495505404533, 5631.521320687705, 5631.7747290108755, 5712.0, 5562.471565201299, 5582.134769110794, 5603.803866864721, 5609.551235901118, 5624.268845050199, 5562.0, 5618.410066942994, 5628.831135065954, 5663.292088488939, 5742.712864356766, 4356.934645980313, 4375.671824613167, 4376.956230437719, 4382.320740285197, 4412.867613971586, 3968.7420317679257, 3978.204359128186, 3983.063979964706, 4016.3975403689096, 4035.5762644922447, 5267.130923397596, 5328.49379308965, 5365.141577347606, 5391.3799913009725, 5432.158015507603, 5769.249997500382, 5776.0, 5787.305523337226, 5792.710364481759, 5817.94182058174, 5229.241759944786, 5349.384820745586, 5386.111291636836, 5390.245365648812, 5441.5102640762525, 4810.39870016248, 4851.0, 4907.312976183337, 4915.827946021872, 4955.4796746341835, 5865.794697185578, 5886.941130588725, 5887.3523912370465, 5887.61730487517, 5894.381089985575, 5630.718464076698, 5682.6306290091015, 5689.77240910359, 5728.2266893970445, 5742.2535070442245, 5893.528517718487, 5936.050231962865, 5969.0, 5972.552058595709, 5987.221661184019, 5582.078956972054, 5634.915476267941, 5651.378348381757, 5651.85870353228, 5655.519280861173, 5597.104463285855, 5705.657660540381, 5727.8568035799435, 5734.082546792493, 5773.393793651606, 5614.494695477427, 5627.324721033502, 5628.690422026828, 5636.802711905064, 5663.32040155184, 5625.915611265752, 5630.690312032713, 5635.577331700057, 5638.097904335286, 5638.126090455986, 5374.7312634367345, 5480.671159730429, 5518.78586710923, 5528.668279903219, 5615.410381909841, 5599.384067752462, 5615.859603509782, 5615.887682246251, 5648.689322087324, 5661.2923384576925, 5504.972475137759, 5510.201020851874, 5529.419410961791, 5533.5849811263515, 5579.553635709052], "unit": "score", "name": "dojo.html", "value": 5262.856020556174}, {"lowerIsBetter": false, "replicates": [487.4151018777468, 521.244195915922, 551.5284431810801, 561.9550435965123, 567.3843879390861, 24843.50312993739, 35861.0, 35970.8201458993, 36215.63784362155, 36287.09282267945, 38343.80828095863, 38800.41799373004, 39245.803770981176, 39274.80362598183, 39280.80359598205, 8287.461315014534, 8564.657413703444, 8578.78553036176, 8582.399232053758, 8589.785255368603, 8204.097549269576, 8419.70531031414, 8421.957890210571, 8440.915590844075, 8462.15378462152, 8443.95778021109, 8511.82976340476, 8524.573771311441, 8537.658493660278, 8561.0, 8415.873761893547, 8463.74608761735, 8540.103289154642, 8640.740777776677, 8683.869741953877, 8451.830963380698, 8604.612792424356, 8614.56927153646, 8639.65441382344, 8654.826903461959, 38259.80870095632, 38432.807835960644, 38447.0, 38516.229675406335, 38607.806960965296, 2892.652881654194, 2938.720821521952, 2942.7204415580486, 2987.626546681665, 3443.276911848515, 28360.14919552417, 29203.12390628263, 29348.11955641334, 29408.11775646734, 29836.0, 3630.945535816965, 3663.7984910829896, 3681.208540163878, 3791.393377059685, 3804.8478060877533, 261132.0, 262157.0, 263436.9999999981, 264227.0, 265146.0, 41800.37299440511, 42202.577974219865, 42263.366049509284, 56380.43619563752, 56687.43312566904, 40609.1878162441, 40712.18575628471, 40814.79592602018, 40821.79589102035, 41279.58720412818, 13946.511872084631, 14006.649833754238, 14120.082194657314, 14132.364043618061, 14137.717245655234, 11079.778404432027, 11156.888431115747, 11165.162612804072, 11182.832257516144, 11183.776324473465, 14195.219262940638, 14284.71444568864, 14354.49759258442, 14363.784543231859, 14419.42322307096, 5663.745131469093, 5726.656400615976, 5727.885442291131, 5743.0, 5768.077107662753, 941.2893265584577, 969.1132613658424, 989.7638108893946, 1013.6097602423121, 1032.932859364139, 28599.57100643492, 28703.712962870522, 28913.0, 29196.124116276547, 29272.414551708847, 1040.2198351236573, 1051.379685985257, 1059.9523021464054, 1064.090202876545, 1157.8147496400536, 15783.368665253261, 16230.837691622932, 16399.262033208535, 16891.23989420479, 16938.661226775643, 370680.0, 372677.0, 373666.0, 373962.0, 376182.0, 54128.72935635375, 54558.0, 54615.45384546183, 54744.0, 54806.725966369915, 1275.1201670847086, 1281.525835440893, 1285.8714128587067, 1290.993545032269, 1307.2483322089836, 28945.0, 29011.0, 29772.702272976992, 30154.0, 30393.544096838123, 44666.776666116464, 44896.77551612352, 45111.32333014942, 45405.54594454145, 45483.54516454926, 300281.0, 302625.0, 304620.0, 305010.0, 306438.0, 30937.226569335948, 40874.0, 42566.78716606397, 42730.35904461373, 42812.78593607012, 40964.0, 41674.37488437615, 42093.0, 42357.57642423536, 42447.3632895513, 35057.0, 35233.1191720209, 35381.82309088438, 36246.0, 36280.27439451249, 35623.46564801478, 36873.63126368809, 37552.0, 38174.435310081455, 39313.41029884497, 33409.83295083509, 33818.154546136546, 33847.83076084702, 34120.82939585286, 34135.65864341325, 29266.414671706872, 29881.252968675955, 34110.65889341174, 35518.644813552564, 35893.64106358903, 23406.531869362178, 23931.401714957265, 24129.39676508031, 26805.463890721687, 27291.454170916073], "unit": "score", "name": "ext.html", "value": 17735.3124186041}, {"lowerIsBetter": false, "replicates": [341.1488336600183, 345.3679766028169, 351.2097779995011, 351.6413258476354, 353.87968090849114, 16382.344706211767, 16439.0, 16512.66974660506, 17130.914345428286, 17485.300587976464, 14972.700545989073, 15271.236438178103, 15438.768418473732, 15961.600959976007, 16010.119443430607, 4740.0, 4892.510748925097, 4929.433115191745, 4934.876628084291, 4938.925916111261, 4341.674374421915, 4831.589314908237, 4912.48418916014, 4917.164082106033, 5413.593980451462, 5390.110631745757, 5391.757370918318, 5411.756470958797, 5420.6747595144225, 5422.864428389283, 4805.399325084364, 4868.123737727207, 4877.8780530486665, 4889.853304400855, 5379.139337705968, 4682.8126874924965, 4683.0, 4720.527947205286, 4734.153680064743, 4739.265413860857, 17146.742798858028, 17769.822301776945, 17828.286868525243, 17841.46475605734, 18464.63070738578, 1874.2315650583196, 2066.2354928676486, 2091.7176181215495, 2125.532382875765, 2157.7302837145357, 9246.35275530713, 9978.900210997943, 12198.207116537396, 12350.691232719164, 12455.875441245562, 1874.4189301316635, 1896.1277812206401, 1990.233760002395, 2024.5141166120172, 2030.2995466564012, 50595.74702126466, 52326.47673523254, 53222.467775322526, 53642.73178634121, 54139.458605413834, 9175.265978721687, 9217.354785164975, 9298.814023719488, 9302.395344302598, 9356.532173391302, 11834.940825295818, 11999.64001079969, 12432.689182770504, 12545.937270313772, 12564.120511564286, 6935.826604334932, 7168.139823221247, 7364.521306115085, 7374.373178279799, 7407.6666550005375, 7107.822304442327, 7155.427565794724, 7171.820704482429, 7188.460865435009, 7188.640567971581, 4106.178764247163, 4243.342281946241, 4246.8301267949555, 4269.4449721536, 4297.226499230169, 1688.7213609754253, 1695.203254470397, 1726.7927848658242, 1741.7126174181371, 1746.3538490758247, 439.16120210397986, 441.94696636403836, 882.5102068351998, 911.3165126155384, 929.4423345992485, 9682.419054856731, 10175.592976281014, 10254.0, 10355.223358248162, 10523.473826308807, 873.3100850328296, 926.8424367857481, 943.0333907744616, 1008.5461542305992, 1015.8863084645537, 5463.453654634504, 5482.506574408322, 5522.364928033247, 5611.607187496836, 9183.357164998519, 385147.0, 386993.0, 410035.0, 411439.0, 420065.0, 61050.0, 63483.0, 72860.27139728535, 74032.0, 77858.0, 441.32917964694127, 446.5244514591949, 450.87150162203613, 453.42867986336796, 455.3647661512238, 9590.232781377612, 9632.95183524106, 9790.902090979283, 10026.448545330077, 10153.746156346151, 20228.0, 30188.69811301859, 30268.0, 30709.539356909216, 30815.61329740122, 41356.379654304605, 41501.58498414977, 42543.57456425396, 45617.31574026459, 45640.31539526844, 2924.883004679789, 5678.7728490861555, 6745.898811517929, 6767.64647070578, 7223.061002069908, 9987.750306242402, 10012.098911098035, 10725.410102444128, 10907.563697452331, 10927.235093543375, 8687.348448866234, 9337.159655631025, 9589.376690515093, 9664.9033509664, 9674.177694896012, 9421.576029078846, 9678.467684277432, 9727.07592778685, 9885.456299903575, 9936.99441893449, 8708.78228044304, 9541.379810312308, 9708.0, 9773.511324433608, 9901.900980990386, 7207.963960180376, 7220.566765994057, 7285.162206346338, 7298.854022919406, 7324.340809327186, 8344.749657510285, 9213.12475314844, 9333.859992099988, 9620.95189524048, 9737.659181928599], "unit": "score", "name": "jquery.html", "value": 7305.690822461046}, {"lowerIsBetter": false, "replicates": [1381.6338670252385, 1382.7096309774943, 1475.4393330534394, 1636.0919689572283, 1649.9935039625834, 7194.0647715797, 7236.674349654265, 7357.448191385641, 7382.741604043859, 7405.740799072034, 7292.489525733201, 7312.488125831194, 7361.595112268823, 7400.518966267189, 7404.074490688664, 2227.354067320475, 2249.5613355395703, 2256.029907139937, 2262.242148880127, 2263.3323169664905, 2217.090992692996, 2236.8769717665523, 2237.85453945493, 2242.3385101395047, 2242.9775702242932, 2172.16371696897, 2191.079746506463, 2200.273909609833, 2238.529908719171, 2250.4036430345973, 2235.0, 2267.1724820440586, 2291.049214575949, 2291.8510296830736, 2293.3922510534803, 2248.3929339078522, 2262.1064679451524, 2264.4565304327007, 2264.5810525052752, 2274.0676322707777, 7279.526830755984, 7289.2346303638415, 7295.744648937261, 7295.744648937261, 7328.890066649004, 4405.647548196137, 4543.068670922486, 4556.931646025312, 4569.0, 4569.177548041352, 2994.431058098976, 2999.895003674861, 3053.084074777558, 3056.2664960409566, 3085.3674996625864, 1070.8714954205545, 1071.7427817323864, 1800.6398720256002, 1847.214933653192, 1886.2737845929416, 9578.6647467339, 9585.281103917234, 9598.328117031811, 9632.614695412245, 9702.708918732378, 3849.095462566295, 3901.2782635212575, 3931.488906442144, 3973.562908080109, 3980.5422376426504, 7679.769606911802, 7685.615719214017, 7725.381969442431, 7743.922560774433, 7762.611869406507, 4383.408239887638, 4387.034852332482, 4407.162639098561, 4412.227860124465, 4433.268510695763, 4097.037196258877, 4102.323116685713, 4103.815328310233, 4118.9588104118575, 4128.855490057834, 3282.7373810095137, 3305.9173520662175, 3336.366090442808, 3365.865365385357, 3366.0911553880314, 1009.3842755918884, 1017.9287449878585, 1024.1653052761976, 1024.329064462778, 1049.076812405094, 1021.8518314844306, 1023.6621914768109, 1075.7955988362187, 1157.438642258504, 1299.9025073119553, 6764.763233286812, 6808.863822723617, 6844.349786770249, 6864.073350097673, 6877.65611719422, 1031.664708969588, 1044.081208536483, 1083.539495714334, 1105.9557617695202, 1110.7889500994786, 5482.972585137049, 5500.50495455411, 5574.749136288877, 5608.607397482218, 5610.579206559524, 8687.522186279815, 8758.824823503493, 8769.473831570127, 8777.122287771299, 8830.514321712368, 8631.352648551258, 8649.437786543855, 8687.478751274944, 8709.782255443537, 8711.91288087111, 6723.746915368656, 6949.409300209438, 6962.860742785218, 6964.233934267227, 6976.058232138596, 6758.459323254227, 6781.457483401217, 6782.762603308861, 6801.557898736566, 6818.795436136924, 7691.2308769124875, 7866.488678235896, 7871.134175240833, 7904.881426778488, 7978.643630582931, 7986.440949133505, 8099.109097999333, 8101.068377136469, 8127.471714338549, 8153.9184608153155, 6106.938930610637, 6190.876182476235, 6313.326968353482, 6400.743970241325, 6421.646809425526, 6824.249332573314, 6852.314768523108, 6866.141732283465, 6867.484938629523, 6882.965585172042, 6599.835004124935, 6658.0, 6750.561213521106, 6755.831104222434, 6833.043373927555, 5927.733252003756, 5972.223610930551, 6269.686515674107, 6456.903146452901, 6457.580257283262, 6429.7428102875365, 6430.356964303533, 6445.774397896051, 6476.902846457401, 6498.610083395011, 6046.697665116814, 6094.542909281733, 6131.386861314011, 6141.477974372228, 6144.846378840565, 6127.3566275540425, 6135.202423684892, 6162.291336496361, 6165.876682466415, 6169.1054797053275], "unit": "score", "name": "mootools.html", "value": 4289.558849531233}, {"lowerIsBetter": false, "replicates": [328.08137215795773, 335.74818885835623, 337.17056042136346, 338.6241272187872, 340.57768367224634, 6255.249370075586, 6277.058441233811, 6284.214473190851, 6298.842528936773, 6348.0, 6169.3830616938285, 6174.6912654367325, 6175.783847565336, 6200.658963756991, 6329.386006568318, 4687.320338550908, 4699.976500117495, 4702.036082603076, 4708.317293992369, 4711.340412342275, 4683.88290292742, 4695.812167513295, 4695.8356457524, 4702.036082603058, 4708.387909571751, 4562.0, 4575.633949284049, 4612.308153776943, 4677.719336839784, 4702.623790096801, 4656.348111264426, 4676.7193968361835, 4684.297355396684, 4692.483826779052, 4696.718196908179, 4067.0849058961794, 4068.593140685937, 4071.470708807866, 4073.124278280184, 4080.061585835245, 5908.8227353179045, 5963.671998040106, 5971.910421343683, 5973.313068997078, 5981.880362392728, 5459.863503412446, 5476.863078423032, 5522.889542209174, 5532.419095994943, 5539.753555450032, 6633.0, 6634.170728658918, 6649.202095748541, 6653.933460665428, 6657.367550082783, 4514.864554063383, 4522.570355816225, 4543.636509079266, 4555.726656400627, 4562.726236425825, 6839.487038472134, 6930.61881596512, 6941.548799328028, 6988.405985491188, 7021.578705277649, 4606.216943119678, 4608.5621865922685, 4613.5386461354265, 4619.491855895849, 4630.374899388539, 4661.627069834405, 4669.136209801198, 4670.7664616769025, 4672.299155126758, 4683.601893838993, 5469.890602188014, 5475.397706252309, 5478.945210547923, 5482.671039737628, 5486.91769623456, 6464.288928217892, 6674.365935236242, 6685.565438246498, 6709.865802683919, 6720.092787473726, 1635.419426103716, 1669.8831081824155, 1670.0146913321198, 1673.5481420016526, 1674.5729838891004, 1073.4042606353548, 1077.8383242513685, 1092.9508172132273, 1095.780843831237, 1102.685734565645, 6265.655388953652, 6271.7804876830005, 6302.369763023753, 6313.652749098844, 6351.587146835441, 6906.758263460755, 6911.550749201286, 6914.101166848378, 6937.861242775116, 6942.201646810681, 6146.907796383058, 6305.747770089145, 6311.305756366796, 6359.713812878432, 6383.872322553523, 3764.7741135531955, 3782.659560639501, 3786.772793632336, 3788.204477059848, 3802.8288727007352, 7244.746433874894, 7291.30732580404, 7301.452391070691, 7305.196428392873, 7305.963470182615, 7012.649367531603, 7143.749968751069, 7145.642717864086, 7151.106111736033, 7160.498765086498, 7270.454715896329, 7274.127104747464, 7274.59989700561, 7275.272472752682, 7311.853762924712, 6912.135983002125, 6914.135733033371, 6933.16801983745, 6937.132858392701, 6966.582005079711, 6744.696488657924, 6865.622390768555, 6892.172939247323, 6900.171979362509, 6905.551139175937, 7215.783526494213, 7257.854842903218, 7305.634718264172, 7316.597587132759, 7335.963320183365, 4604.976975115103, 4624.052069325713, 4626.005408837116, 4640.095181439587, 4657.93013104797, 6809.591424514545, 6925.134358205224, 6930.826729331606, 6954.3045695430055, 6955.513114082168, 6747.831304217238, 6750.9873518972545, 6751.358620931003, 6758.290379510081, 6760.08738820253, 6603.108580341593, 6698.296678848846, 6724.4284235840505, 6744.595324280559, 6751.3248675134055, 6542.280349161493, 6581.243157037002, 6596.571222870498, 6610.173728283965, 6611.834704132435, 6758.797236082925, 6762.526623136333, 6764.966175169093, 6773.424258938046, 6777.8983315249325, 6340.651264180515, 6506.154199953976, 6620.073189753534, 6626.204855417381, 6626.734930602722], "unit": "score", "name": "prototype.html", "value": 4999.331904024923}, {"lowerIsBetter": false, "replicates": [725.2348772045492, 765.3379826450122, 819.3281509162485, 823.6375994562392, 831.2892476932227, 13083.738325233502, 13217.07480476367, 13222.801657975138, 13250.33748312583, 13272.137311074786, 12345.074119441033, 12411.255324680526, 12416.875831241685, 12419.0, 12446.43991020404, 445.16531503431065, 452.8460323490013, 770.2413123073768, 781.8827175923615, 782.4249176855036, 794.1700922535935, 795.824918517928, 800.7877912353231, 802.4543310548825, 803.3051410529908, 828.9336853051772, 832.4921797703396, 834.7913021744564, 837.7696133563288, 839.5172775654023, 824.6824972385615, 829.5603330234954, 829.6432534010373, 836.786619412049, 837.7151768398743, 607.7720854679495, 608.9299730531002, 613.1446631948407, 614.9169862068608, 616.134331264574, 12910.677233069155, 12953.740925181537, 12959.222446653232, 12983.156094853804, 12984.610461686165, 12136.635900922987, 12297.631071067794, 12305.44625491846, 12598.55905043319, 12805.359732013456, 10467.685969420929, 10499.947500262526, 10611.946940265327, 10615.203859710553, 10668.14654827612, 3595.9280814383565, 3620.5112309838096, 3626.873059442933, 3644.726645501598, 3655.670989610948, 45817.312740308924, 46313.30530042052, 46464.53535464636, 46622.30066549039, 46633.30050049252, 9809.362391444532, 9942.801143977225, 10067.748306292402, 10144.898551014543, 10147.594096236067, 16006.199690015452, 16015.519534413987, 16025.759613605805, 16046.839531604535, 16062.357505699641, 7204.387627051759, 7376.557406555624, 7487.438442116863, 7533.171351151369, 7621.199774023758, 4290.678199135077, 4302.612764851178, 4319.200947824663, 4380.7371557706, 4549.9317510236715, 2871.7271859173347, 2875.511163102278, 2884.1924261206896, 2893.85530723463, 2897.6812550619416, 539.4093467652914, 539.7085573790188, 547.8849441617305, 551.1127085392515, 553.7840242305504, 494.39930484461553, 604.6493034040334, 646.4795839349275, 682.668905580793, 714.7212587091038, 8488.405811593253, 8571.957140214383, 8650.956745216234, 8659.48043117415, 8777.648894044294, 544.363095178642, 659.3910857507666, 686.7630667419733, 694.0, 697.5396238482577, 3713.702903767692, 3799.4110912808005, 3916.804159792056, 4070.430139780433, 4073.9592604073578, 54738.0, 57917.131243031385, 58668.70665646644, 58738.70630646819, 58969.0, 51273.23090153651, 52066.0, 52308.21537676938, 52559.474405256224, 52820.0, 45082.0, 45126.77436612796, 46025.07949840985, 46410.07179856452, 47428.525714743104, 8194.0, 8211.38414618894, 8216.34269258446, 8357.749267521984, 8702.390832641655, 33551.32897342088, 33657.83171084129, 34457.31085378329, 34472.310553789284, 34483.0, 45782.0, 45891.77054114708, 45902.31146532871, 46026.30960535662, 46131.53868461272, 10410.323328983592, 10551.472426378497, 10568.101711354313, 11182.66452006441, 11560.30638161713, 11201.271917325348, 11291.887081129084, 11433.0, 11762.764744704888, 11848.940755296167, 10667.093297069836, 10749.89250107489, 11104.5558177672, 11106.047396369811, 11124.0, 11374.886251137714, 11376.317420954769, 11534.538618455168, 11546.94226528862, 11761.705957350792, 11007.61473348429, 11455.484503197209, 11510.712232193928, 11776.882231177578, 11797.115216358636, 9011.2790976723, 9216.400933939272, 9263.120003599648, 9472.242220622196, 9612.75968100803, 9167.220786233245, 9250.843644544431, 9431.386959847589, 9433.24534037289, 9634.181094607036], "unit": "score", "name": "yui.html", "value": 6164.319619269283}], "name": "dromaeo_css", "value": 6696.191628185743}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 106.0, 112.0, 111.0, 112.0, 124.0, 112.0, 111.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.3}, {"lowerIsBetter": true, "replicates": [157.0, 129.0, 152.0, 163.0, 127.0, 154.0, 162.0, 127.0, 171.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 147.0}, {"lowerIsBetter": true, "replicates": [163.0, 165.0, 163.0, 162.0, 160.0, 161.0, 162.0, 167.0, 179.0, 163.0], "unit": "score", "name": "audio-dft", "value": 164.5}, {"lowerIsBetter": true, "replicates": [71.0, 76.0, 74.0, 71.0, 73.0, 77.0, 128.0, 72.0, 75.0, 73.0], "unit": "score", "name": "audio-fft", "value": 79.0}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 139.0, 96.0, 96.0, 96.0, 141.0, 97.0, 98.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 110.2}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 146.0, 148.0, 147.0, 147.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 97.0, 96.0, 97.0, 97.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [59.0, 58.0, 57.0, 58.0, 61.0, 61.0, 59.0, 58.0, 59.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.6}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 68.0, 68.0, 66.0, 67.0, 68.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [84.0, 87.0, 86.0, 86.0, 85.0, 87.0, 88.0, 86.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.0}, {"lowerIsBetter": true, "replicates": [116.0, 119.0, 128.0, 123.0, 127.0, 129.0, 128.0, 119.0, 122.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.0}, {"lowerIsBetter": true, "replicates": [144.0, 157.0, 152.0, 155.0, 146.0, 143.0, 155.0, 150.0, 154.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.0}, {"lowerIsBetter": true, "replicates": [70.0, 67.0, 68.0, 69.0, 67.0, 71.0, 68.0, 67.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1518.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.77785190126752], "unit": "score", "name": "Richards", "value": 211.67079199999998}, {"lowerIsBetter": false, "replicates": [191.27773527161438], "unit": "score", "name": "DeltaBlue", "value": 345.66490400000004}, {"lowerIsBetter": false, "replicates": [282.326369282891], "unit": "score", "name": "Encrypt", "value": 942.813102}, {"lowerIsBetter": false, "replicates": [5268.421052631579], "unit": "score", "name": "Decrypt", "value": 50.52386613386611}, {"lowerIsBetter": false, "replicates": [1092.896174863388], "unit": "score", "name": "RayTrace", "value": 677.089935}, {"lowerIsBetter": false, "replicates": [717.5627240143369], "unit": "score", "name": "Earley", "value": 928.7870979020979}, {"lowerIsBetter": false, "replicates": [12345.67901234568], "unit": "score", "name": "Boyer", "value": 53.98350299999995}, {"lowerIsBetter": false, "replicates": [40039.21568627451], "unit": "score", "name": "RegExp", "value": 22.752318805093026}, {"lowerIsBetter": false, "replicates": [567.2149744753261], "unit": "score", "name": "Splay", "value": 143.66863300000006}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20410.06145274292}]} 20:20:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20410.06"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1518.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6696.19"}}} 20:20:37 INFO - Return code: 0 20:20:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:20:37 INFO - # TBPL SUCCESS # 20:20:37 INFO - Running post-action listener: _resource_record_post_action 20:20:37 INFO - Running post-run listener: _resource_record_post_run 20:20:38 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 0; Write bytes: 578641920; Read time: 0; Write time: 461708 20:20:38 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 255922176; Read time: 0; Write time: 249476 20:20:38 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 322719744; Read time: 0; Write time: 212232 20:20:38 INFO - Running post-run listener: _upload_blobber_files 20:20:38 INFO - Blob upload gear active. 20:20:38 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:20:38 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 20:20:38 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'] 20:20:38 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 20:20:38 INFO - (blobuploader) - INFO - Open directory for files ... 20:20:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:20:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:20:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:20:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:20:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:20:39 INFO - (blobuploader) - INFO - Done attempting. 20:20:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:20:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:20:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:20:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:20:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:20:40 INFO - (blobuploader) - INFO - Done attempting. 20:20:40 INFO - (blobuploader) - INFO - Iteration through files over. 20:20:40 INFO - Return code: 0 20:20:40 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:20:40 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:20:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/97f92d1b5af7d5273e5e2430fc64afe857063b87205da30e5d82ff2f5a1917608f3d4b15570dd537b9876aa22671e7f17a23cc012fe9a0fd41f8e9c4193c8fc4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1f4d98f1718401de0a38e09f120ace3ccd931019f6bc94471be450575da8998ae3f7e676961782e5facc7dc495a60047db6937a6eb8218b8a1720a8bd318197a"} 20:20:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:20:40 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:20:40 INFO - Contents: 20:20:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/97f92d1b5af7d5273e5e2430fc64afe857063b87205da30e5d82ff2f5a1917608f3d4b15570dd537b9876aa22671e7f17a23cc012fe9a0fd41f8e9c4193c8fc4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1f4d98f1718401de0a38e09f120ace3ccd931019f6bc94471be450575da8998ae3f7e676961782e5facc7dc495a60047db6937a6eb8218b8a1720a8bd318197a"} 20:20:40 INFO - Copying logs to upload dir... 20:20:40 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1269.262281 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-07 20:20:40.086799) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 20:20:40.090387) ========= 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=574dc5aafe09851ec43d388c000001b6-1452223546.273737-1484167495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/97f92d1b5af7d5273e5e2430fc64afe857063b87205da30e5d82ff2f5a1917608f3d4b15570dd537b9876aa22671e7f17a23cc012fe9a0fd41f8e9c4193c8fc4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1f4d98f1718401de0a38e09f120ace3ccd931019f6bc94471be450575da8998ae3f7e676961782e5facc7dc495a60047db6937a6eb8218b8a1720a8bd318197a"} build_url:https://queue.taskcluster.net/v1/task/D_PgXomTQjWn7LUDQlBntg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011475 build_url: 'https://queue.taskcluster.net/v1/task/D_PgXomTQjWn7LUDQlBntg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/97f92d1b5af7d5273e5e2430fc64afe857063b87205da30e5d82ff2f5a1917608f3d4b15570dd537b9876aa22671e7f17a23cc012fe9a0fd41f8e9c4193c8fc4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1f4d98f1718401de0a38e09f120ace3ccd931019f6bc94471be450575da8998ae3f7e676961782e5facc7dc495a60047db6937a6eb8218b8a1720a8bd318197a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 20:20:40.114927) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 20:20:40.115276) ========= 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=574dc5aafe09851ec43d388c000001b6-1452223546.273737-1484167495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004613 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 20:20:40.197834) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 20:20:40.198169) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 20:20:40.198443) ========= ========= Total master_lag: 0.24 =========