builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-049 starttime: 1450821209.47 results: success (0) buildid: 20151222113010 builduid: 9228721f68e244be8fa76df3996472c2 revision: 2aad6036a8e559e974a65e0ada0c403775d7aa0b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 13:53:29.466140) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 13:53:29.466775) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 13:53:29.467075) ========= 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=0c96bf5caf0e090009e1a122000001b2-1450816368.385582-1488473436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006414 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 13:53:29.520466) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 13:53:29.520805) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 13:53:29.705407) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 13:53:29.705734) ========= 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=0c96bf5caf0e090009e1a122000001b2-1450816368.385582-1488473436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004570 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 13:53:29.787920) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 13:53:29.788183) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 13:53:29.788534) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 13:53:29.788800) ========= 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=0c96bf5caf0e090009e1a122000001b2-1450816368.385582-1488473436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-22 13:53: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.1M=0s 2015-12-22 13:53:30 (40.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.155473 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 13:53:29.982609) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 13:53:29.982921) ========= 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=0c96bf5caf0e090009e1a122000001b2-1450816368.385582-1488473436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017584 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 13:53:30.036348) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 13:53:30.036729) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2aad6036a8e559e974a65e0ada0c403775d7aa0b --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 2aad6036a8e559e974a65e0ada0c403775d7aa0b --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=0c96bf5caf0e090009e1a122000001b2-1450816368.385582-1488473436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-22 13:53:30,534 truncating revision to first 12 chars 2015-12-22 13:53:30,534 Setting DEBUG logging. 2015-12-22 13:53:30,534 attempt 1/10 2015-12-22 13:53:30,534 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2aad6036a8e5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-22 13:53:30,994 unpacking tar archive at: fx-team-2aad6036a8e5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.745337 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 13:53:30.798484) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 13:53:30.798777) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 13:53:30.808203) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 13:53:30.808518) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 13:53:30.809162) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-22 13:53:30.809462) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--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=0c96bf5caf0e090009e1a122000001b2-1450816368.385582-1488473436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:53:31 INFO - MultiFileLogger online at 20151222 13:53:31 in /builds/slave/test-pgo 13:53:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 13:53:31 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 13:53:31 INFO - {'append_to_log': False, 13:53:31 INFO - 'base_work_dir': '/builds/slave/test-pgo', 13:53:31 INFO - 'blob_upload_branch': 'Fx-Team', 13:53:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 13:53:31 INFO - 'branch': 'Fx-Team', 13:53:31 INFO - 'buildbot_json_path': 'buildprops.json', 13:53:31 INFO - 'config_files': ('talos/linux_config.py',), 13:53:31 INFO - 'default_actions': ('clobber', 13:53:31 INFO - 'read-buildbot-config', 13:53:31 INFO - 'download-and-extract', 13:53:31 INFO - 'populate-webroot', 13:53:31 INFO - 'create-virtualenv', 13:53:31 INFO - 'install', 13:53:31 INFO - 'run-tests'), 13:53:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:53:31 INFO - 'download_minidump_stackwalk': True, 13:53:31 INFO - 'download_symbols': 'ondemand', 13:53:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:53:31 INFO - 'tooltool.py': '/tools/tooltool.py', 13:53:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:53:31 INFO - '/tools/misc-python/virtualenv.py')}, 13:53:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:53:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:53:31 INFO - 'installer_path': 'installer.exe', 13:53:31 INFO - 'log_level': 'info', 13:53:31 INFO - 'log_name': 'talos', 13:53:31 INFO - 'log_to_console': True, 13:53:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:53:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:53:31 INFO - 'opt_config_files': (), 13:53:31 INFO - 'pip_index': False, 13:53:31 INFO - 'sps_profile': False, 13:53:31 INFO - 'sps_profile_interval': 0, 13:53:31 INFO - 'suite': 'dromaeojs', 13:53:31 INFO - 'system_bits': '64', 13:53:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:53:31 INFO - 'title': 'talos-linux64-ix-049', 13:53:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:53:31 INFO - 'use_talos_json': True, 13:53:31 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 13:53:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:53:31 INFO - 'work_dir': 'build'} 13:53:31 INFO - ##### 13:53:31 INFO - ##### Running clobber step. 13:53:31 INFO - ##### 13:53:31 INFO - Running pre-action listener: _resource_record_pre_action 13:53:31 INFO - Running main action method: clobber 13:53:31 INFO - rmtree: /builds/slave/test-pgo/build 13:53:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 13:53:32 INFO - Running post-action listener: _resource_record_post_action 13:53:32 INFO - ##### 13:53:32 INFO - ##### Running read-buildbot-config step. 13:53:32 INFO - ##### 13:53:32 INFO - Running pre-action listener: _resource_record_pre_action 13:53:32 INFO - Running main action method: read_buildbot_config 13:53:32 INFO - Using buildbot properties: 13:53:32 INFO - { 13:53:32 INFO - "project": "", 13:53:32 INFO - "product": "firefox", 13:53:32 INFO - "script_repo_revision": "production", 13:53:32 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:53:32 INFO - "repository": "", 13:53:32 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 13:53:32 INFO - "buildid": "20151222113010", 13:53:32 INFO - "pgo_build": "True", 13:53:32 INFO - "basedir": "/builds/slave/test-pgo", 13:53:32 INFO - "buildnumber": 383, 13:53:32 INFO - "slavename": "talos-linux64-ix-049", 13:53:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:53:32 INFO - "platform": "ubuntu64_hw", 13:53:32 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 13:53:32 INFO - "branch": "fx-team", 13:53:32 INFO - "repo_path": "integration/fx-team", 13:53:32 INFO - "revision": "2aad6036a8e559e974a65e0ada0c403775d7aa0b", 13:53:32 INFO - "stage_platform": "linux64-pgo", 13:53:32 INFO - "builduid": "9228721f68e244be8fa76df3996472c2", 13:53:32 INFO - "slavebuilddir": "test" 13:53:32 INFO - } 13:53:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/BtYEPHAHSYqCv-sPXbeuwA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 13:53:32 INFO - Running post-action listener: _resource_record_post_action 13:53:32 INFO - ##### 13:53:32 INFO - ##### Running download-and-extract step. 13:53:32 INFO - ##### 13:53:32 INFO - Running pre-action listener: _resource_record_pre_action 13:53:32 INFO - Running main action method: download_and_extract 13:53:32 INFO - mkdir: /builds/slave/test-pgo/build/tests 13:53: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')]} 13:53:32 INFO - https://queue.taskcluster.net/v1/task/BtYEPHAHSYqCv-sPXbeuwA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:53:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtYEPHAHSYqCv-sPXbeuwA/artifacts/public/build/test_packages.json 13:53:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtYEPHAHSYqCv-sPXbeuwA/artifacts/public/build/test_packages.json 13:53:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtYEPHAHSYqCv-sPXbeuwA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 13:53:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtYEPHAHSYqCv-sPXbeuwA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 13:53:34 INFO - Downloaded 1302 bytes. 13:53:34 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 13:53:34 INFO - Using the following test package requirements: 13:53:34 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:53:34 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:53:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:53:34 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:53:34 INFO - u'jsshell-linux-x86_64.zip'], 13:53:34 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:53:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:53:34 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:53:34 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:53:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:53:34 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:53:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:53:34 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:53:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:53:34 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:53:34 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:53:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:53:34 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:53:34 INFO - https://queue.taskcluster.net/v1/task/BtYEPHAHSYqCv-sPXbeuwA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:53:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtYEPHAHSYqCv-sPXbeuwA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:53:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtYEPHAHSYqCv-sPXbeuwA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:53:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtYEPHAHSYqCv-sPXbeuwA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:53:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtYEPHAHSYqCv-sPXbeuwA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:53:35 INFO - Downloaded 23175711 bytes. 13:53:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 13:53:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:53:35 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:53:36 INFO - Return code: 0 13:53:36 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:53:36 INFO - https://queue.taskcluster.net/v1/task/BtYEPHAHSYqCv-sPXbeuwA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:53:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtYEPHAHSYqCv-sPXbeuwA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:53:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtYEPHAHSYqCv-sPXbeuwA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:53:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtYEPHAHSYqCv-sPXbeuwA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:53:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtYEPHAHSYqCv-sPXbeuwA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:53:38 INFO - Downloaded 23175711 bytes. 13:53:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 13:53:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:53:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:53:39 INFO - Return code: 0 13:53:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:53:39 INFO - https://queue.taskcluster.net/v1/task/BtYEPHAHSYqCv-sPXbeuwA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:53:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtYEPHAHSYqCv-sPXbeuwA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:53:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtYEPHAHSYqCv-sPXbeuwA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:53:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtYEPHAHSYqCv-sPXbeuwA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:53:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtYEPHAHSYqCv-sPXbeuwA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:53:40 INFO - Downloaded 11132277 bytes. 13:53:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 13:53:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:53:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 13:53:41 INFO - Return code: 0 13:53: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')]} 13:53:41 INFO - https://queue.taskcluster.net/v1/task/BtYEPHAHSYqCv-sPXbeuwA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:53:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtYEPHAHSYqCv-sPXbeuwA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:53:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtYEPHAHSYqCv-sPXbeuwA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:53:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtYEPHAHSYqCv-sPXbeuwA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:53:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BtYEPHAHSYqCv-sPXbeuwA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:53:42 INFO - Downloaded 54877484 bytes. 13:53:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BtYEPHAHSYqCv-sPXbeuwA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:53:42 INFO - mkdir: /builds/slave/test-pgo/properties 13:53:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 13:53:42 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 13:53:42 INFO - Contents: 13:53:42 INFO - build_url:https://queue.taskcluster.net/v1/task/BtYEPHAHSYqCv-sPXbeuwA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:53:42 INFO - Running post-action listener: _resource_record_post_action 13:53:42 INFO - Running post-action listener: set_extra_try_arguments 13:53:42 INFO - ##### 13:53:42 INFO - ##### Running populate-webroot step. 13:53:42 INFO - ##### 13:53:42 INFO - Running pre-action listener: _resource_record_pre_action 13:53:42 INFO - Running main action method: populate_webroot 13:53:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:53:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:53:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:53:42 INFO - '--tppagecycles', 13:53:42 INFO - '7'], 13:53:42 INFO - 'tests': ['tsvgm']}}, 13:53:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:53:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:53:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:53:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:53:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:53:42 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:53:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:53:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:53:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:53:42 INFO - 'talos_options': ['--e10s'], 13:53:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:53:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:53:42 INFO - 'tests': ['damp', 'tps']}, 13:53:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:53:42 INFO - 'talos_options': ['--e10s'], 13:53:42 INFO - 'tests': ['damp', 'tps']}, 13:53:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:53:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:53:42 INFO - 'other': {'tests': ['a11yr', 13:53:42 INFO - 'ts_paint', 13:53:42 INFO - 'tpaint', 13:53:42 INFO - 'sessionrestore', 13:53:42 INFO - 'sessionrestore_no_auto_restore']}, 13:53:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:53:42 INFO - 'tests': ['a11yr', 13:53:42 INFO - 'ts_paint', 13:53:42 INFO - 'tpaint', 13:53:42 INFO - 'sessionrestore', 13:53:42 INFO - 'sessionrestore_no_auto_restore']}, 13:53:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:53:42 INFO - 'tests': ['a11yr', 13:53:42 INFO - 'ts_paint', 13:53:42 INFO - 'tpaint', 13:53:42 INFO - 'sessionrestore', 13:53:42 INFO - 'sessionrestore_no_auto_restore']}, 13:53:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:53:42 INFO - 'tests': ['a11yr', 13:53:42 INFO - 'ts_paint', 13:53:42 INFO - 'tpaint', 13:53:42 INFO - 'sessionrestore', 13:53:42 INFO - 'sessionrestore_no_auto_restore']}, 13:53:42 INFO - 'other_l64': {'tests': ['a11yr', 13:53:42 INFO - 'ts_paint', 13:53:42 INFO - 'tpaint', 13:53:42 INFO - 'sessionrestore', 13:53:42 INFO - 'sessionrestore_no_auto_restore']}, 13:53:42 INFO - 'other_nol64': {'tests': ['a11yr', 13:53:42 INFO - 'ts_paint', 13:53:42 INFO - 'tpaint', 13:53:42 INFO - 'sessionrestore', 13:53:42 INFO - 'sessionrestore_no_auto_restore']}, 13:53:42 INFO - 'svgr': {'tests': ['tsvgx', 13:53:42 INFO - 'tsvgr_opacity', 13:53:42 INFO - 'tart', 13:53:42 INFO - 'tscrollx', 13:53:42 INFO - 'cart']}, 13:53:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:53:42 INFO - 'tests': ['tsvgx', 13:53:42 INFO - 'tsvgr_opacity', 13:53:42 INFO - 'tart', 13:53:42 INFO - 'tscrollx', 13:53:42 INFO - 'cart']}, 13:53:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:53:42 INFO - 'tests': ['tp5o']}, 13:53:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:53:42 INFO - 'talos_options': ['--e10s'], 13:53:42 INFO - 'tests': ['tp5o']}, 13:53:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:53:42 INFO - 'talos_options': ['--xperf_path', 13:53:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:53:42 INFO - 'tests': ['tp5n']}, 13:53:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:53:42 INFO - 'talos_options': ['--e10s', 13:53:42 INFO - '--xperf_path', 13:53:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:53:42 INFO - 'tests': ['tp5n']}}, 13:53:42 INFO - 'talos.zip': {'path': '', 13:53:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:53:42 INFO - Running post-action listener: _resource_record_post_action 13:53:42 INFO - ##### 13:53:42 INFO - ##### Running create-virtualenv step. 13:53:42 INFO - ##### 13:53:42 INFO - Running pre-action listener: _resource_record_pre_action 13:53:42 INFO - Running main action method: create_virtualenv 13:53:42 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 13:53:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 13:53:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 13:53:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:53:42 INFO - Using real prefix '/usr' 13:53:42 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 13:53:43 INFO - Installing distribute.............................................................................................................................................................................................done. 13:53:45 INFO - Installing pip.................done. 13:53:45 INFO - Return code: 0 13:53:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 13:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:53:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:53:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:53:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:53:45 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 0x7f42efd13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2430840>, '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 0x239d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239db60>, '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': '0c96bf5caf0e090009e1a122000001b2-1450816368.385582-1488473436', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:53:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 13:53:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:53:45 INFO - Using env: {'DISPLAY': ':0', 13:53:45 INFO - 'HOME': '/home/cltbld', 13:53:45 INFO - 'LANG': 'en_US.UTF-8', 13:53:45 INFO - 'LANGUAGE': 'en_US:en', 13:53:45 INFO - 'LOGNAME': 'cltbld', 13:53:45 INFO - 'MAIL': '/var/mail/cltbld', 13:53:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:45 INFO - 'MOZ_NO_REMOTE': '1', 13:53:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:45 INFO - 'NO_EM_RESTART': '1', 13:53:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:53:45 INFO - 'PWD': '/builds/slave/test-pgo', 13:53:45 INFO - 'SHELL': '/bin/bash', 13:53:45 INFO - 'SHLVL': '1', 13:53:45 INFO - 'TERM': 'linux', 13:53:45 INFO - 'TMOUT': '86400', 13:53:45 INFO - 'USER': 'cltbld', 13:53:45 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1450816368.385582-1488473436', 13:53:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:45 INFO - '_': '/tools/buildbot/bin/python'} 13:53:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:53:45 INFO - Cleaning up... 13:53:45 INFO - Return code: 0 13:53:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 13:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:53:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:53:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:53:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:53:45 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 0x7f42efd13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2430840>, '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 0x239d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239db60>, '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': '0c96bf5caf0e090009e1a122000001b2-1450816368.385582-1488473436', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:53:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 13:53:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 13:53:45 INFO - Using env: {'DISPLAY': ':0', 13:53:45 INFO - 'HOME': '/home/cltbld', 13:53:45 INFO - 'LANG': 'en_US.UTF-8', 13:53:45 INFO - 'LANGUAGE': 'en_US:en', 13:53:45 INFO - 'LOGNAME': 'cltbld', 13:53:45 INFO - 'MAIL': '/var/mail/cltbld', 13:53:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:45 INFO - 'MOZ_NO_REMOTE': '1', 13:53:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:45 INFO - 'NO_EM_RESTART': '1', 13:53:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:53:45 INFO - 'PWD': '/builds/slave/test-pgo', 13:53:45 INFO - 'SHELL': '/bin/bash', 13:53:45 INFO - 'SHLVL': '1', 13:53:45 INFO - 'TERM': 'linux', 13:53:45 INFO - 'TMOUT': '86400', 13:53:45 INFO - 'USER': 'cltbld', 13:53:45 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1450816368.385582-1488473436', 13:53:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:45 INFO - '_': '/tools/buildbot/bin/python'} 13:53:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:53:45 INFO - Downloading/unpacking psutil>=0.7.1 13:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:53:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:53:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:53:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:53:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:53:47 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 13:53:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:53:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 13:53:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:53:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:53:47 INFO - Installing collected packages: psutil 13:53:47 INFO - Running setup.py install for psutil 13:53:47 INFO - building 'psutil._psutil_linux' extension 13:53:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:53:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:53:47 INFO - building 'psutil._psutil_posix' extension 13:53:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:53:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:53:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:53:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:53:47 INFO - Successfully installed psutil 13:53:47 INFO - Cleaning up... 13:53:47 INFO - Return code: 0 13:53:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 13:53: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')]} 13:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:53:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:53: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')]} 13:53:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:53:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:53: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', '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 0x7f42efd13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2430840>, '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 0x239d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239db60>, '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': '0c96bf5caf0e090009e1a122000001b2-1450816368.385582-1488473436', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:53: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 13:53: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 mozsystemmonitor==0.0.0 13:53:47 INFO - Using env: {'DISPLAY': ':0', 13:53:47 INFO - 'HOME': '/home/cltbld', 13:53:47 INFO - 'LANG': 'en_US.UTF-8', 13:53:47 INFO - 'LANGUAGE': 'en_US:en', 13:53:47 INFO - 'LOGNAME': 'cltbld', 13:53:47 INFO - 'MAIL': '/var/mail/cltbld', 13:53:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:47 INFO - 'MOZ_NO_REMOTE': '1', 13:53:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:47 INFO - 'NO_EM_RESTART': '1', 13:53:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:53:47 INFO - 'PWD': '/builds/slave/test-pgo', 13:53:47 INFO - 'SHELL': '/bin/bash', 13:53:47 INFO - 'SHLVL': '1', 13:53:47 INFO - 'TERM': 'linux', 13:53:47 INFO - 'TMOUT': '86400', 13:53:47 INFO - 'USER': 'cltbld', 13:53:47 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1450816368.385582-1488473436', 13:53:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:47 INFO - '_': '/tools/buildbot/bin/python'} 13:53:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:53:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:53:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:53:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:53:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:53:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:53:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:53:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:53:49 INFO - Installing collected packages: mozsystemmonitor 13:53:49 INFO - Running setup.py install for mozsystemmonitor 13:53:49 INFO - Successfully installed mozsystemmonitor 13:53:49 INFO - Cleaning up... 13:53:49 INFO - Return code: 0 13:53:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 13:53: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')]} 13:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:53:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:53: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')]} 13:53:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:53:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:53: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', '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 0x7f42efd13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2430840>, '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 0x239d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239db60>, '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': '0c96bf5caf0e090009e1a122000001b2-1450816368.385582-1488473436', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:53: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 13:53: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 blobuploader==1.2.4 13:53:49 INFO - Using env: {'DISPLAY': ':0', 13:53:49 INFO - 'HOME': '/home/cltbld', 13:53:49 INFO - 'LANG': 'en_US.UTF-8', 13:53:49 INFO - 'LANGUAGE': 'en_US:en', 13:53:49 INFO - 'LOGNAME': 'cltbld', 13:53:49 INFO - 'MAIL': '/var/mail/cltbld', 13:53:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:49 INFO - 'MOZ_NO_REMOTE': '1', 13:53:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:49 INFO - 'NO_EM_RESTART': '1', 13:53:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:53:49 INFO - 'PWD': '/builds/slave/test-pgo', 13:53:49 INFO - 'SHELL': '/bin/bash', 13:53:49 INFO - 'SHLVL': '1', 13:53:49 INFO - 'TERM': 'linux', 13:53:49 INFO - 'TMOUT': '86400', 13:53:49 INFO - 'USER': 'cltbld', 13:53:49 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1450816368.385582-1488473436', 13:53:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:49 INFO - '_': '/tools/buildbot/bin/python'} 13:53:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:53:50 INFO - Downloading/unpacking blobuploader==1.2.4 13:53: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 13:53: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 13:53: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 13:53: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 13:53: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 13:53: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 13:53:51 INFO - Downloading blobuploader-1.2.4.tar.gz 13:53:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:53:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:53:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:53:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:53:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:53:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:53:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:53:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:53:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 13:53:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:53: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 13:53: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 13:53: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 13:53: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 13:53: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 13:53: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 13:53:52 INFO - Downloading docopt-0.6.1.tar.gz 13:53:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:53:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 13:53:52 INFO - Installing collected packages: blobuploader, requests, docopt 13:53:52 INFO - Running setup.py install for blobuploader 13:53:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:53:52 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 13:53:52 INFO - Running setup.py install for requests 13:53:53 INFO - Running setup.py install for docopt 13:53:53 INFO - Successfully installed blobuploader requests docopt 13:53:53 INFO - Cleaning up... 13:53:53 INFO - Return code: 0 13:53:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:53:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:53:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:53:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:53:53 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 0x7f42efd13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2430840>, '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 0x239d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239db60>, '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': '0c96bf5caf0e090009e1a122000001b2-1450816368.385582-1488473436', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:53:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 13:53:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:53:53 INFO - Using env: {'DISPLAY': ':0', 13:53:53 INFO - 'HOME': '/home/cltbld', 13:53:53 INFO - 'LANG': 'en_US.UTF-8', 13:53:53 INFO - 'LANGUAGE': 'en_US:en', 13:53:53 INFO - 'LOGNAME': 'cltbld', 13:53:53 INFO - 'MAIL': '/var/mail/cltbld', 13:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:53 INFO - 'MOZ_NO_REMOTE': '1', 13:53:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:53 INFO - 'NO_EM_RESTART': '1', 13:53:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:53:53 INFO - 'PWD': '/builds/slave/test-pgo', 13:53:53 INFO - 'SHELL': '/bin/bash', 13:53:53 INFO - 'SHLVL': '1', 13:53:53 INFO - 'TERM': 'linux', 13:53:53 INFO - 'TMOUT': '86400', 13:53:53 INFO - 'USER': 'cltbld', 13:53:53 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1450816368.385582-1488473436', 13:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:53 INFO - '_': '/tools/buildbot/bin/python'} 13:53:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:53:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:53:53 INFO - Running setup.py (path:/tmp/pip-YhGEnp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:53:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:53:53 INFO - Running setup.py (path:/tmp/pip-jQqm5V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:53:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:53:53 INFO - Running setup.py (path:/tmp/pip-xoovFA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:53:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:53:53 INFO - Running setup.py (path:/tmp/pip-UZQQYD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:53:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:53:53 INFO - Running setup.py (path:/tmp/pip-U62nn5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:53:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:53:53 INFO - Running setup.py (path:/tmp/pip-wpQw2E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:53:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:53:53 INFO - Running setup.py (path:/tmp/pip-0rccxt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:53:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:53:53 INFO - Running setup.py (path:/tmp/pip-RAgO2n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:53:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:53:53 INFO - Running setup.py (path:/tmp/pip-8DHDOn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:53:54 INFO - Running setup.py (path:/tmp/pip-sOy1FQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:53:54 INFO - Running setup.py (path:/tmp/pip-PEp6er-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:53:54 INFO - Running setup.py (path:/tmp/pip-L0vhyK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:53:54 INFO - Running setup.py (path:/tmp/pip-lAM7DV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:53:54 INFO - Running setup.py (path:/tmp/pip-LiSEdz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:53:54 INFO - Running setup.py (path:/tmp/pip-1hAt2C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:53:54 INFO - Running setup.py (path:/tmp/pip-0Rqfjl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:53:54 INFO - Running setup.py (path:/tmp/pip-8bn0xm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:53:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:53:54 INFO - Running setup.py install for manifestparser 13:53:54 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 13:53:54 INFO - Running setup.py install for mozcrash 13:53:54 INFO - Running setup.py install for mozdebug 13:53:54 INFO - Running setup.py install for mozdevice 13:53:55 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 13:53:55 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 13:53:55 INFO - Running setup.py install for mozfile 13:53:55 INFO - Running setup.py install for mozhttpd 13:53:55 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 13:53:55 INFO - Running setup.py install for mozinfo 13:53:55 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 13:53:55 INFO - Running setup.py install for mozInstall 13:53:55 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 13:53:55 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 13:53:55 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 13:53:55 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 13:53:55 INFO - Running setup.py install for mozleak 13:53:55 INFO - Running setup.py install for mozlog 13:53:55 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 13:53:55 INFO - Running setup.py install for moznetwork 13:53:55 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 13:53:55 INFO - Running setup.py install for mozprocess 13:53:55 INFO - Running setup.py install for mozprofile 13:53:55 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 13:53:55 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 13:53:55 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 13:53:55 INFO - Running setup.py install for mozrunner 13:53:56 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 13:53:56 INFO - Running setup.py install for mozscreenshot 13:53:56 INFO - Running setup.py install for moztest 13:53:56 INFO - Running setup.py install for mozversion 13:53:56 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 13:53:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:53:56 INFO - Cleaning up... 13:53:56 INFO - Return code: 0 13:53:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:53:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:53:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:53:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:53:56 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 0x7f42efd13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2430840>, '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 0x239d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239db60>, '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': '0c96bf5caf0e090009e1a122000001b2-1450816368.385582-1488473436', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:53:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 13:53:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:53:56 INFO - Using env: {'DISPLAY': ':0', 13:53:56 INFO - 'HOME': '/home/cltbld', 13:53:56 INFO - 'LANG': 'en_US.UTF-8', 13:53:56 INFO - 'LANGUAGE': 'en_US:en', 13:53:56 INFO - 'LOGNAME': 'cltbld', 13:53:56 INFO - 'MAIL': '/var/mail/cltbld', 13:53:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:56 INFO - 'MOZ_NO_REMOTE': '1', 13:53:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:56 INFO - 'NO_EM_RESTART': '1', 13:53:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:53:56 INFO - 'PWD': '/builds/slave/test-pgo', 13:53:56 INFO - 'SHELL': '/bin/bash', 13:53:56 INFO - 'SHLVL': '1', 13:53:56 INFO - 'TERM': 'linux', 13:53:56 INFO - 'TMOUT': '86400', 13:53:56 INFO - 'USER': 'cltbld', 13:53:56 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1450816368.385582-1488473436', 13:53:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:56 INFO - '_': '/tools/buildbot/bin/python'} 13:53:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:53:56 INFO - Running setup.py (path:/tmp/pip-bbCHU3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 13:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:53:56 INFO - Running setup.py (path:/tmp/pip-FX0Yd4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 13:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:53:56 INFO - Running setup.py (path:/tmp/pip-TR3uX4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 13:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:53:56 INFO - Running setup.py (path:/tmp/pip-cRdCnU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:53:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:53:56 INFO - Running setup.py (path:/tmp/pip-VR_TxO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 13:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:53:57 INFO - Running setup.py (path:/tmp/pip-9Hb19y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 13:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:53:57 INFO - Running setup.py (path:/tmp/pip-dCUzdD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 13:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:53:57 INFO - Running setup.py (path:/tmp/pip-Hcz7le-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 13:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:53:57 INFO - Running setup.py (path:/tmp/pip-MRRfi9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 13:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:53:57 INFO - Running setup.py (path:/tmp/pip-AORFCz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:53:57 INFO - Running setup.py (path:/tmp/pip-7fGInQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 13:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:53:57 INFO - Running setup.py (path:/tmp/pip-7_dfkF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 13:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:53:57 INFO - Running setup.py (path:/tmp/pip-A1VTrI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 13:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:53:57 INFO - Running setup.py (path:/tmp/pip-QAObfv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 13:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:53:57 INFO - Running setup.py (path:/tmp/pip-bejBk9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 13:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:53:57 INFO - Running setup.py (path:/tmp/pip-mSweZJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 13:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:53:57 INFO - Running setup.py (path:/tmp/pip-i_2pD5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 13:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 13:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 13:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 13:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:53:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:53:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:53:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:53:59 INFO - Downloading blessings-1.5.1.tar.gz 13:53:59 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 13:53:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 13:53:59 INFO - Installing collected packages: blessings 13:53:59 INFO - Running setup.py install for blessings 13:53:59 INFO - Successfully installed blessings 13:53:59 INFO - Cleaning up... 13:53:59 INFO - Return code: 0 13:53:59 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 13:53:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:53:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:54:00 INFO - Reading from file tmpfile_stdout 13:54:00 INFO - Current package versions: 13:54:00 INFO - argparse == 1.2.1 13:54:00 INFO - blessings == 1.5.1 13:54:00 INFO - blobuploader == 1.2.4 13:54:00 INFO - docopt == 0.6.1 13:54:00 INFO - manifestparser == 1.1 13:54:00 INFO - mozInstall == 1.12 13:54:00 INFO - mozcrash == 0.16 13:54:00 INFO - mozdebug == 0.1 13:54:00 INFO - mozdevice == 0.47 13:54:00 INFO - mozfile == 1.2 13:54:00 INFO - mozhttpd == 0.7 13:54:00 INFO - mozinfo == 0.9 13:54:00 INFO - mozleak == 0.1 13:54:00 INFO - mozlog == 3.1 13:54:00 INFO - moznetwork == 0.27 13:54:00 INFO - mozprocess == 0.22 13:54:00 INFO - mozprofile == 0.28 13:54:00 INFO - mozrunner == 6.11 13:54:00 INFO - mozscreenshot == 0.1 13:54:00 INFO - mozsystemmonitor == 0.0 13:54:00 INFO - moztest == 0.7 13:54:00 INFO - mozversion == 1.4 13:54:00 INFO - psutil == 3.1.1 13:54:00 INFO - requests == 1.2.3 13:54:00 INFO - wsgiref == 0.1.2 13:54:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:54:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:54:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:54:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:00 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 0x7f42efd13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2430840>, '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 0x239d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239db60>, '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': '0c96bf5caf0e090009e1a122000001b2-1450816368.385582-1488473436', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:54:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 13:54:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:54:00 INFO - Using env: {'DISPLAY': ':0', 13:54:00 INFO - 'HOME': '/home/cltbld', 13:54:00 INFO - 'LANG': 'en_US.UTF-8', 13:54:00 INFO - 'LANGUAGE': 'en_US:en', 13:54:00 INFO - 'LOGNAME': 'cltbld', 13:54:00 INFO - 'MAIL': '/var/mail/cltbld', 13:54:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:54:00 INFO - 'MOZ_NO_REMOTE': '1', 13:54:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:54:00 INFO - 'NO_EM_RESTART': '1', 13:54:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:54:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:54:00 INFO - 'PWD': '/builds/slave/test-pgo', 13:54:00 INFO - 'SHELL': '/bin/bash', 13:54:00 INFO - 'SHLVL': '1', 13:54:00 INFO - 'TERM': 'linux', 13:54:00 INFO - 'TMOUT': '86400', 13:54:00 INFO - 'USER': 'cltbld', 13:54:00 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1450816368.385582-1488473436', 13:54:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:54:00 INFO - '_': '/tools/buildbot/bin/python'} 13:54:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 13:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 13:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 13:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 13:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 13:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 13:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 13:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 13:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 13:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 13:54: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 mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 13:54:00 INFO - Cleaning up... 13:54:00 INFO - Return code: 0 13:54:00 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 13:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:54:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:54:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:54:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:00 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 0x7f42efd13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2430840>, '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 0x239d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239db60>, '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': '0c96bf5caf0e090009e1a122000001b2-1450816368.385582-1488473436', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:54:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 13:54:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:54:00 INFO - Using env: {'DISPLAY': ':0', 13:54:00 INFO - 'HOME': '/home/cltbld', 13:54:00 INFO - 'LANG': 'en_US.UTF-8', 13:54:00 INFO - 'LANGUAGE': 'en_US:en', 13:54:00 INFO - 'LOGNAME': 'cltbld', 13:54:00 INFO - 'MAIL': '/var/mail/cltbld', 13:54:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:54:00 INFO - 'MOZ_NO_REMOTE': '1', 13:54:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:54:00 INFO - 'NO_EM_RESTART': '1', 13:54:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:54:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:54:00 INFO - 'PWD': '/builds/slave/test-pgo', 13:54:00 INFO - 'SHELL': '/bin/bash', 13:54:00 INFO - 'SHLVL': '1', 13:54:00 INFO - 'TERM': 'linux', 13:54:00 INFO - 'TMOUT': '86400', 13:54:00 INFO - 'USER': 'cltbld', 13:54:00 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1450816368.385582-1488473436', 13:54:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:54:00 INFO - '_': '/tools/buildbot/bin/python'} 13:54:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:54:00 INFO - Downloading/unpacking jsonschema 13:54: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 13:54: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 13:54: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 13:54: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 13:54: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 13:54: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 13:54:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:54:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 13:54:02 INFO - Downloading/unpacking functools32 (from jsonschema) 13:54: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 13:54: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 13:54: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 13:54: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 13:54: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 13:54: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 13:54:02 INFO - Downloading functools32-3.2.3-2.tar.gz 13:54:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 13:54:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 13:54:02 INFO - warning: no files found matching '*.txt' 13:54:02 INFO - no previously-included directories found matching 'build' 13:54:02 INFO - no previously-included directories found matching 'dist' 13:54:02 INFO - no previously-included directories found matching '.git*' 13:54:02 INFO - Installing collected packages: jsonschema, functools32 13:54:02 INFO - Running setup.py install for functools32 13:54:02 INFO - warning: no files found matching '*.txt' 13:54:02 INFO - no previously-included directories found matching 'build' 13:54:02 INFO - no previously-included directories found matching 'dist' 13:54:02 INFO - no previously-included directories found matching '.git*' 13:54:02 INFO - Successfully installed jsonschema functools32 13:54:02 INFO - Cleaning up... 13:54:02 INFO - Return code: 0 13:54:02 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 13:54: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')]} 13:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:54:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54: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')]} 13:54:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:54:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f42efd13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2430840>, '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 0x239d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239db60>, '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': '0c96bf5caf0e090009e1a122000001b2-1450816368.385582-1488473436', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:54: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', 'flake8'] in /builds/slave/test-pgo/build 13:54: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 flake8 13:54:02 INFO - Using env: {'DISPLAY': ':0', 13:54:02 INFO - 'HOME': '/home/cltbld', 13:54:02 INFO - 'LANG': 'en_US.UTF-8', 13:54:02 INFO - 'LANGUAGE': 'en_US:en', 13:54:02 INFO - 'LOGNAME': 'cltbld', 13:54:02 INFO - 'MAIL': '/var/mail/cltbld', 13:54:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:54:02 INFO - 'MOZ_NO_REMOTE': '1', 13:54:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:54:02 INFO - 'NO_EM_RESTART': '1', 13:54:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:54:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:54:02 INFO - 'PWD': '/builds/slave/test-pgo', 13:54:02 INFO - 'SHELL': '/bin/bash', 13:54:02 INFO - 'SHLVL': '1', 13:54:02 INFO - 'TERM': 'linux', 13:54:02 INFO - 'TMOUT': '86400', 13:54:02 INFO - 'USER': 'cltbld', 13:54:02 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1450816368.385582-1488473436', 13:54:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:54:02 INFO - '_': '/tools/buildbot/bin/python'} 13:54:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:54:02 INFO - Downloading/unpacking flake8 13:54: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 13:54: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 13:54: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 13:54: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 13:54: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 13:54: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 13:54:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:54:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 13:54:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:54: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 13:54: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 13:54: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 13:54: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 13:54: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 13:54: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 13:54:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:54:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 13:54:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:54: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 13:54: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 13:54: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 13:54: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 13:54: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 13:54: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 13:54:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 13:54:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:54: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 13:54: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 13:54: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 13:54: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 13:54: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 13:54: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 13:54:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 13:54:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 13:54:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:54:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:54:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:54:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:54:05 INFO - no previously-included directories found matching 'docs/_build' 13:54:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:54:05 INFO - Running setup.py install for pep8 13:54:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:54:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:54:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:54:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:54:05 INFO - no previously-included directories found matching 'docs/_build' 13:54:05 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 13:54:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:54:05 INFO - Cleaning up... 13:54:05 INFO - Return code: 0 13:54:05 INFO - Running post-action listener: _resource_record_post_action 13:54:05 INFO - Running post-action listener: _start_resource_monitoring 13:54:05 INFO - Starting resource monitoring. 13:54:05 INFO - ##### 13:54:05 INFO - ##### Running install step. 13:54:05 INFO - ##### 13:54:05 INFO - Running pre-action listener: _resource_record_pre_action 13:54:05 INFO - Running main action method: install 13:54:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:54:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:54:05 INFO - Reading from file tmpfile_stdout 13:54:05 INFO - Detecting whether we're running mozinstall >=1.0... 13:54:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 13:54:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 13:54:05 INFO - Reading from file tmpfile_stdout 13:54:05 INFO - Output received: 13:54:05 INFO - Usage: mozinstall [options] installer 13:54:05 INFO - Options: 13:54:05 INFO - -h, --help show this help message and exit 13:54:05 INFO - -d DEST, --destination=DEST 13:54:05 INFO - Directory to install application into. [default: 13:54:05 INFO - "/builds/slave/test-pgo"] 13:54:05 INFO - --app=APP Application being installed. [default: firefox] 13:54:05 INFO - mkdir: /builds/slave/test-pgo/build/application 13:54:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 13:54:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 13:54:21 INFO - Reading from file tmpfile_stdout 13:54:21 INFO - Output received: 13:54:21 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 13:54:21 INFO - Running post-action listener: _resource_record_post_action 13:54:21 INFO - ##### 13:54:21 INFO - ##### Running run-tests step. 13:54:21 INFO - ##### 13:54:21 INFO - Running pre-action listener: _resource_record_pre_action 13:54:21 INFO - Running main action method: run_tests 13:54:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 13:54:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 13:54:21 INFO - Python 2.7.3 13:54:21 INFO - Return code: 0 13:54:21 INFO - grabbing minidump binary from tooltool 13:54:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:54:21 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 0x2430840>, '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 0x239d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239db60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 13:54:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 13:54:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:54:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:54:21 INFO - Return code: 0 13:54:21 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 13:54:21 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 13:54:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 13:54:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 13:54:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 13:54:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 13:54:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 13:54:22 INFO - Return code: 0 13:54:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BtYEPHAHSYqCv-sPXbeuwA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 13:54:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BtYEPHAHSYqCv-sPXbeuwA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 13:54:22 INFO - Using env: {'DISPLAY': ':0', 13:54:22 INFO - 'HOME': '/home/cltbld', 13:54:22 INFO - 'LANG': 'en_US.UTF-8', 13:54:22 INFO - 'LANGUAGE': 'en_US:en', 13:54:22 INFO - 'LOGNAME': 'cltbld', 13:54:22 INFO - 'MAIL': '/var/mail/cltbld', 13:54:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:54:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 13:54:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:54:22 INFO - 'MOZ_NO_REMOTE': '1', 13:54:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:54:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:54:22 INFO - 'NO_EM_RESTART': '1', 13:54:22 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:54:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:54:22 INFO - 'PWD': '/builds/slave/test-pgo', 13:54:22 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 13:54:22 INFO - 'SHELL': '/bin/bash', 13:54:22 INFO - 'SHLVL': '1', 13:54:22 INFO - 'TERM': 'linux', 13:54:22 INFO - 'TMOUT': '86400', 13:54:22 INFO - 'USER': 'cltbld', 13:54:22 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1450816368.385582-1488473436', 13:54:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:54:22 INFO - '_': '/tools/buildbot/bin/python'} 13:54:22 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BtYEPHAHSYqCv-sPXbeuwA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:54:22 INFO - mozversion application_buildid: 20151222113010 13:54:22 INFO - mozversion application_changeset: 2aad6036a8e559e974a65e0ada0c403775d7aa0b 13:54:22 INFO - mozversion application_display_name: Nightly 13:54:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:54:22 INFO - mozversion application_name: Firefox 13:54:22 INFO - mozversion application_remotingname: firefox 13:54:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:54:22 INFO - mozversion application_vendor: Mozilla 13:54:22 INFO - mozversion application_version: 46.0a1 13:54:22 INFO - mozversion platform_buildid: 20151222113010 13:54:22 INFO - mozversion platform_changeset: 2aad6036a8e559e974a65e0ada0c403775d7aa0b 13:54:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:54:22 INFO - mozversion platform_version: 46.0a1 13:54:22 INFO - using testdate: 1450821262 13:54:22 INFO - actual date: 1450821262 13:54:22 INFO - starting webserver on 'localhost:40511' 13:54:22 INFO - SUITE-START | Running 3 tests 13:54:22 INFO - TEST-START | dromaeo_css 13:54:22 INFO - operating with platform_type : linux_ 13:54:22 INFO - Initialising browser for dromaeo_css test... 13:54:22 INFO - TEST-INFO | started process 20342 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVcJwFO/profile http://localhost:40511/getInfo.html) 13:54:26 INFO - PROCESS | 20342 | __metrics Screen width/height:1600/1200 13:54:26 INFO - PROCESS | 20342 | colorDepth:24 13:54:26 INFO - PROCESS | 20342 | Browser inner width/height: 1024/697 13:54:26 INFO - PROCESS | 20342 | __metrics 13:54:27 INFO - PROCESS | 20342 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:54:27 INFO - PROCESS | 20342 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:54:27 ERROR - PROCESS | 20342 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 13:54:28 INFO - TEST-INFO | 20342: exit 0 13:54:28 INFO - Browser initialized. 13:54:28 INFO - Running cycle 1/1 for dromaeo_css test... 13:54:28 INFO - TEST-INFO | started process 20439 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVcJwFO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:54:39 INFO - PROCESS | 20439 | RSS: Main: 149671936 13:54:39 INFO - PROCESS | 20439 | 13:55:31 INFO - PROCESS | 20439 | 1450821331498 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] 13:57:39 INFO - PROCESS | 20439 | Cycle 1(1): loaded http://localhost:40511/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40511/tests/dromaeo/cssquery-ext.html) 13:57:41 INFO - PROCESS | 20439 | RSS: Main: 237236224 13:57:41 INFO - PROCESS | 20439 | 14:00:43 INFO - PROCESS | 20439 | Cycle 1(1): loaded http://localhost:40511/tests/dromaeo/cssquery-ext.html (next: http://localhost:40511/tests/dromaeo/cssquery-jquery.html) 14:00:44 INFO - PROCESS | 20439 | RSS: Main: 230727680 14:00:44 INFO - PROCESS | 20439 | 14:03:46 INFO - PROCESS | 20439 | Cycle 1(1): loaded http://localhost:40511/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40511/tests/dromaeo/cssquery-mootools.html) 14:03:46 INFO - PROCESS | 20439 | RSS: Main: 229888000 14:03:46 INFO - PROCESS | 20439 | 14:06:48 INFO - PROCESS | 20439 | Cycle 1(1): loaded http://localhost:40511/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40511/tests/dromaeo/cssquery-prototype.html) 14:06:49 INFO - PROCESS | 20439 | RSS: Main: 212312064 14:06:49 INFO - PROCESS | 20439 | 14:09:51 INFO - PROCESS | 20439 | Cycle 1(1): loaded http://localhost:40511/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40511/tests/dromaeo/cssquery-yui.html) 14:09:52 INFO - PROCESS | 20439 | RSS: Main: 214556672 14:09:52 INFO - PROCESS | 20439 | 14:12:54 INFO - PROCESS | 20439 | Cycle 1(1): loaded http://localhost:40511/tests/dromaeo/cssquery-yui.html (next: http://localhost:40511/tests/dromaeo/cssquery-dojo.html) 14:12:54 INFO - PROCESS | 20439 | RSS: Main: 229097472 14:12:54 INFO - PROCESS | 20439 | 14:12:54 INFO - PROCESS | 20439 | __start_tp_report 14:12:54 INFO - PROCESS | 20439 | _x_x_mozilla_page_load 14:12:54 INFO - PROCESS | 20439 | _x_x_mozilla_page_load_details 14:12:54 INFO - PROCESS | 20439 | |i|pagename|runs| 14:12:54 INFO - PROCESS | 20439 | |0;dojo.html;3098.5042393217086;3158.1315138336968;3207.967920320796;3208.23002479405;3228.128405330561;5119;5234.973825130878;5272.077386457369;5293.17955716864;5316.813911513098;5282.550983166436;5338.973305133479;5370.033393989081;5402.864928376793;5422.783088676458;4784.641151913603;4816.253480710496;4947.332110165135;5029.497050294978;5051.3938327400765;4935.6545041847085;4945.9258111128365;4956.083124621957;5037.0681423936685;5071.670341427795;4742.146413645542;4780.569748722597;4818.927716084227;4838.854834354957;4866.635002374836;4829.806807727687;4834.975825120887;4837.467878533358;4858.951410485885;4881.755912204376;4777;4835.371401717789;4838.782254798507;4856.05306965142;4891.902161956777;5039.395272567315;5066.240063990394;5067.037262920034;5122.692638441706;5150.201718733602;5661.801836935688;5749.425057494217;5749.683767392792;5750.683712395817;5754.942450575482;5595.244641973363;5716.628419152783;5732.455416735404;5733.598648094635;5734.254546908917;5300.734963251861;5301.151815709506;5324.41431442541;5374.91937620936;5412.188171774226;5882.205902203234;5888.087346461305;5906.940930590639;5911.586188966731;5970.880582388328;5380.112281473591;5679.829605111853;5685.971570142123;5690.658560486384;5696.544276457874;5508.283923090053;5551.666899986014;5668.234788303609;5786.681732504669;5825.2135961644635;5603.8599035023635;5650.26546548946;5656.490915817596;5657.462541058593;5662.094064949588;5633.183188437653;5662.603617746719;5668.603197776199;5670.8015219467125;5676.035074037423;4356.956430435655;4427.247367947457;4431.379606855043;4440.62254708347;4440.956375251813;3916.177602703407;3916.6475017248013;3933.056066544009;3952.525696916331;3965.2466031453932;5350.91973620396;5363.034653762282;5363.356397232279;5367.704776237344;5406.08096623575;5537.446255374511;5572.275604171432;5597.384287728347;5660.264165658438;5715.971420142872;5413.729313534308;5422.15956526739;5422.240886275925;5457.808976685797;5482.095454250004;4890.559849613481;4890.902181956412;4891.926621100615;4904.485029071968;4916.926246106311;5657.6322539035655;5794.942050579441;5873.177755114288;5878.588498805043;5882.294124705063;5596.244506991667;5663.348714897839;5696.4588364107;5747.827565173052;5780;5704.743286552198;5818.505427038749;5827.358990511125;5834.766609335579;5835.8832823342445;5588.469095435927;5661.66030038199;5662.688552129673;5664.518515926193;5673.5461163107675;5558.277423934863;5661.943380566142;5681.346645135863;5682.886342273048;5689.544836412994;5495.203195536705;5515.724213789214;5526.171074338881;5634.408387119293;5647.661140331593;5618.185363122243;5664.348599911063;5675.659460432387;5685.147227915846;5685.403032681509;5543.25166102571;5559;5565.499105080562;5565.860853478695;5610.607257491936;5406.648567843235;5536.307961504812;5544.306961629796;5603.411641777555;5681.375048744552;5503.908514764364;5511.807086751945;5514.6691198528215;5517.944820551904;5575.386707462257 14:12:55 INFO - PROCESS | 20439 | |1;ext.html;568.184655020046;572.8424683212119;575.9424057594243;598.625858838226;605.5700452678598;26472;38726.41910371343;39173.41239881404;39181.21637567247;39201.803990980006;42012.159756804926;42318.78840605792;42512.787436062856;42516.78741606288;42558;7289.890651640229;7393.482456228066;8686.826263474743;8864.246539044158;10006.449645269508;10214.233932455058;10276.075153236206;10371.274010819208;10377.273590848643;10384.896151038507;10083.596656133746;10168.678071850649;10170.135538479239;10178.643747468841;10183.6944891653;7438.851222975537;7629.084509858797;10399.636012739593;10626.14990800734;10645.733856653567;10162.847557286646;10292.639757608522;10296.845547316796;10300.89699103007;10305.484725763681;39009.219815603814;39466.60533394658;39494;39554;39570.40644390336;3279.803211807275;3317.3862835375535;3631.564212294515;3681.7422780405113;4083.530394004668;29113.56329655057;29263.41473170525;29347.853260733773;29488;29873.70126298731;3844.1350696093436;3916.7649941003633;3928.744631598937;4017.678585713136;4038.434619153321;264860;265823;267724;268748;270070;57295;57589.71205143948;57625;57636.71181644065;57678.42321576815;46381.5361846384;47643.285350719765;66021.6698916512;67604.66197669078;67778.3222167772;14938.775918361232;15058.096514209183;15193.164375959428;15241.314140863687;15245.542633721006;10901.127909767358;10904.781904362027;10963.287386319864;11042;11060;18994.050297485348;19074.80925190758;19257;19263.133159007877;19303.814870546485;7787.961060194776;7970.083440404312;8002.479838810459;8054.5569993650915;8069.556174410346;1000.2947921715319;1056.1497994114657;1087.896649818266;1090.225939582905;1091.170710260208;27653.44693106167;28224;28682.13953581396;28910.566341504895;29108.563371549444;974.8878878929014;987.1214618988962;1035.1098055672267;1094.1684319916762;1113.4711012269108;14085.507007254697;15053.172075535731;15223.847761522244;15340.002899811476;15535.611609709847;308250;313892;313936;314162;314608;49793.75103124461;49984.75007624939;50119.74940125276;50129.49870501321;50257;1368.4457794593206;1369.0553518072697;1370.5340184337374;1379.951701690456;1389.7637401641746;27481.45037099207;28270.293242669097;28289.71710282953;28300;28585;43782.34326485042;44084.559154409326;44164.77917610391;44169.55830441783;44173.77913110414;285265;285467;285626;286966;287053;23034.654480182475;24534.754652453248;25441.491170176123;29491.705082949753;31111.84444077765;37637.81181094077;38791.22417551577;39012;39311;39718.80140599279;31604;32833.835830820695;33198;33414.498782517796;33446.832765836014;28192.29519262035;31624.525632115077;36216.81891590525;37681.81159094187;38007.2398552033;31710.36579268448;32062.67937320597;32064.35871282608;32070.518942215418;34486.31027379489;26673;28218.71781282243;28903.85548072246;28980.130596082152;29081;22676;22930.656040159745;23900.402489937194;24033;24583.13959011426 14:12:55 INFO - PROCESS | 20439 | |2;jquery.html;369.26331967724394;369.6839202481878;369.84096838359505;370.1708173690933;370.57939238963786;12938.223706577612;12939;16616.501504954857;17667.11664416779;18414.17136228868;12190.02479801616;14707.338169782359;15003.549893503212;15009.099454032767;15111.546653600382;5352.143657014869;5485.945140548583;5495.6427832190975;5496.120620700669;5497.340319161706;3741.5323084614424;3824.7513911595797;5066.012127635113;5249.081410753122;5461.836144915639;5368;5393.2719082923695;5400.675959442446;5407;5407.080796264644;5383.81156659515;5389.245505629196;5592.748326325304;5915.260592425947;5920.79277225295;5246.475352464761;5251.081060814342;5255.211718242256;5255.710935898524;5259.658122222081;11916.404179790976;18515;18878.90560547202;19138;19703.704444433344;2045.6420126477956;2100.85294029418;2130.5845360154776;2156.4069880782754;2252.358077947777;9402.95298523503;9583.424994500352;9719.514024298827;10656.840147397796;12600.306983115925;1680.3698613020117;1842.5946291815778;1848.2884089625456;1851.5741379482795;1877.6807942649646;59234;59750.402495974915;59828.70085649544;62976.37023629751;64212.67893660549;9868.703938881845;9956.900430995598;10050.648227312155;10099.192064634812;10152.644657436955;12978.740425191443;13027.413766380536;13125;13140.934295328461;13161.67095822593;7324;7353.485256032026;7362.085459183643;7460.29127232912;7473.439492038119;6973.965130174317;7003.089598352181;7095.113110861143;7097.538659987187;7117.750878719324;4206.305959516707;4294.871153865389;4309.870703878889;4351.282038463682;4356.106998065389;1603.4628399486303;1643.2851709506165;1719.8796084274231;1766.5318690546758;1806.4309742431092;818.9140140285184;860.6127242740666;941.5904081724472;1016;1045.947702614866;16057.919710401373;16187.514374568545;17208.39770608048;17564.38524651631;17836.821631783776;827.3648429751262;892.7812685891998;930.093159169804;934.4159900062461;1019.1031891935049;8517.36119791018;9578.281628877861;9619.230461563198;9717.514124293757;9951.154151897024;569612;572564;594789;598559;603285;77103;80160;80240.59879700681;80487.59756201181;82384;1096.090245096568;1102.030213412192;1185.146694380045;1188.5008296515484;1207.4687137659403;15593.610159746097;15631;15673;15839.920800395925;15973.440929567874;35558.46662300119;35682.46476302909;35742.64257357393;36577.085572860895;36943.07642308964;46385.304220436046;46636.53363466322;46796.7660161697;47705.522944770106;47765.761171193924;9399.20106790903;9461.763455913657;9556.378835375679;9668.613255469703;9672.95163524178;11305.378204198849;11414.48634811419;11544.422778861192;11559.595414160463;11578.363190024293;10360.896391035993;11401.942990284995;14387.568372948828;14727.453617370022;14870.256487175382;13698.38357273945;13847.584572462842;14257.358418870968;14679.55961321162;14779.261036947895;14249.179022788006;14383.137011779327;14481.275936203358;14626.122432654074;14717.264136793332;9341.34610577253;9359.578818953027;9394.95302523483;9511.476868772284;9713.9028609713;11548.307101573597;14760;14800.555983320517;15019.399224030916;15105.773413399027 14:12:55 INFO - PROCESS | 20439 | |3;mootools.html;1296.3647812571842;1703.1824724132416;1734.9653006939861;1748.064785339843;1786.6158775863196;6444.8066558003275;7676.155622881485;7835.92164078359;7845.4900431471915;7864.134945156028;7454.329110380065;7647.082350117979;7657.578833164173;7661.502002369842;7664.271894170045;1955.3156395261688;2016.3547664747286;2019.4749365165017;2269.4326418395403;2314.4792421705065;2041.2651445479617;2258.3450799268276;2293.1859189987563;2304.7925686688195;2307.7692230776956;2249.6513040478753;2272.5682120397155;2282.5549017941507;2283.360659015478;2314.618088015475;2206.018321846771;2222.533268013703;2234.4748983988748;2234.5084081502123;2236.083205885587;2299.988500057489;2330.5105927755194;2331.1141766128762;2333.8833058347186;2334.26470661741;7840.2943735063545;7914.920850791476;7915.05019397676;7915.762527124196;7921.881171782428;4662.3239630253765;4756.762161891892;4768.833090841838;4769.689970151929;4772.284157376386;3057.6824145801834;3089.748651796026;3144.7326977206967;3175.3966746318124;3185.7451403887635;1037.19617296595;1104.0670633314917;1106.8173751331021;1112.8720197177347;1121.8092924202824;10813.729656758565;10895.673129806119;10895.782084358269;10933.18001149917;10940;4199.91600167995;4279.679024073207;4304.966807966066;4336.718113322624;4356.803943822536;9240.491772952551;9250.074992500831;9262.95368523153;9269.536523173814;9287.628494860264;4760.09558183944;4760.976195119071;4780.617550596014;4780.976095119572;4792.2332426811545;4355.760433176206;4365.978170109129;4367.192069467159;4369.737815731066;4372.322290045048;3219.323941972212;3710.591834898159;3767.7174211933666;3781.621837816251;3786.3563194257044;1083.312096818526;1180.7756526259984;1212.5998420521207;1215.769003889258;1221.8350522679502;1034.4207243943415;1052.1004541117388;1087.7715679707192;1302.7524770293614;1304.8368953880765;7159.284071592799;7248.456365772483;7343.816404589928;7356.485046046725;7358.96320518394;1109.5839060352369;1111.727626731456;1133.0287342863212;1137.8748337682848;1140.7946569617382;5678;5760.654360738369;5764.942350576524;5769.451902069297;5769.884602308014;8847.601857916408;9001.954990225138;9285.25717942563;9289.256859451227;9290.210332121711;9112.681056163003;9203.723888283228;9225.400348977295;9229.215516681157;9233.769155771159;7101.680424380916;7248.166460857069;7256.129264488295;7313.866350715648;7318.707251709872;7289.4168466523615;7345.412367010519;7385.224551422239;7437.553746775211;7447.739329123455;8234.464759790595;8486.915130848613;8624.827503449771;8640.35197360213;8670.956645216733;8811.295096392145;8825.646974120964;8834.823303534022;8849.4247873888;8850.247728943112;6598.60408375499;6879.621620810904;6881.621510816954;6883.7590684325805;6892.827679307857;6799.762008329685;6936.583804971718;7550.320471157622;7588.886166707393;7608.31525162738;6775.356341147583;6853.760118395832;6908;6936.2023367311385;7009.894851577128;6695.598264104169;6757.290484499254;6800.081988931431;6845.0759147514445;6899.793006209822;7109.573425594481;7148.64256787169;7152.177499587614;7154.141503019671;7157.427405807419;6417.6470294132405;6420.871582568416;6476.283784797127;6484.70818813164;6489.9026514603265;6387.041943708295;6393.6163830170335;6394.4884409246215;6411.807645770635;6415.8396040097505 14:12:55 INFO - PROCESS | 20439 | |4;prototype.html;324.2720093390339;335.22061207692116;338.62243598387806;340.2565394612771;343.05146270561903;5857.85355366115;5897.557683173768;5903.527717782573;5912.7930522431725;5948.1375200595885;5571.275734154565;5662.320521537411;5785.913211301834;5869.8239052828485;5882.382349853268;4577.519360467153;4580.404547408849;4602.332661764042;4621.191291523986;4622.445306563217;4357.869263922072;4588.197065513538;4589.219832628444;4591.173588754023;4595.172868883599;4392.89017774555;4417.823287068513;4518.751468669222;4523.411956445674;4555.314533622564;4574.542545745432;4575;4575.130725162208;4579.198640237945;4582.427196600425;4030.415589739471;4034.152827906143;4044.8382064717375;4046.8178931947837;4050.453188819501;5507.9449205507835;5626.324841019063;5629.80295689653;5631.155326701028;5634.154876768517;5316.601254905898;5319.813806516792;5323.494268044529;5325.893482130375;5333.200019997032;6248.937510624881;6266.655333956631;6267.9686601567155;6274.749010039593;6276.184096067527;4474.597286244221;4476.55234476553;4477.529859364752;4482.350059241392;4493.887652808673;6372.745090196387;6540.34596540347;6543.869122617521;6548.8362790930605;6563.278039415708;4567.817287308537;4568.954310456919;4570.405847239837;4572.359869618256;4572.4055872736335;4625.074985002945;4625.95374046262;4628.305754136906;4631.606313463393;4635.884102897455;5273.024490469275;5277.894442111213;5281.102212623863;5287.68273903567;5297.099493086184;6127.509799216052;6243.282022567463;6289.654069026156;6293;6301.779437719658;1615.6203292226317;1637.124138585851;1637.7870876785942;1638.754186871955;1639.0821140161547;1108.6784832398675;1109.8335249712445;1121.103117505992;1121.377635412354;1131.0386171753944;6031.788887388921;6041.365656606081;6042;6042.003069493484;6046.727897244635;6478.546501744832;6478.935210647834;6482;6489.448396886223;6505.902411463831;5809.738561764731;5876.970615146983;5937;6075.75696972125;6085;3493.0917961330238;3511.0520159556777;3518.964810351864;3521;3522.7181825453904;6630.104935833697;6639.070530125786;6641.601503909781;6642.368974947372;6646.401823835781;6531.8693626127215;6665.933340666628;6668.266490686021;6670.899936500957;6699.425634975777;6574.079628851964;6586.04502347157;6588.374104460068;6588.769393071316;6618.768343107872;6465.450436712932;6475.611463312216;6476.898927182485;6482.902756458751;6489.318621544669;6275.278342990432;6428.100065990671;6428.55000149985;6437.130987316652;6451.0645956337;6592.736290548324;6639.103720997604;6647.7008534617025;6649.235337936006;6653.334666533308;4369.868903932887;4377.978110109557;4386.122775444987;4397.912041759211;4400.713953593006;6360.93639063622;6540.803775886731;6548.8362790930605;6551.344865513411;6557.96721016411;6347.238331400262;6367.808965731036;6373.298937117006;6374.139491168633;6379.457746091634;6358.078078678658;6361.554691171574;6363.490920726424;6371.299157092623;6376.139221205263;6089.421504957022;6226.470749986121;6227.034809604518;6231.22109736283;6233.438990490878;6382.106505089198;6385;6385.764982256173;6386.648734319657;6386.840328991812;6181.443670069715;6186.041163619646;6194.535409844189;6195.845103872439;6199.628022318675 14:12:55 INFO - PROCESS | 20439 | |5;yui.html;763.8243204063066;822.9300509456694;827;844.0715213265405;853.2107800284736;12659.683507912307;12948.935255323733;13044.60866174014;13094.345282735861;13101.67245818855;13100.47598096075;13293.534726284583;13303.534376296831;13686.863131368684;13712.24582647954;828.6146941672137;844.8859403980476;844.9535275559841;846.3863698818338;847.8007668197969;490.14469750285804;493.5557997801971;817.0481389181597;846.327169899931;847.6143354773594;876.6361959786681;878.7627340618061;882.8057827277988;882.867569864519;883.6112110671316;506.7516916710785;512.3032675561234;877.4428238068808;877.4954401219325;878.9121087891192;627.1220291591808;648.627039452312;649.2695717318018;649.4641920415676;650.0152269311997;12911.418986145552;13030.263644634639;13158.144720593227;13180.406881690347;13352.666183345396;11088.168387370899;11195.104391648649;11667.6499705009;11977;12576.930960868338;9920.603175872957;9982.700518984442;10043.19654427644;10211.693649190536;10243.28297019209;3493.9650603494147;3607.1162565171703;3637.9636203638156;3639.508666330038;3643.4716966039778;44794.10411791746;44962.10075798498;46552.30171547429;48113.75943120332;48151.27773083407;9537.284703647116;9793.118619324296;9881.703548893545;10012;10279.126274266622;15475.84524154744;15499.5350139496;15514.301856416489;15523.84476155224;15563.688726225411;7131.857362852714;7132.750353737698;7208.35124838767;7295.817604559928;7554.471187016966;4245.426867372865;4255.744655320691;4262.829486820492;4306.181825453154;4313.956860431355;3071.66211716711;3072.585200997881;3076.292452735883;3085.7531397488146;3120.5475206095443;596.2665920917209;603.3453702732496;604.241676695744;605.0198678141351;616.8334549671564;537.887043720823;627;644.4232411991242;648.2156590525423;679.7484930575719;7627.847443051219;7773.922260777433;8026.117127116013;8081.919180808234;8144.429889907649;484.1019908070549;535.6919771131537;615.0773839241139;639.8656282180701;654.653033892038;3690.2250527389547;3803.2583646188727;3848.3265428549894;3989.860354887565;4022.778747168934;47555.76222118867;47609;47731.28403073957;47744.28383574249;50355;45404.77297613491;45581.772091139996;45993.77003114963;46062.30906536405;46131.53868461272;41451.58548414538;41749.79125104416;41808.58191418047;41944.370834437505;42406.78796606059;7660.80847978805;8013.2387423194705;8106.47307924983;8191.631376587949;8347.666093356198;31173.53239701361;31650.208744780644;31948.20129496781;32258.516122258654;32652.34695306033;37457.81271093627;38160;38511.61488385192;41223.1755364897;41322.380164296956;10350.13677607095;10759.13926885863;10844;11013.2841365311;11308.604198853001;11863.940680296544;11931.623422107452;12112.515499379926;12211.75576488483;12525.436355363849;10849.457527123453;10933.507992140214;11112.555497779998;11253.943730281624;11504.424778761197;10771.030607245386;10889.618863339745;11373.943130284295;11374.31754094757;11756.412179391167;7013.789586312419;8874.201321881063;9123.087691230823;9751.902480975099;10151.492425378554;8978.86531702012;9007.954960225157;9161.450312981242;9254.012279592178;9713.417194968324;9178.403403778733;9601.183899368632;9634.759131021781;9658.420494770337;9856.260780441638 14:12:55 INFO - PROCESS | 20439 | __end_tp_report 14:12:55 INFO - PROCESS | 20439 | __start_cc_report 14:12:55 INFO - PROCESS | 20439 | _x_x_mozilla_cycle_collect,1153 14:12:55 INFO - PROCESS | 20439 | __end_cc_report 14:12:55 INFO - PROCESS | 20439 | __startTimestamp1450822374994__endTimestamp 14:12:55 INFO - PROCESS | 20439 | 14:12:55 INFO - PROCESS | 20439 | ------- Summary: start ------- 14:12:55 INFO - PROCESS | 20439 | Number of tests: 6 14:12:55 INFO - PROCESS | 20439 | 14:12:55 INFO - PROCESS | 20439 | [#0] dojo.html Cycles:165 Average:5296.02 Median:5515.72 stddev:579.13 (10.5%) stddev-sans-first:554.65 14:12:55 INFO - PROCESS | 20439 | Values: 3098.5 3158.1 3208.0 3208.2 3228.1 5119.0 5235.0 5272.1 5293.2 5316.8 5282.6 5339.0 5370.0 5402.9 5422.8 4784.6 4816.3 4947.3 5029.5 5051.4 4935.7 4945.9 4956.1 5037.1 5071.7 4742.1 4780.6 4818.9 4838.9 4866.6 4829.8 4835.0 4837.5 4859.0 4881.8 4777.0 4835.4 4838.8 4856.1 4891.9 5039.4 5066.2 5067.0 5122.7 5150.2 5661.8 5749.4 5749.7 5750.7 5754.9 5595.2 5716.6 5732.5 5733.6 5734.3 5300.7 5301.2 5324.4 5374.9 5412.2 5882.2 5888.1 5906.9 5911.6 5970.9 5380.1 5679.8 5686.0 5690.7 5696.5 5508.3 5551.7 5668.2 5786.7 5825.2 5603.9 5650.3 5656.5 5657.5 5662.1 5633.2 5662.6 5668.6 5670.8 5676.0 4357.0 4427.2 4431.4 4440.6 4441.0 3916.2 3916.6 3933.1 3952.5 3965.2 5350.9 5363.0 5363.4 5367.7 5406.1 5537.4 5572.3 5597.4 5660.3 5716.0 5413.7 5422.2 5422.2 5457.8 5482.1 4890.6 4890.9 4891.9 4904.5 4916.9 5657.6 5794.9 5873.2 5878.6 5882.3 5596.2 5663.3 5696.5 5747.8 5780.0 5704.7 5818.5 5827.4 5834.8 5835.9 5588.5 5661.7 5662.7 5664.5 5673.5 5558.3 5661.9 5681.3 5682.9 5689.5 5495.2 5515.7 5526.2 5634.4 5647.7 5618.2 5664.3 5675.7 5685.1 5685.4 5543.3 5559.0 5565.5 5565.9 5610.6 5406.6 5536.3 5544.3 5603.4 5681.4 5503.9 5511.8 5514.7 5517.9 5575.4 14:12:55 INFO - PROCESS | 20439 | 14:12:55 INFO - PROCESS | 20439 | [#1] ext.html Cycles:180 Average:45209.91 Median:29489.85 stddev:75622.61 (256.4%) stddev-sans-first:75760.47 14:12:55 INFO - PROCESS | 20439 | Values: 568.2 572.8 575.9 598.6 605.6 26472.0 38726.4 39173.4 39181.2 39201.8 42012.2 42318.8 42512.8 42516.8 42558.0 7289.9 7393.5 8686.8 8864.2 10006.4 10214.2 10276.1 10371.3 10377.3 10384.9 10083.6 10168.7 10170.1 10178.6 10183.7 7438.9 7629.1 10399.6 10626.1 10645.7 10162.8 10292.6 10296.8 10300.9 10305.5 39009.2 39466.6 39494.0 39554.0 39570.4 3279.8 3317.4 3631.6 3681.7 4083.5 29113.6 29263.4 29347.9 29488.0 29873.7 3844.1 3916.8 3928.7 4017.7 4038.4 264860.0 265823.0 267724.0 268748.0 270070.0 57295.0 57589.7 57625.0 57636.7 57678.4 46381.5 47643.3 66021.7 67604.7 67778.3 14938.8 15058.1 15193.2 15241.3 15245.5 10901.1 10904.8 10963.3 11042.0 11060.0 18994.1 19074.8 19257.0 19263.1 19303.8 7788.0 7970.1 8002.5 8054.6 8069.6 1000.3 1056.1 1087.9 1090.2 1091.2 27653.4 28224.0 28682.1 28910.6 29108.6 974.9 987.1 1035.1 1094.2 1113.5 14085.5 15053.2 15223.8 15340.0 15535.6 308250.0 313892.0 313936.0 314162.0 314608.0 49793.8 49984.8 50119.7 50129.5 50257.0 1368.4 1369.1 1370.5 1380.0 1389.8 27481.5 28270.3 28289.7 28300.0 28585.0 43782.3 44084.6 44164.8 44169.6 44173.8 285265.0 285467.0 285626.0 286966.0 287053.0 23034.7 24534.8 25441.5 29491.7 31111.8 37637.8 38791.2 39012.0 39311.0 39718.8 31604.0 32833.8 33198.0 33414.5 33446.8 28192.3 31624.5 36216.8 37681.8 38007.2 31710.4 32062.7 32064.4 32070.5 34486.3 26673.0 28218.7 28903.9 28980.1 29081.0 22676.0 22930.7 23900.4 24033.0 24583.1 14:12:55 INFO - PROCESS | 20439 | 14:12:55 INFO - PROCESS | 20439 | [#2] jquery.html Cycles:180 Average:29902.91 Median:18656.62 stddev:96056.69 (514.9%) stddev-sans-first:96300.55 14:12:55 INFO - PROCESS | 20439 | Values: 369.3 369.7 369.8 370.2 370.6 12938.2 12939.0 16616.5 17667.1 18414.2 12190.0 14707.3 15003.5 15009.1 15111.5 5352.1 5485.9 5495.6 5496.1 5497.3 3741.5 3824.8 5066.0 5249.1 5461.8 5368.0 5393.3 5400.7 5407.0 5407.1 5383.8 5389.2 5592.7 5915.3 5920.8 5246.5 5251.1 5255.2 5255.7 5259.7 11916.4 18515.0 18878.9 19138.0 19703.7 2045.6 2100.9 2130.6 2156.4 2252.4 9403.0 9583.4 9719.5 10656.8 12600.3 1680.4 1842.6 1848.3 1851.6 1877.7 59234.0 59750.4 59828.7 62976.4 64212.7 9868.7 9956.9 10050.6 10099.2 10152.6 12978.7 13027.4 13125.0 13140.9 13161.7 7324.0 7353.5 7362.1 7460.3 7473.4 6974.0 7003.1 7095.1 7097.5 7117.8 4206.3 4294.9 4309.9 4351.3 4356.1 1603.5 1643.3 1719.9 1766.5 1806.4 818.9 860.6 941.6 1016.0 1045.9 16057.9 16187.5 17208.4 17564.4 17836.8 827.4 892.8 930.1 934.4 1019.1 8517.4 9578.3 9619.2 9717.5 9951.2 569612.0 572564.0 594789.0 598559.0 603285.0 77103.0 80160.0 80240.6 80487.6 82384.0 1096.1 1102.0 1185.1 1188.5 1207.5 15593.6 15631.0 15673.0 15839.9 15973.4 35558.5 35682.5 35742.6 36577.1 36943.1 46385.3 46636.5 46796.8 47705.5 47765.8 9399.2 9461.8 9556.4 9668.6 9673.0 11305.4 11414.5 11544.4 11559.6 11578.4 10360.9 11401.9 14387.6 14727.5 14870.3 13698.4 13847.6 14257.4 14679.6 14779.3 14249.2 14383.1 14481.3 14626.1 14717.3 9341.3 9359.6 9395.0 9511.5 9713.9 11548.3 14760.0 14800.6 15019.4 15105.8 14:12:55 INFO - PROCESS | 20439 | 14:12:55 INFO - PROCESS | 20439 | [#3] mootools.html Cycles:180 Average:5466.26 Median:6390.33 stddev:2823.48 (44.2%) stddev-sans-first:2814.00 14:12:55 INFO - PROCESS | 20439 | Values: 1296.4 1703.2 1735.0 1748.1 1786.6 6444.8 7676.2 7835.9 7845.5 7864.1 7454.3 7647.1 7657.6 7661.5 7664.3 1955.3 2016.4 2019.5 2269.4 2314.5 2041.3 2258.3 2293.2 2304.8 2307.8 2249.7 2272.6 2282.6 2283.4 2314.6 2206.0 2222.5 2234.5 2234.5 2236.1 2300.0 2330.5 2331.1 2333.9 2334.3 7840.3 7914.9 7915.1 7915.8 7921.9 4662.3 4756.8 4768.8 4769.7 4772.3 3057.7 3089.7 3144.7 3175.4 3185.7 1037.2 1104.1 1106.8 1112.9 1121.8 10813.7 10895.7 10895.8 10933.2 10940.0 4199.9 4279.7 4305.0 4336.7 4356.8 9240.5 9250.1 9263.0 9269.5 9287.6 4760.1 4761.0 4780.6 4781.0 4792.2 4355.8 4366.0 4367.2 4369.7 4372.3 3219.3 3710.6 3767.7 3781.6 3786.4 1083.3 1180.8 1212.6 1215.8 1221.8 1034.4 1052.1 1087.8 1302.8 1304.8 7159.3 7248.5 7343.8 7356.5 7359.0 1109.6 1111.7 1133.0 1137.9 1140.8 5678.0 5760.7 5764.9 5769.5 5769.9 8847.6 9002.0 9285.3 9289.3 9290.2 9112.7 9203.7 9225.4 9229.2 9233.8 7101.7 7248.2 7256.1 7313.9 7318.7 7289.4 7345.4 7385.2 7437.6 7447.7 8234.5 8486.9 8624.8 8640.4 8671.0 8811.3 8825.6 8834.8 8849.4 8850.2 6598.6 6879.6 6881.6 6883.8 6892.8 6799.8 6936.6 7550.3 7588.9 7608.3 6775.4 6853.8 6908.0 6936.2 7009.9 6695.6 6757.3 6800.1 6845.1 6899.8 7109.6 7148.6 7152.2 7154.1 7157.4 6417.6 6420.9 6476.3 6484.7 6489.9 6387.0 6393.6 6394.5 6411.8 6415.8 14:12:55 INFO - PROCESS | 20439 | 14:12:55 INFO - PROCESS | 20439 | [#4] prototype.html Cycles:180 Average:5270.10 Median:5924.90 stddev:1565.07 (26.4%) stddev-sans-first:1524.80 14:12:55 INFO - PROCESS | 20439 | Values: 324.3 335.2 338.6 340.3 343.1 5857.9 5897.6 5903.5 5912.8 5948.1 5571.3 5662.3 5785.9 5869.8 5882.4 4577.5 4580.4 4602.3 4621.2 4622.4 4357.9 4588.2 4589.2 4591.2 4595.2 4392.9 4417.8 4518.8 4523.4 4555.3 4574.5 4575.0 4575.1 4579.2 4582.4 4030.4 4034.2 4044.8 4046.8 4050.5 5507.9 5626.3 5629.8 5631.2 5634.2 5316.6 5319.8 5323.5 5325.9 5333.2 6248.9 6266.7 6268.0 6274.7 6276.2 4474.6 4476.6 4477.5 4482.4 4493.9 6372.7 6540.3 6543.9 6548.8 6563.3 4567.8 4569.0 4570.4 4572.4 4572.4 4625.1 4626.0 4628.3 4631.6 4635.9 5273.0 5277.9 5281.1 5287.7 5297.1 6127.5 6243.3 6289.7 6293.0 6301.8 1615.6 1637.1 1637.8 1638.8 1639.1 1108.7 1109.8 1121.1 1121.4 1131.0 6031.8 6041.4 6042.0 6042.0 6046.7 6478.5 6478.9 6482.0 6489.4 6505.9 5809.7 5877.0 5937.0 6075.8 6085.0 3493.1 3511.1 3519.0 3521.0 3522.7 6630.1 6639.1 6641.6 6642.4 6646.4 6531.9 6665.9 6668.3 6670.9 6699.4 6574.1 6586.0 6588.4 6588.8 6618.8 6465.5 6475.6 6476.9 6482.9 6489.3 6275.3 6428.1 6428.6 6437.1 6451.1 6592.7 6639.1 6647.7 6649.2 6653.3 4369.9 4378.0 4386.1 4397.9 4400.7 6360.9 6540.8 6548.8 6551.3 6558.0 6347.2 6367.8 6373.3 6374.1 6379.5 6358.1 6361.6 6363.5 6371.3 6376.1 6089.4 6226.5 6227.0 6231.2 6233.4 6382.1 6385.0 6385.8 6386.6 6386.8 6181.4 6186.0 6194.5 6195.8 6199.6 14:12:55 INFO - PROCESS | 20439 | 14:12:55 INFO - PROCESS | 20439 | [#5] yui.html Cycles:180 Average:12724.47 Median:46028.04 stddev:14181.22 (30.8%) stddev-sans-first:14192.56 14:12:55 INFO - PROCESS | 20439 | Values: 763.8 822.9 827.0 844.1 853.2 12659.7 12948.9 13044.6 13094.3 13101.7 13100.5 13293.5 13303.5 13686.9 13712.2 828.6 844.9 845.0 846.4 847.8 490.1 493.6 817.0 846.3 847.6 876.6 878.8 882.8 882.9 883.6 506.8 512.3 877.4 877.5 878.9 627.1 648.6 649.3 649.5 650.0 12911.4 13030.3 13158.1 13180.4 13352.7 11088.2 11195.1 11667.6 11977.0 12576.9 9920.6 9982.7 10043.2 10211.7 10243.3 3494.0 3607.1 3638.0 3639.5 3643.5 44794.1 44962.1 46552.3 48113.8 48151.3 9537.3 9793.1 9881.7 10012.0 10279.1 15475.8 15499.5 15514.3 15523.8 15563.7 7131.9 7132.8 7208.4 7295.8 7554.5 4245.4 4255.7 4262.8 4306.2 4314.0 3071.7 3072.6 3076.3 3085.8 3120.5 596.3 603.3 604.2 605.0 616.8 537.9 627.0 644.4 648.2 679.7 7627.8 7773.9 8026.1 8081.9 8144.4 484.1 535.7 615.1 639.9 654.7 3690.2 3803.3 3848.3 3989.9 4022.8 47555.8 47609.0 47731.3 47744.3 50355.0 45404.8 45581.8 45993.8 46062.3 46131.5 41451.6 41749.8 41808.6 41944.4 42406.8 7660.8 8013.2 8106.5 8191.6 8347.7 31173.5 31650.2 31948.2 32258.5 32652.3 37457.8 38160.0 38511.6 41223.2 41322.4 10350.1 10759.1 10844.0 11013.3 11308.6 11863.9 11931.6 12112.5 12211.8 12525.4 10849.5 10933.5 11112.6 11253.9 11504.4 10771.0 10889.6 11373.9 11374.3 11756.4 7013.8 8874.2 9123.1 9751.9 10151.5 8978.9 9008.0 9161.5 9254.0 9713.4 9178.4 9601.2 9634.8 9658.4 9856.3 14:12:55 INFO - PROCESS | 20439 | -------- Summary: end -------- 14:12:55 INFO - PROCESS | 20439 | 14:12:55 INFO - TEST-INFO | 20439: exit 0 14:12:55 INFO - TEST-OK | dromaeo_css | took 1112921ms 14:12:55 INFO - TEST-START | kraken 14:12:55 INFO - operating with platform_type : linux_ 14:12:55 INFO - Initialising browser for kraken test... 14:12:55 INFO - TEST-INFO | started process 20629 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaxxIDm/profile http://localhost:40511/getInfo.html) 14:12:59 INFO - PROCESS | 20629 | __metrics Screen width/height:1600/1200 14:12:59 INFO - PROCESS | 20629 | colorDepth:24 14:12:59 INFO - PROCESS | 20629 | Browser inner width/height: 1024/697 14:12:59 INFO - PROCESS | 20629 | __metrics 14:12:59 INFO - PROCESS | 20629 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:12:59 INFO - PROCESS | 20629 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:13:00 INFO - TEST-INFO | 20629: exit 0 14:13:00 INFO - Browser initialized. 14:13:00 INFO - Running cycle 1/1 for kraken test... 14:13:00 INFO - TEST-INFO | started process 20712 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaxxIDm/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:13:12 INFO - PROCESS | 20712 | RSS: Main: 151183360 14:13:12 INFO - PROCESS | 20712 | 14:13:15 INFO - PROCESS | 20712 | Cycle 1(1): loaded http://localhost:40511/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40511/tests/kraken/driver.html?testName=audio-beat-detection) 14:13:15 INFO - PROCESS | 20712 | RSS: Main: 185999360 14:13:15 INFO - PROCESS | 20712 | 14:13:18 INFO - PROCESS | 20712 | Cycle 1(1): loaded http://localhost:40511/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40511/tests/kraken/driver.html?testName=audio-dft) 14:13:18 INFO - PROCESS | 20712 | RSS: Main: 176599040 14:13:18 INFO - PROCESS | 20712 | 14:13:21 INFO - PROCESS | 20712 | Cycle 1(1): loaded http://localhost:40511/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40511/tests/kraken/driver.html?testName=audio-fft) 14:13:22 INFO - PROCESS | 20712 | RSS: Main: 160718848 14:13:22 INFO - PROCESS | 20712 | 14:13:24 INFO - PROCESS | 20712 | Cycle 1(1): loaded http://localhost:40511/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40511/tests/kraken/driver.html?testName=audio-oscillator) 14:13:24 INFO - PROCESS | 20712 | RSS: Main: 164659200 14:13:24 INFO - PROCESS | 20712 | 14:13:26 INFO - PROCESS | 20712 | Cycle 1(1): loaded http://localhost:40511/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40511/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:13:27 INFO - PROCESS | 20712 | RSS: Main: 166252544 14:13:27 INFO - PROCESS | 20712 | 14:13:30 INFO - PROCESS | 20712 | Cycle 1(1): loaded http://localhost:40511/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40511/tests/kraken/driver.html?testName=imaging-darkroom) 14:13:30 INFO - PROCESS | 20712 | RSS: Main: 165175296 14:13:30 INFO - PROCESS | 20712 | 14:13:34 INFO - PROCESS | 20712 | Cycle 1(1): loaded http://localhost:40511/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40511/tests/kraken/driver.html?testName=imaging-desaturate) 14:13:34 INFO - PROCESS | 20712 | RSS: Main: 165998592 14:13:34 INFO - PROCESS | 20712 | 14:13:37 INFO - PROCESS | 20712 | Cycle 1(1): loaded http://localhost:40511/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40511/tests/kraken/driver.html?testName=json-parse-financial) 14:13:38 INFO - PROCESS | 20712 | RSS: Main: 164474880 14:13:38 INFO - PROCESS | 20712 | 14:13:39 INFO - PROCESS | 20712 | Cycle 1(1): loaded http://localhost:40511/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40511/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:13:40 INFO - PROCESS | 20712 | RSS: Main: 178483200 14:13:40 INFO - PROCESS | 20712 | 14:13:42 INFO - PROCESS | 20712 | Cycle 1(1): loaded http://localhost:40511/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40511/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:13:42 INFO - PROCESS | 20712 | RSS: Main: 174624768 14:13:42 INFO - PROCESS | 20712 | 14:13:44 INFO - PROCESS | 20712 | Cycle 1(1): loaded http://localhost:40511/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40511/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:13:45 INFO - PROCESS | 20712 | RSS: Main: 188215296 14:13:45 INFO - PROCESS | 20712 | 14:13:47 INFO - PROCESS | 20712 | Cycle 1(1): loaded http://localhost:40511/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40511/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:13:48 INFO - PROCESS | 20712 | RSS: Main: 196009984 14:13:48 INFO - PROCESS | 20712 | 14:13:50 INFO - PROCESS | 20712 | Cycle 1(1): loaded http://localhost:40511/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40511/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:13:51 INFO - PROCESS | 20712 | RSS: Main: 193691648 14:13:51 INFO - PROCESS | 20712 | 14:13:53 INFO - PROCESS | 20712 | Cycle 1(1): loaded http://localhost:40511/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40511/tests/kraken/driver.html?testName=ai-astar) 14:13:53 INFO - PROCESS | 20712 | RSS: Main: 251850752 14:13:53 INFO - PROCESS | 20712 | 14:13:53 INFO - PROCESS | 20712 | __start_tp_report 14:13:53 INFO - PROCESS | 20712 | _x_x_mozilla_page_load 14:13:53 INFO - PROCESS | 20712 | _x_x_mozilla_page_load_details 14:13:53 INFO - PROCESS | 20712 | |i|pagename|runs| 14:13:53 INFO - PROCESS | 20712 | |0;ai-astar;108;110;104;110;110;111;101;109;110;115 14:13:53 INFO - PROCESS | 20712 | |1;audio-beat-detection;145;124;149;159;123;150;150;124;173;129 14:13:53 INFO - PROCESS | 20712 | |2;audio-dft;162;159;160;159;160;160;159;163;161;161 14:13:53 INFO - PROCESS | 20712 | |3;audio-fft;75;73;84;96;73;73;72;126;92;72 14:13:53 INFO - PROCESS | 20712 | |4;audio-oscillator;93;94;139;93;94;94;138;92;93;135 14:13:53 INFO - PROCESS | 20712 | |5;imaging-gaussian-blur;110;109;109;110;109;110;110;109;109;109 14:13:53 INFO - PROCESS | 20712 | |6;imaging-darkroom;145;146;145;145;145;145;145;145;146;145 14:13:53 INFO - PROCESS | 20712 | |7;imaging-desaturate;96;96;96;96;95;95;95;96;96;95 14:13:53 INFO - PROCESS | 20712 | |8;json-parse-financial;60;58;57;59;61;57;58;65;54;56 14:13:53 INFO - PROCESS | 20712 | |9;json-stringify-tinderbox;67;66;66;67;67;67;67;70;67;73 14:13:53 INFO - PROCESS | 20712 | |10;stanford-crypto-aes;84;84;85;85;84;85;85;84;85;84 14:13:53 INFO - PROCESS | 20712 | |11;stanford-crypto-ccm;117;126;118;115;128;125;132;116;124;113 14:13:53 INFO - PROCESS | 20712 | |12;stanford-crypto-pbkdf2;145;154;160;154;155;142;152;159;153;144 14:13:53 INFO - PROCESS | 20712 | |13;stanford-crypto-sha256-iterative;70;66;69;67;71;66;66;68;66;68 14:13:53 INFO - PROCESS | 20712 | __end_tp_report 14:13:53 INFO - PROCESS | 20712 | __start_cc_report 14:13:53 INFO - PROCESS | 20712 | _x_x_mozilla_cycle_collect,936 14:13:53 INFO - PROCESS | 20712 | __end_cc_report 14:13:53 INFO - PROCESS | 20712 | __startTimestamp1450822433463__endTimestamp 14:13:53 INFO - PROCESS | 20712 | 14:13:53 INFO - PROCESS | 20712 | ------- Summary: start ------- 14:13:53 INFO - PROCESS | 20712 | Number of tests: 14 14:13:53 INFO - PROCESS | 20712 | 14:13:53 INFO - PROCESS | 20712 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.00 stddev:3.85 (3.5%) stddev-sans-first:4.08 14:13:53 INFO - PROCESS | 20712 | Values: 108.0 110.0 104.0 110.0 110.0 111.0 101.0 109.0 110.0 115.0 14:13:53 INFO - PROCESS | 20712 | 14:13:53 INFO - PROCESS | 20712 | [#1] audio-beat-detection Cycles:10 Average:142.60 Median:149.50 stddev:17.03 (11.4%) stddev-sans-first:18.04 14:13:53 INFO - PROCESS | 20712 | Values: 145.0 124.0 149.0 159.0 123.0 150.0 150.0 124.0 173.0 129.0 14:13:53 INFO - PROCESS | 20712 | 14:13:53 INFO - PROCESS | 20712 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:1.35 (0.8%) stddev-sans-first:1.30 14:13:53 INFO - PROCESS | 20712 | Values: 162.0 159.0 160.0 159.0 160.0 160.0 159.0 163.0 161.0 161.0 14:13:53 INFO - PROCESS | 20712 | 14:13:53 INFO - PROCESS | 20712 | [#3] audio-fft Cycles:10 Average:83.60 Median:74.00 stddev:17.33 (23.4%) stddev-sans-first:18.10 14:13:53 INFO - PROCESS | 20712 | Values: 75.0 73.0 84.0 96.0 73.0 73.0 72.0 126.0 92.0 72.0 14:13:53 INFO - PROCESS | 20712 | 14:13:53 INFO - PROCESS | 20712 | [#4] audio-oscillator Cycles:10 Average:106.50 Median:93.00 stddev:21.31 (22.9%) stddev-sans-first:22.03 14:13:53 INFO - PROCESS | 20712 | Values: 93.0 94.0 139.0 93.0 94.0 94.0 138.0 92.0 93.0 135.0 14:13:53 INFO - PROCESS | 20712 | 14:13:53 INFO - PROCESS | 20712 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 14:13:53 INFO - PROCESS | 20712 | Values: 110.0 109.0 109.0 110.0 109.0 110.0 110.0 109.0 109.0 109.0 14:13:53 INFO - PROCESS | 20712 | 14:13:53 INFO - PROCESS | 20712 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 14:13:53 INFO - PROCESS | 20712 | Values: 145.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 14:13:53 INFO - PROCESS | 20712 | 14:13:53 INFO - PROCESS | 20712 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 14:13:53 INFO - PROCESS | 20712 | Values: 96.0 96.0 96.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 14:13:53 INFO - PROCESS | 20712 | 14:13:53 INFO - PROCESS | 20712 | [#8] json-parse-financial Cycles:10 Average:58.50 Median:58.50 stddev:3.03 (5.2%) stddev-sans-first:3.16 14:13:53 INFO - PROCESS | 20712 | Values: 60.0 58.0 57.0 59.0 61.0 57.0 58.0 65.0 54.0 56.0 14:13:53 INFO - PROCESS | 20712 | 14:13:53 INFO - PROCESS | 20712 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:67.00 stddev:2.16 (3.2%) stddev-sans-first:2.28 14:13:53 INFO - PROCESS | 20712 | Values: 67.0 66.0 66.0 67.0 67.0 67.0 67.0 70.0 67.0 73.0 14:13:53 INFO - PROCESS | 20712 | 14:13:53 INFO - PROCESS | 20712 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:85.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 14:13:53 INFO - PROCESS | 20712 | Values: 84.0 84.0 85.0 85.0 84.0 85.0 85.0 84.0 85.0 84.0 14:13:53 INFO - PROCESS | 20712 | 14:13:53 INFO - PROCESS | 20712 | [#11] stanford-crypto-ccm Cycles:10 Average:121.40 Median:124.50 stddev:6.40 (5.1%) stddev-sans-first:6.58 14:13:53 INFO - PROCESS | 20712 | Values: 117.0 126.0 118.0 115.0 128.0 125.0 132.0 116.0 124.0 113.0 14:13:53 INFO - PROCESS | 20712 | 14:13:53 INFO - PROCESS | 20712 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.80 Median:154.00 stddev:6.18 (4.0%) stddev-sans-first:6.04 14:13:53 INFO - PROCESS | 20712 | Values: 145.0 154.0 160.0 154.0 155.0 142.0 152.0 159.0 153.0 144.0 14:13:53 INFO - PROCESS | 20712 | 14:13:53 INFO - PROCESS | 20712 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.83 (2.7%) stddev-sans-first:1.74 14:13:53 INFO - PROCESS | 20712 | Values: 70.0 66.0 69.0 67.0 71.0 66.0 66.0 68.0 66.0 68.0 14:13:53 INFO - PROCESS | 20712 | -------- Summary: end -------- 14:13:53 INFO - PROCESS | 20712 | 14:13:54 INFO - TEST-INFO | 20712: exit 0 14:13:54 INFO - TEST-OK | kraken | took 58567ms 14:13:54 INFO - TEST-START | v8_7 14:13:54 INFO - operating with platform_type : linux_ 14:13:54 INFO - Initialising browser for v8_7 test... 14:13:54 INFO - TEST-INFO | started process 20963 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8IxP1R/profile http://localhost:40511/getInfo.html) 14:13:58 INFO - PROCESS | 20963 | __metrics Screen width/height:1600/1200 14:13:58 INFO - PROCESS | 20963 | colorDepth:24 14:13:58 INFO - PROCESS | 20963 | Browser inner width/height: 1024/697 14:13:58 INFO - PROCESS | 20963 | __metrics 14:13:58 INFO - PROCESS | 20963 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:13:58 INFO - PROCESS | 20963 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:13:59 INFO - TEST-INFO | 20963: exit 0 14:13:59 INFO - Browser initialized. 14:13:59 INFO - Running cycle 1/1 for v8_7 test... 14:13:59 INFO - TEST-INFO | started process 21047 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8IxP1R/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:14:11 INFO - PROCESS | 21047 | RSS: Main: 149520384 14:14:11 INFO - PROCESS | 21047 | 14:14:32 INFO - PROCESS | 21047 | Cycle 1(1): loaded http://localhost:40511/tests/v8_7/run.html (next: http://localhost:40511/tests/v8_7/run.html) 14:14:32 INFO - PROCESS | 21047 | RSS: Main: 554983424 14:14:32 INFO - PROCESS | 21047 | 14:14:32 INFO - PROCESS | 21047 | __start_tp_report 14:14:32 INFO - PROCESS | 21047 | _x_x_mozilla_page_load 14:14:32 INFO - PROCESS | 21047 | _x_x_mozilla_page_load_details 14:14:32 INFO - PROCESS | 21047 | |i|pagename|runs| 14:14:32 INFO - PROCESS | 21047 | |0;Richards;165.92002654720426 14:14:32 INFO - PROCESS | 21047 | |1;DeltaBlue;188.32391713747646 14:14:32 INFO - PROCESS | 21047 | |2;Encrypt;279.72027972027973 14:14:32 INFO - PROCESS | 21047 | |3;Decrypt;5196.891191709845 14:14:32 INFO - PROCESS | 21047 | |4;RayTrace;1951.2670565302144 14:14:32 INFO - PROCESS | 21047 | |5;Earley;786.7820613690008 14:14:32 INFO - PROCESS | 21047 | |6;Boyer;12108.43373493976 14:14:32 INFO - PROCESS | 21047 | |7;RegExp;25743.589743589742 14:14:32 INFO - PROCESS | 21047 | |8;Splay;574.052812858783 14:14:32 INFO - PROCESS | 21047 | |9;NavierStokes;4822.115384615385 14:14:32 INFO - PROCESS | 21047 | __end_tp_report 14:14:32 INFO - PROCESS | 21047 | __startTimestamp1450822472825__endTimestamp 14:14:32 INFO - PROCESS | 21047 | 14:14:32 INFO - PROCESS | 21047 | ------- Summary: start ------- 14:14:32 INFO - PROCESS | 21047 | Number of tests: 10 14:14:32 INFO - PROCESS | 21047 | 14:14:32 INFO - PROCESS | 21047 | [#0] Richards Cycles:1 Average:165.92 Median:165.92 stddev:0.00 (0.0%) 14:14:32 INFO - PROCESS | 21047 | Values: 165.9 14:14:32 INFO - PROCESS | 21047 | 14:14:32 INFO - PROCESS | 21047 | [#1] DeltaBlue Cycles:1 Average:188.32 Median:188.32 stddev:0.00 (0.0%) 14:14:32 INFO - PROCESS | 21047 | Values: 188.3 14:14:32 INFO - PROCESS | 21047 | 14:14:32 INFO - PROCESS | 21047 | [#2] Encrypt Cycles:1 Average:279.72 Median:279.72 stddev:0.00 (0.0%) 14:14:32 INFO - PROCESS | 21047 | Values: 279.7 14:14:32 INFO - PROCESS | 21047 | 14:14:32 INFO - PROCESS | 21047 | [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 14:14:32 INFO - PROCESS | 21047 | Values: 5196.9 14:14:32 INFO - PROCESS | 21047 | 14:14:32 INFO - PROCESS | 21047 | [#4] RayTrace Cycles:1 Average:1951.27 Median:1951.27 stddev:0.00 (0.0%) 14:14:32 INFO - PROCESS | 21047 | Values: 1951.3 14:14:32 INFO - PROCESS | 21047 | 14:14:32 INFO - PROCESS | 21047 | [#5] Earley Cycles:1 Average:786.78 Median:786.78 stddev:0.00 (0.0%) 14:14:32 INFO - PROCESS | 21047 | Values: 786.8 14:14:32 INFO - PROCESS | 21047 | 14:14:32 INFO - PROCESS | 21047 | [#6] Boyer Cycles:1 Average:12108.43 Median:12108.43 stddev:0.00 (0.0%) 14:14:32 INFO - PROCESS | 21047 | Values: 12108.4 14:14:32 INFO - PROCESS | 21047 | 14:14:32 INFO - PROCESS | 21047 | [#7] RegExp Cycles:1 Average:25743.59 Median:25743.59 stddev:0.00 (0.0%) 14:14:32 INFO - PROCESS | 21047 | Values: 25743.6 14:14:32 INFO - PROCESS | 21047 | 14:14:32 INFO - PROCESS | 21047 | [#8] Splay Cycles:1 Average:574.05 Median:574.05 stddev:0.00 (0.0%) 14:14:32 INFO - PROCESS | 21047 | Values: 574.1 14:14:32 INFO - PROCESS | 21047 | 14:14:32 INFO - PROCESS | 21047 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 14:14:32 INFO - PROCESS | 21047 | Values: 4822.1 14:14:32 INFO - PROCESS | 21047 | -------- Summary: end -------- 14:14:32 INFO - PROCESS | 21047 | 14:14:33 INFO - TEST-INFO | 21047: exit 0 14:14:33 INFO - TEST-OK | v8_7 | took 39374ms 14:14:33 INFO - SUITE-END | took 1210s 14:14:33 INFO - Completed test suite (00:20:11) 14:14:33 INFO - Working with test: dromaeo_css 14:14:33 INFO - Generating results file: dromaeo_css 14:14:33 INFO - Working with test: kraken 14:14:33 INFO - Generating results file: kraken 14:14:33 INFO - javascript benchmark 14:14:33 INFO - Working with test: v8_7 14:14:33 INFO - Generating results file: v8_7 14:14:33 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:14:33 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 14:14:33 INFO - process_Request line: dromaeo_css 6898.96 graph.html#tests=[[72,64,35]] 14:14:33 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:14:33 INFO - process_Request line: kraken 1503.70 graph.html#tests=[[232,64,35]] 14:14:33 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:14:33 INFO - process_Request line: v8_7 20019.06 graph.html#tests=[[230,64,35]] 14:14:33 INFO - RETURN: dromaeo_css: 6898.96 14:14:33 INFO - RETURN: kraken: 1503.70 14:14:33 INFO - RETURN: v8_7: 20019.06 14:14:33 INFO - javascript benchmark 14:14:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3098.5042393217086, 3158.1315138336968, 3207.967920320796, 3208.23002479405, 3228.128405330561, 5119.0, 5234.973825130878, 5272.077386457369, 5293.17955716864, 5316.813911513098, 5282.550983166436, 5338.973305133479, 5370.033393989081, 5402.864928376793, 5422.783088676458, 4784.641151913603, 4816.253480710496, 4947.332110165135, 5029.497050294978, 5051.3938327400765, 4935.6545041847085, 4945.9258111128365, 4956.083124621957, 5037.0681423936685, 5071.670341427795, 4742.146413645542, 4780.569748722597, 4818.927716084227, 4838.854834354957, 4866.635002374836, 4829.806807727687, 4834.975825120887, 4837.467878533358, 4858.951410485885, 4881.755912204376, 4777.0, 4835.371401717789, 4838.782254798507, 4856.05306965142, 4891.902161956777, 5039.395272567315, 5066.240063990394, 5067.037262920034, 5122.692638441706, 5150.201718733602, 5661.801836935688, 5749.425057494217, 5749.683767392792, 5750.683712395817, 5754.942450575482, 5595.244641973363, 5716.628419152783, 5732.455416735404, 5733.598648094635, 5734.254546908917, 5300.734963251861, 5301.151815709506, 5324.41431442541, 5374.91937620936, 5412.188171774226, 5882.205902203234, 5888.087346461305, 5906.940930590639, 5911.586188966731, 5970.880582388328, 5380.112281473591, 5679.829605111853, 5685.971570142123, 5690.658560486384, 5696.544276457874, 5508.283923090053, 5551.666899986014, 5668.234788303609, 5786.681732504669, 5825.2135961644635, 5603.8599035023635, 5650.26546548946, 5656.490915817596, 5657.462541058593, 5662.094064949588, 5633.183188437653, 5662.603617746719, 5668.603197776199, 5670.8015219467125, 5676.035074037423, 4356.956430435655, 4427.247367947457, 4431.379606855043, 4440.62254708347, 4440.956375251813, 3916.177602703407, 3916.6475017248013, 3933.056066544009, 3952.525696916331, 3965.2466031453932, 5350.91973620396, 5363.034653762282, 5363.356397232279, 5367.704776237344, 5406.08096623575, 5537.446255374511, 5572.275604171432, 5597.384287728347, 5660.264165658438, 5715.971420142872, 5413.729313534308, 5422.15956526739, 5422.240886275925, 5457.808976685797, 5482.095454250004, 4890.559849613481, 4890.902181956412, 4891.926621100615, 4904.485029071968, 4916.926246106311, 5657.6322539035655, 5794.942050579441, 5873.177755114288, 5878.588498805043, 5882.294124705063, 5596.244506991667, 5663.348714897839, 5696.4588364107, 5747.827565173052, 5780.0, 5704.743286552198, 5818.505427038749, 5827.358990511125, 5834.766609335579, 5835.8832823342445, 5588.469095435927, 5661.66030038199, 5662.688552129673, 5664.518515926193, 5673.5461163107675, 5558.277423934863, 5661.943380566142, 5681.346645135863, 5682.886342273048, 5689.544836412994, 5495.203195536705, 5515.724213789214, 5526.171074338881, 5634.408387119293, 5647.661140331593, 5618.185363122243, 5664.348599911063, 5675.659460432387, 5685.147227915846, 5685.403032681509, 5543.25166102571, 5559.0, 5565.499105080562, 5565.860853478695, 5610.607257491936, 5406.648567843235, 5536.307961504812, 5544.306961629796, 5603.411641777555, 5681.375048744552, 5503.908514764364, 5511.807086751945, 5514.6691198528215, 5517.944820551904, 5575.386707462257], "unit": "score", "name": "dojo.html", "value": 5258.881253583768}, {"lowerIsBetter": false, "replicates": [568.184655020046, 572.8424683212119, 575.9424057594243, 598.625858838226, 605.5700452678598, 26472.0, 38726.41910371343, 39173.41239881404, 39181.21637567247, 39201.803990980006, 42012.159756804926, 42318.78840605792, 42512.787436062856, 42516.78741606288, 42558.0, 7289.890651640229, 7393.482456228066, 8686.826263474743, 8864.246539044158, 10006.449645269508, 10214.233932455058, 10276.075153236206, 10371.274010819208, 10377.273590848643, 10384.896151038507, 10083.596656133746, 10168.678071850649, 10170.135538479239, 10178.643747468841, 10183.6944891653, 7438.851222975537, 7629.084509858797, 10399.636012739593, 10626.14990800734, 10645.733856653567, 10162.847557286646, 10292.639757608522, 10296.845547316796, 10300.89699103007, 10305.484725763681, 39009.219815603814, 39466.60533394658, 39494.0, 39554.0, 39570.40644390336, 3279.803211807275, 3317.3862835375535, 3631.564212294515, 3681.7422780405113, 4083.530394004668, 29113.56329655057, 29263.41473170525, 29347.853260733773, 29488.0, 29873.70126298731, 3844.1350696093436, 3916.7649941003633, 3928.744631598937, 4017.678585713136, 4038.434619153321, 264860.0, 265823.0, 267724.0, 268748.0, 270070.0, 57295.0, 57589.71205143948, 57625.0, 57636.71181644065, 57678.42321576815, 46381.5361846384, 47643.285350719765, 66021.6698916512, 67604.66197669078, 67778.3222167772, 14938.775918361232, 15058.096514209183, 15193.164375959428, 15241.314140863687, 15245.542633721006, 10901.127909767358, 10904.781904362027, 10963.287386319864, 11042.0, 11060.0, 18994.050297485348, 19074.80925190758, 19257.0, 19263.133159007877, 19303.814870546485, 7787.961060194776, 7970.083440404312, 8002.479838810459, 8054.5569993650915, 8069.556174410346, 1000.2947921715319, 1056.1497994114657, 1087.896649818266, 1090.225939582905, 1091.170710260208, 27653.44693106167, 28224.0, 28682.13953581396, 28910.566341504895, 29108.563371549444, 974.8878878929014, 987.1214618988962, 1035.1098055672267, 1094.1684319916762, 1113.4711012269108, 14085.507007254697, 15053.172075535731, 15223.847761522244, 15340.002899811476, 15535.611609709847, 308250.0, 313892.0, 313936.0, 314162.0, 314608.0, 49793.75103124461, 49984.75007624939, 50119.74940125276, 50129.49870501321, 50257.0, 1368.4457794593206, 1369.0553518072697, 1370.5340184337374, 1379.951701690456, 1389.7637401641746, 27481.45037099207, 28270.293242669097, 28289.71710282953, 28300.0, 28585.0, 43782.34326485042, 44084.559154409326, 44164.77917610391, 44169.55830441783, 44173.77913110414, 285265.0, 285467.0, 285626.0, 286966.0, 287053.0, 23034.654480182475, 24534.754652453248, 25441.491170176123, 29491.705082949753, 31111.84444077765, 37637.81181094077, 38791.22417551577, 39012.0, 39311.0, 39718.80140599279, 31604.0, 32833.835830820695, 33198.0, 33414.498782517796, 33446.832765836014, 28192.29519262035, 31624.525632115077, 36216.81891590525, 37681.81159094187, 38007.2398552033, 31710.36579268448, 32062.67937320597, 32064.35871282608, 32070.518942215418, 34486.31027379489, 26673.0, 28218.71781282243, 28903.85548072246, 28980.130596082152, 29081.0, 22676.0, 22930.656040159745, 23900.402489937194, 24033.0, 24583.13959011426], "unit": "score", "name": "ext.html", "value": 18288.461806353276}, {"lowerIsBetter": false, "replicates": [369.26331967724394, 369.6839202481878, 369.84096838359505, 370.1708173690933, 370.57939238963786, 12938.223706577612, 12939.0, 16616.501504954857, 17667.11664416779, 18414.17136228868, 12190.02479801616, 14707.338169782359, 15003.549893503212, 15009.099454032767, 15111.546653600382, 5352.143657014869, 5485.945140548583, 5495.6427832190975, 5496.120620700669, 5497.340319161706, 3741.5323084614424, 3824.7513911595797, 5066.012127635113, 5249.081410753122, 5461.836144915639, 5368.0, 5393.2719082923695, 5400.675959442446, 5407.0, 5407.080796264644, 5383.81156659515, 5389.245505629196, 5592.748326325304, 5915.260592425947, 5920.79277225295, 5246.475352464761, 5251.081060814342, 5255.211718242256, 5255.710935898524, 5259.658122222081, 11916.404179790976, 18515.0, 18878.90560547202, 19138.0, 19703.704444433344, 2045.6420126477956, 2100.85294029418, 2130.5845360154776, 2156.4069880782754, 2252.358077947777, 9402.95298523503, 9583.424994500352, 9719.514024298827, 10656.840147397796, 12600.306983115925, 1680.3698613020117, 1842.5946291815778, 1848.2884089625456, 1851.5741379482795, 1877.6807942649646, 59234.0, 59750.402495974915, 59828.70085649544, 62976.37023629751, 64212.67893660549, 9868.703938881845, 9956.900430995598, 10050.648227312155, 10099.192064634812, 10152.644657436955, 12978.740425191443, 13027.413766380536, 13125.0, 13140.934295328461, 13161.67095822593, 7324.0, 7353.485256032026, 7362.085459183643, 7460.29127232912, 7473.439492038119, 6973.965130174317, 7003.089598352181, 7095.113110861143, 7097.538659987187, 7117.750878719324, 4206.305959516707, 4294.871153865389, 4309.870703878889, 4351.282038463682, 4356.106998065389, 1603.4628399486303, 1643.2851709506165, 1719.8796084274231, 1766.5318690546758, 1806.4309742431092, 818.9140140285184, 860.6127242740666, 941.5904081724472, 1016.0, 1045.947702614866, 16057.919710401373, 16187.514374568545, 17208.39770608048, 17564.38524651631, 17836.821631783776, 827.3648429751262, 892.7812685891998, 930.093159169804, 934.4159900062461, 1019.1031891935049, 8517.36119791018, 9578.281628877861, 9619.230461563198, 9717.514124293757, 9951.154151897024, 569612.0, 572564.0, 594789.0, 598559.0, 603285.0, 77103.0, 80160.0, 80240.59879700681, 80487.59756201181, 82384.0, 1096.090245096568, 1102.030213412192, 1185.146694380045, 1188.5008296515484, 1207.4687137659403, 15593.610159746097, 15631.0, 15673.0, 15839.920800395925, 15973.440929567874, 35558.46662300119, 35682.46476302909, 35742.64257357393, 36577.085572860895, 36943.07642308964, 46385.304220436046, 46636.53363466322, 46796.7660161697, 47705.522944770106, 47765.761171193924, 9399.20106790903, 9461.763455913657, 9556.378835375679, 9668.613255469703, 9672.95163524178, 11305.378204198849, 11414.48634811419, 11544.422778861192, 11559.595414160463, 11578.363190024293, 10360.896391035993, 11401.942990284995, 14387.568372948828, 14727.453617370022, 14870.256487175382, 13698.38357273945, 13847.584572462842, 14257.358418870968, 14679.55961321162, 14779.261036947895, 14249.179022788006, 14383.137011779327, 14481.275936203358, 14626.122432654074, 14717.264136793332, 9341.34610577253, 9359.578818953027, 9394.95302523483, 9511.476868772284, 9713.9028609713, 11548.307101573597, 14760.0, 14800.555983320517, 15019.399224030916, 15105.773413399027], "unit": "score", "name": "jquery.html", "value": 8679.731186239083}, {"lowerIsBetter": false, "replicates": [1296.3647812571842, 1703.1824724132416, 1734.9653006939861, 1748.064785339843, 1786.6158775863196, 6444.8066558003275, 7676.155622881485, 7835.92164078359, 7845.4900431471915, 7864.134945156028, 7454.329110380065, 7647.082350117979, 7657.578833164173, 7661.502002369842, 7664.271894170045, 1955.3156395261688, 2016.3547664747286, 2019.4749365165017, 2269.4326418395403, 2314.4792421705065, 2041.2651445479617, 2258.3450799268276, 2293.1859189987563, 2304.7925686688195, 2307.7692230776956, 2249.6513040478753, 2272.5682120397155, 2282.5549017941507, 2283.360659015478, 2314.618088015475, 2206.018321846771, 2222.533268013703, 2234.4748983988748, 2234.5084081502123, 2236.083205885587, 2299.988500057489, 2330.5105927755194, 2331.1141766128762, 2333.8833058347186, 2334.26470661741, 7840.2943735063545, 7914.920850791476, 7915.05019397676, 7915.762527124196, 7921.881171782428, 4662.3239630253765, 4756.762161891892, 4768.833090841838, 4769.689970151929, 4772.284157376386, 3057.6824145801834, 3089.748651796026, 3144.7326977206967, 3175.3966746318124, 3185.7451403887635, 1037.19617296595, 1104.0670633314917, 1106.8173751331021, 1112.8720197177347, 1121.8092924202824, 10813.729656758565, 10895.673129806119, 10895.782084358269, 10933.18001149917, 10940.0, 4199.91600167995, 4279.679024073207, 4304.966807966066, 4336.718113322624, 4356.803943822536, 9240.491772952551, 9250.074992500831, 9262.95368523153, 9269.536523173814, 9287.628494860264, 4760.09558183944, 4760.976195119071, 4780.617550596014, 4780.976095119572, 4792.2332426811545, 4355.760433176206, 4365.978170109129, 4367.192069467159, 4369.737815731066, 4372.322290045048, 3219.323941972212, 3710.591834898159, 3767.7174211933666, 3781.621837816251, 3786.3563194257044, 1083.312096818526, 1180.7756526259984, 1212.5998420521207, 1215.769003889258, 1221.8350522679502, 1034.4207243943415, 1052.1004541117388, 1087.7715679707192, 1302.7524770293614, 1304.8368953880765, 7159.284071592799, 7248.456365772483, 7343.816404589928, 7356.485046046725, 7358.96320518394, 1109.5839060352369, 1111.727626731456, 1133.0287342863212, 1137.8748337682848, 1140.7946569617382, 5678.0, 5760.654360738369, 5764.942350576524, 5769.451902069297, 5769.884602308014, 8847.601857916408, 9001.954990225138, 9285.25717942563, 9289.256859451227, 9290.210332121711, 9112.681056163003, 9203.723888283228, 9225.400348977295, 9229.215516681157, 9233.769155771159, 7101.680424380916, 7248.166460857069, 7256.129264488295, 7313.866350715648, 7318.707251709872, 7289.4168466523615, 7345.412367010519, 7385.224551422239, 7437.553746775211, 7447.739329123455, 8234.464759790595, 8486.915130848613, 8624.827503449771, 8640.35197360213, 8670.956645216733, 8811.295096392145, 8825.646974120964, 8834.823303534022, 8849.4247873888, 8850.247728943112, 6598.60408375499, 6879.621620810904, 6881.621510816954, 6883.7590684325805, 6892.827679307857, 6799.762008329685, 6936.583804971718, 7550.320471157622, 7588.886166707393, 7608.31525162738, 6775.356341147583, 6853.760118395832, 6908.0, 6936.2023367311385, 7009.894851577128, 6695.598264104169, 6757.290484499254, 6800.081988931431, 6845.0759147514445, 6899.793006209822, 7109.573425594481, 7148.64256787169, 7152.177499587614, 7154.141503019671, 7157.427405807419, 6417.6470294132405, 6420.871582568416, 6476.283784797127, 6484.70818813164, 6489.9026514603265, 6387.041943708295, 6393.6163830170335, 6394.4884409246215, 6411.807645770635, 6415.8396040097505], "unit": "score", "name": "mootools.html", "value": 4505.384272864691}, {"lowerIsBetter": false, "replicates": [324.2720093390339, 335.22061207692116, 338.62243598387806, 340.2565394612771, 343.05146270561903, 5857.85355366115, 5897.557683173768, 5903.527717782573, 5912.7930522431725, 5948.1375200595885, 5571.275734154565, 5662.320521537411, 5785.913211301834, 5869.8239052828485, 5882.382349853268, 4577.519360467153, 4580.404547408849, 4602.332661764042, 4621.191291523986, 4622.445306563217, 4357.869263922072, 4588.197065513538, 4589.219832628444, 4591.173588754023, 4595.172868883599, 4392.89017774555, 4417.823287068513, 4518.751468669222, 4523.411956445674, 4555.314533622564, 4574.542545745432, 4575.0, 4575.130725162208, 4579.198640237945, 4582.427196600425, 4030.415589739471, 4034.152827906143, 4044.8382064717375, 4046.8178931947837, 4050.453188819501, 5507.9449205507835, 5626.324841019063, 5629.80295689653, 5631.155326701028, 5634.154876768517, 5316.601254905898, 5319.813806516792, 5323.494268044529, 5325.893482130375, 5333.200019997032, 6248.937510624881, 6266.655333956631, 6267.9686601567155, 6274.749010039593, 6276.184096067527, 4474.597286244221, 4476.55234476553, 4477.529859364752, 4482.350059241392, 4493.887652808673, 6372.745090196387, 6540.34596540347, 6543.869122617521, 6548.8362790930605, 6563.278039415708, 4567.817287308537, 4568.954310456919, 4570.405847239837, 4572.359869618256, 4572.4055872736335, 4625.074985002945, 4625.95374046262, 4628.305754136906, 4631.606313463393, 4635.884102897455, 5273.024490469275, 5277.894442111213, 5281.102212623863, 5287.68273903567, 5297.099493086184, 6127.509799216052, 6243.282022567463, 6289.654069026156, 6293.0, 6301.779437719658, 1615.6203292226317, 1637.124138585851, 1637.7870876785942, 1638.754186871955, 1639.0821140161547, 1108.6784832398675, 1109.8335249712445, 1121.103117505992, 1121.377635412354, 1131.0386171753944, 6031.788887388921, 6041.365656606081, 6042.0, 6042.003069493484, 6046.727897244635, 6478.546501744832, 6478.935210647834, 6482.0, 6489.448396886223, 6505.902411463831, 5809.738561764731, 5876.970615146983, 5937.0, 6075.75696972125, 6085.0, 3493.0917961330238, 3511.0520159556777, 3518.964810351864, 3521.0, 3522.7181825453904, 6630.104935833697, 6639.070530125786, 6641.601503909781, 6642.368974947372, 6646.401823835781, 6531.8693626127215, 6665.933340666628, 6668.266490686021, 6670.899936500957, 6699.425634975777, 6574.079628851964, 6586.04502347157, 6588.374104460068, 6588.769393071316, 6618.768343107872, 6465.450436712932, 6475.611463312216, 6476.898927182485, 6482.902756458751, 6489.318621544669, 6275.278342990432, 6428.100065990671, 6428.55000149985, 6437.130987316652, 6451.0645956337, 6592.736290548324, 6639.103720997604, 6647.7008534617025, 6649.235337936006, 6653.334666533308, 4369.868903932887, 4377.978110109557, 4386.122775444987, 4397.912041759211, 4400.713953593006, 6360.93639063622, 6540.803775886731, 6548.8362790930605, 6551.344865513411, 6557.96721016411, 6347.238331400262, 6367.808965731036, 6373.298937117006, 6374.139491168633, 6379.457746091634, 6358.078078678658, 6361.554691171574, 6363.490920726424, 6371.299157092623, 6376.139221205263, 6089.421504957022, 6226.470749986121, 6227.034809604518, 6231.22109736283, 6233.438990490878, 6382.106505089198, 6385.0, 6385.764982256173, 6386.648734319657, 6386.840328991812, 6181.443670069715, 6186.041163619646, 6194.535409844189, 6195.845103872439, 6199.628022318675], "unit": "score", "name": "prototype.html", "value": 4765.501329539142}, {"lowerIsBetter": false, "replicates": [763.8243204063066, 822.9300509456694, 827.0, 844.0715213265405, 853.2107800284736, 12659.683507912307, 12948.935255323733, 13044.60866174014, 13094.345282735861, 13101.67245818855, 13100.47598096075, 13293.534726284583, 13303.534376296831, 13686.863131368684, 13712.24582647954, 828.6146941672137, 844.8859403980476, 844.9535275559841, 846.3863698818338, 847.8007668197969, 490.14469750285804, 493.5557997801971, 817.0481389181597, 846.327169899931, 847.6143354773594, 876.6361959786681, 878.7627340618061, 882.8057827277988, 882.867569864519, 883.6112110671316, 506.7516916710785, 512.3032675561234, 877.4428238068808, 877.4954401219325, 878.9121087891192, 627.1220291591808, 648.627039452312, 649.2695717318018, 649.4641920415676, 650.0152269311997, 12911.418986145552, 13030.263644634639, 13158.144720593227, 13180.406881690347, 13352.666183345396, 11088.168387370899, 11195.104391648649, 11667.6499705009, 11977.0, 12576.930960868338, 9920.603175872957, 9982.700518984442, 10043.19654427644, 10211.693649190536, 10243.28297019209, 3493.9650603494147, 3607.1162565171703, 3637.9636203638156, 3639.508666330038, 3643.4716966039778, 44794.10411791746, 44962.10075798498, 46552.30171547429, 48113.75943120332, 48151.27773083407, 9537.284703647116, 9793.118619324296, 9881.703548893545, 10012.0, 10279.126274266622, 15475.84524154744, 15499.5350139496, 15514.301856416489, 15523.84476155224, 15563.688726225411, 7131.857362852714, 7132.750353737698, 7208.35124838767, 7295.817604559928, 7554.471187016966, 4245.426867372865, 4255.744655320691, 4262.829486820492, 4306.181825453154, 4313.956860431355, 3071.66211716711, 3072.585200997881, 3076.292452735883, 3085.7531397488146, 3120.5475206095443, 596.2665920917209, 603.3453702732496, 604.241676695744, 605.0198678141351, 616.8334549671564, 537.887043720823, 627.0, 644.4232411991242, 648.2156590525423, 679.7484930575719, 7627.847443051219, 7773.922260777433, 8026.117127116013, 8081.919180808234, 8144.429889907649, 484.1019908070549, 535.6919771131537, 615.0773839241139, 639.8656282180701, 654.653033892038, 3690.2250527389547, 3803.2583646188727, 3848.3265428549894, 3989.860354887565, 4022.778747168934, 47555.76222118867, 47609.0, 47731.28403073957, 47744.28383574249, 50355.0, 45404.77297613491, 45581.772091139996, 45993.77003114963, 46062.30906536405, 46131.53868461272, 41451.58548414538, 41749.79125104416, 41808.58191418047, 41944.370834437505, 42406.78796606059, 7660.80847978805, 8013.2387423194705, 8106.47307924983, 8191.631376587949, 8347.666093356198, 31173.53239701361, 31650.208744780644, 31948.20129496781, 32258.516122258654, 32652.34695306033, 37457.81271093627, 38160.0, 38511.61488385192, 41223.1755364897, 41322.380164296956, 10350.13677607095, 10759.13926885863, 10844.0, 11013.2841365311, 11308.604198853001, 11863.940680296544, 11931.623422107452, 12112.515499379926, 12211.75576488483, 12525.436355363849, 10849.457527123453, 10933.507992140214, 11112.555497779998, 11253.943730281624, 11504.424778761197, 10771.030607245386, 10889.618863339745, 11373.943130284295, 11374.31754094757, 11756.412179391167, 7013.789586312419, 8874.201321881063, 9123.087691230823, 9751.902480975099, 10151.492425378554, 8978.86531702012, 9007.954960225157, 9161.450312981242, 9254.012279592178, 9713.417194968324, 9178.403403778733, 9601.183899368632, 9634.759131021781, 9658.420494770337, 9856.260780441638], "unit": "score", "name": "yui.html", "value": 6015.161023689446}], "name": "dromaeo_css", "value": 6898.9629859698425}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 104.0, 110.0, 110.0, 111.0, 101.0, 109.0, 110.0, 115.0], "unit": "score", "name": "ai-astar", "value": 108.8}, {"lowerIsBetter": true, "replicates": [145.0, 124.0, 149.0, 159.0, 123.0, 150.0, 150.0, 124.0, 173.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 142.6}, {"lowerIsBetter": true, "replicates": [162.0, 159.0, 160.0, 159.0, 160.0, 160.0, 159.0, 163.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.4}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 84.0, 96.0, 73.0, 73.0, 72.0, 126.0, 92.0, 72.0], "unit": "score", "name": "audio-fft", "value": 83.6}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 139.0, 93.0, 94.0, 94.0, 138.0, 92.0, 93.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 106.5}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 110.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [60.0, 58.0, 57.0, 59.0, 61.0, 57.0, 58.0, 65.0, 54.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.5}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 66.0, 67.0, 67.0, 67.0, 67.0, 70.0, 67.0, 73.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 85.0, 85.0, 84.0, 85.0, 85.0, 84.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.5}, {"lowerIsBetter": true, "replicates": [117.0, 126.0, 118.0, 115.0, 128.0, 125.0, 132.0, 116.0, 124.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.4}, {"lowerIsBetter": true, "replicates": [145.0, 154.0, 160.0, 154.0, 155.0, 142.0, 152.0, 159.0, 153.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.8}, {"lowerIsBetter": true, "replicates": [70.0, 66.0, 69.0, 67.0, 71.0, 66.0, 66.0, 68.0, 66.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.7}], "name": "kraken", "value": 1503.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.92002654720426], "unit": "score", "name": "Richards", "value": 212.765154}, {"lowerIsBetter": false, "replicates": [188.32391713747646], "unit": "score", "name": "DeltaBlue", "value": 351.08658000000014}, {"lowerIsBetter": false, "replicates": [279.72027972027973], "unit": "score", "name": "Encrypt", "value": 951.5970750000004}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1951.2670565302144], "unit": "score", "name": "RayTrace", "value": 379.23512187812196}, {"lowerIsBetter": false, "replicates": [786.7820613690008], "unit": "score", "name": "Earley", "value": 847.0744729999998}, {"lowerIsBetter": false, "replicates": [12108.43373493976], "unit": "score", "name": "Boyer", "value": 55.0412228855721}, {"lowerIsBetter": false, "replicates": [25743.589743589742], "unit": "score", "name": "RegExp", "value": 35.38686752988046}, {"lowerIsBetter": false, "replicates": [574.052812858783], "unit": "score", "name": "Splay", "value": 141.95732200000006}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 20019.058703641265}]} 14:14:34 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20019.06"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1503.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6898.96"}}} 14:14:34 INFO - Return code: 0 14:14:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:14:34 ERROR - # TBPL SUCCESS # 14:14:34 INFO - Running post-action listener: _resource_record_post_action 14:14:34 INFO - Running post-run listener: _resource_record_post_run 14:14:35 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 0; Write bytes: 561553408; Read time: 0; Write time: 657644 14:14:35 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 249307136; Read time: 0; Write time: 400432 14:14:35 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 312246272; Read time: 0; Write time: 257212 14:14:35 INFO - Running post-run listener: _upload_blobber_files 14:14:35 INFO - Blob upload gear active. 14:14:35 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:14:35 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:14:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 14:14:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 14:14:35 INFO - (blobuploader) - INFO - Open directory for files ... 14:14:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:14:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:14:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:14:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:14:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:14:36 INFO - (blobuploader) - INFO - Done attempting. 14:14:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 14:14:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:14:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:14:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:14:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:14:37 INFO - (blobuploader) - INFO - Done attempting. 14:14:37 INFO - (blobuploader) - INFO - Iteration through files over. 14:14:37 INFO - Return code: 0 14:14:37 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:14:37 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:14:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/189ece934dad8341bbaad2c19e245bebe313e4e42ef0294f796b2f178e6c2c97e8932ad917aacb23c0eb40161352d5360224908334814b8a5dfe255bbcef8c7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/74a0d3b344f077de6fed644dd632ebd7c34e4cec4b2b9e4bf52907a8f0e79864bfaeb3b0235b8a14219486f30458d25dba16c1a54d3d02177b36bfb6bd596c27"} 14:14:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:14:37 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:14:37 INFO - Contents: 14:14:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/189ece934dad8341bbaad2c19e245bebe313e4e42ef0294f796b2f178e6c2c97e8932ad917aacb23c0eb40161352d5360224908334814b8a5dfe255bbcef8c7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/74a0d3b344f077de6fed644dd632ebd7c34e4cec4b2b9e4bf52907a8f0e79864bfaeb3b0235b8a14219486f30458d25dba16c1a54d3d02177b36bfb6bd596c27"} 14:14:37 INFO - Copying logs to upload dir... 14:14:37 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1266.077020 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-22 14:14:36.903585) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 14:14:36.906834) ========= 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=0c96bf5caf0e090009e1a122000001b2-1450816368.385582-1488473436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/189ece934dad8341bbaad2c19e245bebe313e4e42ef0294f796b2f178e6c2c97e8932ad917aacb23c0eb40161352d5360224908334814b8a5dfe255bbcef8c7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/74a0d3b344f077de6fed644dd632ebd7c34e4cec4b2b9e4bf52907a8f0e79864bfaeb3b0235b8a14219486f30458d25dba16c1a54d3d02177b36bfb6bd596c27"} build_url:https://queue.taskcluster.net/v1/task/BtYEPHAHSYqCv-sPXbeuwA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011330 build_url: 'https://queue.taskcluster.net/v1/task/BtYEPHAHSYqCv-sPXbeuwA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/189ece934dad8341bbaad2c19e245bebe313e4e42ef0294f796b2f178e6c2c97e8932ad917aacb23c0eb40161352d5360224908334814b8a5dfe255bbcef8c7e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/74a0d3b344f077de6fed644dd632ebd7c34e4cec4b2b9e4bf52907a8f0e79864bfaeb3b0235b8a14219486f30458d25dba16c1a54d3d02177b36bfb6bd596c27"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 14:14:36.932551) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 14:14:36.932940) ========= 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=0c96bf5caf0e090009e1a122000001b2-1450816368.385582-1488473436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004456 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 14:14:37.019729) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 14:14:37.020099) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 14:14:37.020453) ========= ========= Total master_lag: 0.33 =========