builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-027 starttime: 1453791195.55 results: success (0) buildid: 20160125203202 builduid: 81961faa15364d2096727cbd499af565 revision: 8160b0c865bff3281a3e8118bce47d099eeb3963 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 22:53:15.550945) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 22:53:15.551723) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 22:53:15.552235) ========= 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=1f5564757af27664ca02d71f000001b0-1453782510.291007-2031243442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006395 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 22:53:15.593995) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 22:53:15.594517) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 22:53:15.708313) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 22:53:15.708633) ========= 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=1f5564757af27664ca02d71f000001b0-1453782510.291007-2031243442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004769 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 22:53:15.776816) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 22:53:15.777132) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 22:53:15.777495) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 22:53:15.777776) ========= 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=1f5564757af27664ca02d71f000001b0-1453782510.291007-2031243442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-25 22:53:16-- 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% 218M=0s 2016-01-25 22:53:16 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162783 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 22:53:15.960486) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 22:53:15.960788) ========= 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=1f5564757af27664ca02d71f000001b0-1453782510.291007-2031243442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018929 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 22:53:16.010138) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 22:53:16.010504) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8160b0c865bff3281a3e8118bce47d099eeb3963 --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 8160b0c865bff3281a3e8118bce47d099eeb3963 --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=1f5564757af27664ca02d71f000001b0-1453782510.291007-2031243442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-25 22:53:16,368 truncating revision to first 12 chars 2016-01-25 22:53:16,368 Setting DEBUG logging. 2016-01-25 22:53:16,368 attempt 1/10 2016-01-25 22:53:16,368 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8160b0c865bf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-25 22:53:16,649 unpacking tar archive at: fx-team-8160b0c865bf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.584117 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 22:53:16.607559) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 22:53:16.607886) ========= echo 8160b0c865bff3281a3e8118bce47d099eeb3963 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8160b0c865bff3281a3e8118bce47d099eeb3963'] 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=1f5564757af27664ca02d71f000001b0-1453782510.291007-2031243442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 8160b0c865bff3281a3e8118bce47d099eeb3963 program finished with exit code 0 elapsedTime=0.003566 script_repo_revision: '8160b0c865bff3281a3e8118bce47d099eeb3963' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 22:53:16.655626) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 22:53:16.655931) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 22:53:16.666678) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-01-25 22:53:16.667046) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1453782510.291007-2031243442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:53:17 INFO - MultiFileLogger online at 20160125 22:53:17 in /builds/slave/test-pgo 22:53:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 22:53:17 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:53:17 INFO - {'append_to_log': False, 22:53:17 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:53:17 INFO - 'blob_upload_branch': 'Fx-Team', 22:53:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:53:17 INFO - 'branch': 'Fx-Team', 22:53:17 INFO - 'buildbot_json_path': 'buildprops.json', 22:53:17 INFO - 'config_files': ('talos/linux_config.py',), 22:53:17 INFO - 'default_actions': ('clobber', 22:53:17 INFO - 'read-buildbot-config', 22:53:17 INFO - 'download-and-extract', 22:53:17 INFO - 'populate-webroot', 22:53:17 INFO - 'create-virtualenv', 22:53:17 INFO - 'install', 22:53:17 INFO - 'run-tests'), 22:53:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:53:17 INFO - 'download_minidump_stackwalk': True, 22:53:17 INFO - 'download_symbols': 'ondemand', 22:53:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:53:17 INFO - 'tooltool.py': '/tools/tooltool.py', 22:53:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:53:17 INFO - '/tools/misc-python/virtualenv.py')}, 22:53:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:53:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:53:17 INFO - 'installer_path': 'installer.exe', 22:53:17 INFO - 'log_level': 'info', 22:53:17 INFO - 'log_name': 'talos', 22:53:17 INFO - 'log_to_console': True, 22:53:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:53:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:53:17 INFO - 'opt_config_files': (), 22:53:17 INFO - 'pip_index': False, 22:53:17 INFO - 'sps_profile': False, 22:53:17 INFO - 'sps_profile_interval': 0, 22:53:17 INFO - 'suite': 'dromaeojs-e10s', 22:53:17 INFO - 'system_bits': '32', 22:53:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:53:17 INFO - 'title': 'talos-linux64-ix-027', 22:53:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:53:17 INFO - 'use_talos_json': True, 22:53:17 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:53:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:53:17 INFO - 'work_dir': 'build'} 22:53:17 INFO - ##### 22:53:17 INFO - ##### Running clobber step. 22:53:17 INFO - ##### 22:53:17 INFO - Running pre-action listener: _resource_record_pre_action 22:53:17 INFO - Running main action method: clobber 22:53:17 INFO - rmtree: /builds/slave/test-pgo/build 22:53:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:53:17 INFO - Running post-action listener: _resource_record_post_action 22:53:17 INFO - ##### 22:53:17 INFO - ##### Running read-buildbot-config step. 22:53:17 INFO - ##### 22:53:17 INFO - Running pre-action listener: _resource_record_pre_action 22:53:17 INFO - Running main action method: read_buildbot_config 22:53:17 INFO - Using buildbot properties: 22:53:17 INFO - { 22:53:17 INFO - "project": "", 22:53:17 INFO - "product": "firefox", 22:53:17 INFO - "script_repo_revision": "production", 22:53:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:53:17 INFO - "repository": "", 22:53:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 22:53:17 INFO - "buildid": "20160125203202", 22:53:17 INFO - "pgo_build": "True", 22:53:17 INFO - "basedir": "/builds/slave/test-pgo", 22:53:17 INFO - "buildnumber": 138, 22:53:17 INFO - "slavename": "talos-linux64-ix-027", 22:53:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:53:17 INFO - "platform": "ubuntu64_hw", 22:53:17 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 22:53:17 INFO - "branch": "fx-team", 22:53:17 INFO - "repo_path": "integration/fx-team", 22:53:17 INFO - "revision": "8160b0c865bff3281a3e8118bce47d099eeb3963", 22:53:17 INFO - "stage_platform": "linux64-pgo", 22:53:17 INFO - "builduid": "81961faa15364d2096727cbd499af565", 22:53:17 INFO - "slavebuilddir": "test" 22:53:17 INFO - } 22:53:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/NizjWjVtQ9y8KcmO5ogg2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 22:53:17 INFO - Running post-action listener: _resource_record_post_action 22:53:17 INFO - ##### 22:53:17 INFO - ##### Running download-and-extract step. 22:53:17 INFO - ##### 22:53:17 INFO - Running pre-action listener: _resource_record_pre_action 22:53:17 INFO - Running main action method: download_and_extract 22:53:17 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:53:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:17 INFO - https://queue.taskcluster.net/v1/task/NizjWjVtQ9y8KcmO5ogg2g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:53:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NizjWjVtQ9y8KcmO5ogg2g/artifacts/public/build/test_packages.json 22:53:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NizjWjVtQ9y8KcmO5ogg2g/artifacts/public/build/test_packages.json 22:53:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NizjWjVtQ9y8KcmO5ogg2g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:53:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NizjWjVtQ9y8KcmO5ogg2g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:53:23 INFO - Downloaded 1448 bytes. 22:53:23 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:53:23 INFO - Using the following test package requirements: 22:53:23 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:53:23 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:23 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:53:23 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:23 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:53:23 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:23 INFO - u'jsshell-linux-x86_64.zip'], 22:53:23 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:23 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:53:23 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:53:23 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:23 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:53:23 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:23 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:53:23 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:23 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:53:23 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:53:23 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:23 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:53:23 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:53:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:23 INFO - https://queue.taskcluster.net/v1/task/NizjWjVtQ9y8KcmO5ogg2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:53:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NizjWjVtQ9y8KcmO5ogg2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:53:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NizjWjVtQ9y8KcmO5ogg2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:53:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NizjWjVtQ9y8KcmO5ogg2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:53:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NizjWjVtQ9y8KcmO5ogg2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:53:28 INFO - Downloaded 22500988 bytes. 22:53:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:53:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:53:29 INFO - Return code: 0 22:53:29 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:53:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:29 INFO - https://queue.taskcluster.net/v1/task/NizjWjVtQ9y8KcmO5ogg2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:53:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NizjWjVtQ9y8KcmO5ogg2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:53:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NizjWjVtQ9y8KcmO5ogg2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:53:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NizjWjVtQ9y8KcmO5ogg2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:53:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NizjWjVtQ9y8KcmO5ogg2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:53:38 INFO - Downloaded 22500988 bytes. 22:53:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:53:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:53:40 INFO - Return code: 0 22:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:40 INFO - https://queue.taskcluster.net/v1/task/NizjWjVtQ9y8KcmO5ogg2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:53:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NizjWjVtQ9y8KcmO5ogg2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:53:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NizjWjVtQ9y8KcmO5ogg2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:53:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NizjWjVtQ9y8KcmO5ogg2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:53:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NizjWjVtQ9y8KcmO5ogg2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:53:41 INFO - Downloaded 10706572 bytes. 22:53:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:53:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 22:53:41 INFO - Return code: 0 22: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')]} 22:53:41 INFO - https://queue.taskcluster.net/v1/task/NizjWjVtQ9y8KcmO5ogg2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:53:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NizjWjVtQ9y8KcmO5ogg2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:53:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NizjWjVtQ9y8KcmO5ogg2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:53:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NizjWjVtQ9y8KcmO5ogg2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:53:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NizjWjVtQ9y8KcmO5ogg2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:53:43 INFO - Downloaded 55967672 bytes. 22:53:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NizjWjVtQ9y8KcmO5ogg2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:53:43 INFO - mkdir: /builds/slave/test-pgo/properties 22:53:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:53:43 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:53:43 INFO - Contents: 22:53:43 INFO - build_url:https://queue.taskcluster.net/v1/task/NizjWjVtQ9y8KcmO5ogg2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:53:43 INFO - Running post-action listener: _resource_record_post_action 22:53:43 INFO - Running post-action listener: set_extra_try_arguments 22:53:43 INFO - ##### 22:53:43 INFO - ##### Running populate-webroot step. 22:53:43 INFO - ##### 22:53:43 INFO - Running pre-action listener: _resource_record_pre_action 22:53:43 INFO - Running main action method: populate_webroot 22:53:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:53:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:53:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:53:43 INFO - '--tppagecycles', 22:53:43 INFO - '7'], 22:53:43 INFO - 'tests': ['tsvgm']}}, 22:53:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:53:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:53:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:53:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:53:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:53:43 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:53:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:53:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:43 INFO - 'talos_options': ['--e10s'], 22:53:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:53:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:43 INFO - 'tests': ['damp', 'tps']}, 22:53:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:43 INFO - 'talos_options': ['--e10s'], 22:53:43 INFO - 'tests': ['damp', 'tps']}, 22:53:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:53:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:53:43 INFO - 'other': {'tests': ['a11yr', 22:53:43 INFO - 'ts_paint', 22:53:43 INFO - 'tpaint', 22:53:43 INFO - 'sessionrestore', 22:53:43 INFO - 'sessionrestore_no_auto_restore']}, 22:53:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:53:43 INFO - 'tests': ['a11yr', 22:53:43 INFO - 'ts_paint', 22:53:43 INFO - 'tpaint', 22:53:43 INFO - 'sessionrestore', 22:53:43 INFO - 'sessionrestore_no_auto_restore']}, 22:53:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:53:43 INFO - 'tests': ['a11yr', 22:53:43 INFO - 'ts_paint', 22:53:43 INFO - 'tpaint', 22:53:43 INFO - 'sessionrestore', 22:53:43 INFO - 'sessionrestore_no_auto_restore']}, 22:53:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:53:43 INFO - 'tests': ['a11yr', 22:53:43 INFO - 'ts_paint', 22:53:43 INFO - 'tpaint', 22:53:43 INFO - 'sessionrestore', 22:53:43 INFO - 'sessionrestore_no_auto_restore']}, 22:53:43 INFO - 'other_l64': {'tests': ['a11yr', 22:53:43 INFO - 'ts_paint', 22:53:43 INFO - 'tpaint', 22:53:43 INFO - 'sessionrestore', 22:53:43 INFO - 'sessionrestore_no_auto_restore']}, 22:53:43 INFO - 'other_nol64': {'tests': ['a11yr', 22:53:43 INFO - 'ts_paint', 22:53:43 INFO - 'tpaint', 22:53:43 INFO - 'sessionrestore', 22:53:43 INFO - 'sessionrestore_no_auto_restore']}, 22:53:43 INFO - 'svgr': {'tests': ['tsvgx', 22:53:43 INFO - 'tsvgr_opacity', 22:53:43 INFO - 'tart', 22:53:43 INFO - 'tscrollx', 22:53:43 INFO - 'cart']}, 22:53:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:53:43 INFO - 'tests': ['tsvgx', 22:53:43 INFO - 'tsvgr_opacity', 22:53:43 INFO - 'tart', 22:53:43 INFO - 'tscrollx', 22:53:43 INFO - 'cart']}, 22:53:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:43 INFO - 'tests': ['tp5o']}, 22:53:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:43 INFO - 'talos_options': ['--e10s'], 22:53:43 INFO - 'tests': ['tp5o']}, 22:53:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:43 INFO - 'talos_options': ['--xperf_path', 22:53:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:53:43 INFO - 'tests': ['tp5n']}, 22:53:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:43 INFO - 'talos_options': ['--e10s', 22:53:43 INFO - '--xperf_path', 22:53:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:53:43 INFO - 'tests': ['tp5n']}}, 22:53:43 INFO - 'talos.zip': {'path': '', 22:53:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:53:43 INFO - Running post-action listener: _resource_record_post_action 22:53:43 INFO - ##### 22:53:43 INFO - ##### Running create-virtualenv step. 22:53:43 INFO - ##### 22:53:43 INFO - Running pre-action listener: _resource_record_pre_action 22:53:43 INFO - Running main action method: create_virtualenv 22:53:43 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:53:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 22:53:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:53:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:53:43 INFO - Using real prefix '/usr' 22:53:43 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:53:44 INFO - Installing distribute.............................................................................................................................................................................................done. 22:53:46 INFO - Installing pip.................done. 22:53:46 INFO - Return code: 0 22:53:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fe80cce4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf840>, '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 0x1f4c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4cb60>, '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': '1f5564757af27664ca02d71f000001b0-1453782510.291007-2031243442', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:53:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 22:53:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:53:46 INFO - Using env: {'DISPLAY': ':0', 22:53:46 INFO - 'HOME': '/home/cltbld', 22:53:46 INFO - 'LANG': 'en_US.UTF-8', 22:53:46 INFO - 'LANGUAGE': 'en_US:en', 22:53:46 INFO - 'LOGNAME': 'cltbld', 22:53:46 INFO - 'MAIL': '/var/mail/cltbld', 22:53:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:46 INFO - 'MOZ_NO_REMOTE': '1', 22:53:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:46 INFO - 'NO_EM_RESTART': '1', 22:53:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:46 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:46 INFO - 'SHELL': '/bin/bash', 22:53:46 INFO - 'SHLVL': '1', 22:53:46 INFO - 'TERM': 'linux', 22:53:46 INFO - 'TMOUT': '86400', 22:53:46 INFO - 'USER': 'cltbld', 22:53:46 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1453782510.291007-2031243442', 22:53:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:46 INFO - '_': '/tools/buildbot/bin/python'} 22:53:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:53:46 INFO - Cleaning up... 22:53:46 INFO - Return code: 0 22:53:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fe80cce4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf840>, '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 0x1f4c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4cb60>, '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': '1f5564757af27664ca02d71f000001b0-1453782510.291007-2031243442', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:53:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 22:53:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:53:46 INFO - Using env: {'DISPLAY': ':0', 22:53:46 INFO - 'HOME': '/home/cltbld', 22:53:46 INFO - 'LANG': 'en_US.UTF-8', 22:53:46 INFO - 'LANGUAGE': 'en_US:en', 22:53:46 INFO - 'LOGNAME': 'cltbld', 22:53:46 INFO - 'MAIL': '/var/mail/cltbld', 22:53:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:46 INFO - 'MOZ_NO_REMOTE': '1', 22:53:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:46 INFO - 'NO_EM_RESTART': '1', 22:53:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:46 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:46 INFO - 'SHELL': '/bin/bash', 22:53:46 INFO - 'SHLVL': '1', 22:53:46 INFO - 'TERM': 'linux', 22:53:46 INFO - 'TMOUT': '86400', 22:53:46 INFO - 'USER': 'cltbld', 22:53:46 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1453782510.291007-2031243442', 22:53:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:46 INFO - '_': '/tools/buildbot/bin/python'} 22:53:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:46 INFO - Downloading/unpacking psutil>=0.7.1 22:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:53:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:53:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:53:48 INFO - Installing collected packages: psutil 22:53:48 INFO - Running setup.py install for psutil 22:53:48 INFO - building 'psutil._psutil_linux' extension 22:53:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:53:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:53:48 INFO - building 'psutil._psutil_posix' extension 22:53:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:53:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:53:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:53:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:53:48 INFO - Successfully installed psutil 22:53:48 INFO - Cleaning up... 22:53:49 INFO - Return code: 0 22:53:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22: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')]} 22:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22: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')]} 22:53:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fe80cce4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf840>, '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 0x1f4c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4cb60>, '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': '1f5564757af27664ca02d71f000001b0-1453782510.291007-2031243442', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:53:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 22:53:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:53:49 INFO - Using env: {'DISPLAY': ':0', 22:53:49 INFO - 'HOME': '/home/cltbld', 22:53:49 INFO - 'LANG': 'en_US.UTF-8', 22:53:49 INFO - 'LANGUAGE': 'en_US:en', 22:53:49 INFO - 'LOGNAME': 'cltbld', 22:53:49 INFO - 'MAIL': '/var/mail/cltbld', 22:53:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:49 INFO - 'MOZ_NO_REMOTE': '1', 22:53:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:49 INFO - 'NO_EM_RESTART': '1', 22:53:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:49 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:49 INFO - 'SHELL': '/bin/bash', 22:53:49 INFO - 'SHLVL': '1', 22:53:49 INFO - 'TERM': 'linux', 22:53:49 INFO - 'TMOUT': '86400', 22:53:49 INFO - 'USER': 'cltbld', 22:53:49 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1453782510.291007-2031243442', 22:53:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:49 INFO - '_': '/tools/buildbot/bin/python'} 22:53:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:53:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:53:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:53:51 INFO - Installing collected packages: mozsystemmonitor 22:53:51 INFO - Running setup.py install for mozsystemmonitor 22:53:51 INFO - Successfully installed mozsystemmonitor 22:53:51 INFO - Cleaning up... 22:53:51 INFO - Return code: 0 22:53:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:53:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fe80cce4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf840>, '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 0x1f4c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4cb60>, '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': '1f5564757af27664ca02d71f000001b0-1453782510.291007-2031243442', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:53:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 22:53:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:53:51 INFO - Using env: {'DISPLAY': ':0', 22:53:51 INFO - 'HOME': '/home/cltbld', 22:53:51 INFO - 'LANG': 'en_US.UTF-8', 22:53:51 INFO - 'LANGUAGE': 'en_US:en', 22:53:51 INFO - 'LOGNAME': 'cltbld', 22:53:51 INFO - 'MAIL': '/var/mail/cltbld', 22:53:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:51 INFO - 'MOZ_NO_REMOTE': '1', 22:53:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:51 INFO - 'NO_EM_RESTART': '1', 22:53:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:51 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:51 INFO - 'SHELL': '/bin/bash', 22:53:51 INFO - 'SHLVL': '1', 22:53:51 INFO - 'TERM': 'linux', 22:53:51 INFO - 'TMOUT': '86400', 22:53:51 INFO - 'USER': 'cltbld', 22:53:51 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1453782510.291007-2031243442', 22:53:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:51 INFO - '_': '/tools/buildbot/bin/python'} 22:53:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:51 INFO - Downloading/unpacking blobuploader==1.2.4 22: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 22: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 22: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 22: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 22: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 22: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 22:53:53 INFO - Downloading blobuploader-1.2.4.tar.gz 22:53:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:53:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:53:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:53 INFO - Downloading docopt-0.6.1.tar.gz 22:53:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:53:53 INFO - Installing collected packages: blobuploader, requests, docopt 22:53:53 INFO - Running setup.py install for blobuploader 22:53:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:53:54 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:53:54 INFO - Running setup.py install for requests 22:53:54 INFO - Running setup.py install for docopt 22:53:54 INFO - Successfully installed blobuploader requests docopt 22:53:54 INFO - Cleaning up... 22:53:54 INFO - Return code: 0 22:53:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:53:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7fe80cce4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf840>, '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 0x1f4c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4cb60>, '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': '1f5564757af27664ca02d71f000001b0-1453782510.291007-2031243442', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:53:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:53:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:53:54 INFO - Using env: {'DISPLAY': ':0', 22:53:54 INFO - 'HOME': '/home/cltbld', 22:53:54 INFO - 'LANG': 'en_US.UTF-8', 22:53:54 INFO - 'LANGUAGE': 'en_US:en', 22:53:54 INFO - 'LOGNAME': 'cltbld', 22:53:54 INFO - 'MAIL': '/var/mail/cltbld', 22:53:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:54 INFO - 'MOZ_NO_REMOTE': '1', 22:53:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:54 INFO - 'NO_EM_RESTART': '1', 22:53:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:54 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:54 INFO - 'SHELL': '/bin/bash', 22:53:54 INFO - 'SHLVL': '1', 22:53:54 INFO - 'TERM': 'linux', 22:53:54 INFO - 'TMOUT': '86400', 22:53:54 INFO - 'USER': 'cltbld', 22:53:54 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1453782510.291007-2031243442', 22:53:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:54 INFO - '_': '/tools/buildbot/bin/python'} 22:53:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:53:54 INFO - Running setup.py (path:/tmp/pip-ODy5l4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:53:54 INFO - Running setup.py (path:/tmp/pip-CFl8i1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:53:54 INFO - Running setup.py (path:/tmp/pip-CQiz7p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:53:54 INFO - Running setup.py (path:/tmp/pip-DH1bll-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:53:55 INFO - Running setup.py (path:/tmp/pip-LMs9Jb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:53:55 INFO - Running setup.py (path:/tmp/pip-vXx0LX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:53:55 INFO - Running setup.py (path:/tmp/pip-IOUkvn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:53:55 INFO - Running setup.py (path:/tmp/pip-gWA54k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:53:55 INFO - Running setup.py (path:/tmp/pip-Wtmtw8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:53:55 INFO - Running setup.py (path:/tmp/pip-HBXyQ6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:53:55 INFO - Running setup.py (path:/tmp/pip-iU9IOJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:53:55 INFO - Running setup.py (path:/tmp/pip-cwQ4s2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:53:55 INFO - Running setup.py (path:/tmp/pip-icbSid-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:53:55 INFO - Running setup.py (path:/tmp/pip-olI4oV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:53:55 INFO - Running setup.py (path:/tmp/pip-4V8Q2O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:53:55 INFO - Running setup.py (path:/tmp/pip-okCN3v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:53:55 INFO - Running setup.py (path:/tmp/pip-sLp8FZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:53:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:53:55 INFO - Running setup.py install for manifestparser 22:53:56 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:53:56 INFO - Running setup.py install for mozcrash 22:53:56 INFO - Running setup.py install for mozdebug 22:53:56 INFO - Running setup.py install for mozdevice 22:53:56 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:53:56 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:53:56 INFO - Running setup.py install for mozfile 22:53:56 INFO - Running setup.py install for mozhttpd 22:53:56 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:53:56 INFO - Running setup.py install for mozinfo 22:53:56 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:53:56 INFO - Running setup.py install for mozInstall 22:53:56 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:53:56 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:53:56 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:53:56 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:53:56 INFO - Running setup.py install for mozleak 22:53:56 INFO - Running setup.py install for mozlog 22:53:56 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:53:56 INFO - Running setup.py install for moznetwork 22:53:57 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:53:57 INFO - Running setup.py install for mozprocess 22:53:57 INFO - Running setup.py install for mozprofile 22:53:57 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:53:57 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:53:57 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:53:57 INFO - Running setup.py install for mozrunner 22:53:57 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:53:57 INFO - Running setup.py install for mozscreenshot 22:53:57 INFO - Running setup.py install for moztest 22:53:57 INFO - Running setup.py install for mozversion 22:53:57 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:53:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:53:57 INFO - Cleaning up... 22:53:57 INFO - Return code: 0 22:53:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fe80cce4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf840>, '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 0x1f4c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4cb60>, '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': '1f5564757af27664ca02d71f000001b0-1453782510.291007-2031243442', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:53:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:53:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:53:57 INFO - Using env: {'DISPLAY': ':0', 22:53:57 INFO - 'HOME': '/home/cltbld', 22:53:57 INFO - 'LANG': 'en_US.UTF-8', 22:53:57 INFO - 'LANGUAGE': 'en_US:en', 22:53:57 INFO - 'LOGNAME': 'cltbld', 22:53:57 INFO - 'MAIL': '/var/mail/cltbld', 22:53:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:57 INFO - 'MOZ_NO_REMOTE': '1', 22:53:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:57 INFO - 'NO_EM_RESTART': '1', 22:53:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:57 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:57 INFO - 'SHELL': '/bin/bash', 22:53:57 INFO - 'SHLVL': '1', 22:53:57 INFO - 'TERM': 'linux', 22:53:57 INFO - 'TMOUT': '86400', 22:53:57 INFO - 'USER': 'cltbld', 22:53:57 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1453782510.291007-2031243442', 22:53:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:57 INFO - '_': '/tools/buildbot/bin/python'} 22:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:53:57 INFO - Running setup.py (path:/tmp/pip-UUhh2p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 22:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:53:58 INFO - Running setup.py (path:/tmp/pip-mijX90-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:53:58 INFO - Running setup.py (path:/tmp/pip-bjmIG1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:53:58 INFO - Running setup.py (path:/tmp/pip-YgfxKg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:53:58 INFO - Running setup.py (path:/tmp/pip-KIvgpS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 22:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:53:58 INFO - Running setup.py (path:/tmp/pip-YT3xe3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 22:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:53:58 INFO - Running setup.py (path:/tmp/pip-YtiHbN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 22:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:53:58 INFO - Running setup.py (path:/tmp/pip-IcnXJw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 22:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:53:58 INFO - Running setup.py (path:/tmp/pip-wzron2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 22:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:53:58 INFO - Running setup.py (path:/tmp/pip-wIMQSQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:53:58 INFO - Running setup.py (path:/tmp/pip-u8aiC6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 22:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:53:58 INFO - Running setup.py (path:/tmp/pip-cXWDBd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 22:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:53:58 INFO - Running setup.py (path:/tmp/pip-ksncBR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 22:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:53:58 INFO - Running setup.py (path:/tmp/pip-kgls33-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 22:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:53:59 INFO - Running setup.py (path:/tmp/pip-gxhJHw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 22:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:53:59 INFO - Running setup.py (path:/tmp/pip-trrBdi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 22:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:53:59 INFO - Running setup.py (path:/tmp/pip-ekHoWF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 22:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:53:59 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:53:59 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:53:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:00 INFO - Downloading blessings-1.6.tar.gz 22:54:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:54:01 INFO - Installing collected packages: blessings 22:54:01 INFO - Running setup.py install for blessings 22:54:01 INFO - Successfully installed blessings 22:54:01 INFO - Cleaning up... 22:54:01 INFO - Return code: 0 22:54:01 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:54:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:54:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:54:01 INFO - Reading from file tmpfile_stdout 22:54:01 INFO - Current package versions: 22:54:01 INFO - argparse == 1.2.1 22:54:01 INFO - blessings == 1.6 22:54:01 INFO - blobuploader == 1.2.4 22:54:01 INFO - docopt == 0.6.1 22:54:01 INFO - manifestparser == 1.1 22:54:01 INFO - mozInstall == 1.12 22:54:01 INFO - mozcrash == 0.16 22:54:01 INFO - mozdebug == 0.1 22:54:01 INFO - mozdevice == 0.48 22:54:01 INFO - mozfile == 1.2 22:54:01 INFO - mozhttpd == 0.7 22:54:01 INFO - mozinfo == 0.9 22:54:01 INFO - mozleak == 0.1 22:54:01 INFO - mozlog == 3.1 22:54:01 INFO - moznetwork == 0.27 22:54:01 INFO - mozprocess == 0.22 22:54:01 INFO - mozprofile == 0.28 22:54:01 INFO - mozrunner == 6.11 22:54:01 INFO - mozscreenshot == 0.1 22:54:01 INFO - mozsystemmonitor == 0.0 22:54:01 INFO - moztest == 0.7 22:54:01 INFO - mozversion == 1.4 22:54:01 INFO - psutil == 3.1.1 22:54:01 INFO - requests == 1.2.3 22:54:01 INFO - wsgiref == 0.1.2 22:54:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fe80cce4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf840>, '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 0x1f4c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4cb60>, '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': '1f5564757af27664ca02d71f000001b0-1453782510.291007-2031243442', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:54:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 22:54:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:54:01 INFO - Using env: {'DISPLAY': ':0', 22:54:01 INFO - 'HOME': '/home/cltbld', 22:54:01 INFO - 'LANG': 'en_US.UTF-8', 22:54:01 INFO - 'LANGUAGE': 'en_US:en', 22:54:01 INFO - 'LOGNAME': 'cltbld', 22:54:01 INFO - 'MAIL': '/var/mail/cltbld', 22:54:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:01 INFO - 'MOZ_NO_REMOTE': '1', 22:54:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:01 INFO - 'NO_EM_RESTART': '1', 22:54:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:01 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:01 INFO - 'SHELL': '/bin/bash', 22:54:01 INFO - 'SHLVL': '1', 22:54:01 INFO - 'TERM': 'linux', 22:54:01 INFO - 'TMOUT': '86400', 22:54:01 INFO - 'USER': 'cltbld', 22:54:01 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1453782510.291007-2031243442', 22:54:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:01 INFO - '_': '/tools/buildbot/bin/python'} 22:54:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 22:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 22:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 22:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 22:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 22:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 22:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 22:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:54:01 INFO - Cleaning up... 22:54:01 INFO - Return code: 0 22:54:01 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fe80cce4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf840>, '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 0x1f4c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4cb60>, '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': '1f5564757af27664ca02d71f000001b0-1453782510.291007-2031243442', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:54:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 22:54:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:54:01 INFO - Using env: {'DISPLAY': ':0', 22:54:01 INFO - 'HOME': '/home/cltbld', 22:54:01 INFO - 'LANG': 'en_US.UTF-8', 22:54:01 INFO - 'LANGUAGE': 'en_US:en', 22:54:01 INFO - 'LOGNAME': 'cltbld', 22:54:01 INFO - 'MAIL': '/var/mail/cltbld', 22:54:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:01 INFO - 'MOZ_NO_REMOTE': '1', 22:54:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:01 INFO - 'NO_EM_RESTART': '1', 22:54:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:01 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:01 INFO - 'SHELL': '/bin/bash', 22:54:01 INFO - 'SHLVL': '1', 22:54:01 INFO - 'TERM': 'linux', 22:54:01 INFO - 'TMOUT': '86400', 22:54:01 INFO - 'USER': 'cltbld', 22:54:01 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1453782510.291007-2031243442', 22:54:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:01 INFO - '_': '/tools/buildbot/bin/python'} 22:54:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:01 INFO - Downloading/unpacking jsonschema 22:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:54:03 INFO - Downloading/unpacking functools32 (from jsonschema) 22:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:03 INFO - Downloading functools32-3.2.3-2.tar.gz 22:54:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:54:03 INFO - warning: no files found matching '*.txt' 22:54:03 INFO - no previously-included directories found matching 'build' 22:54:03 INFO - no previously-included directories found matching 'dist' 22:54:03 INFO - no previously-included directories found matching '.git*' 22:54:03 INFO - Installing collected packages: jsonschema, functools32 22:54:03 INFO - Running setup.py install for functools32 22:54:04 INFO - warning: no files found matching '*.txt' 22:54:04 INFO - no previously-included directories found matching 'build' 22:54:04 INFO - no previously-included directories found matching 'dist' 22:54:04 INFO - no previously-included directories found matching '.git*' 22:54:04 INFO - Successfully installed jsonschema functools32 22:54:04 INFO - Cleaning up... 22:54:04 INFO - Return code: 0 22:54:04 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:54:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fe80cce4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdf840>, '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 0x1f4c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4cb60>, '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': '1f5564757af27664ca02d71f000001b0-1453782510.291007-2031243442', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:54:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 22:54:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:54:04 INFO - Using env: {'DISPLAY': ':0', 22:54:04 INFO - 'HOME': '/home/cltbld', 22:54:04 INFO - 'LANG': 'en_US.UTF-8', 22:54:04 INFO - 'LANGUAGE': 'en_US:en', 22:54:04 INFO - 'LOGNAME': 'cltbld', 22:54:04 INFO - 'MAIL': '/var/mail/cltbld', 22:54:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:04 INFO - 'MOZ_NO_REMOTE': '1', 22:54:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:04 INFO - 'NO_EM_RESTART': '1', 22:54:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:04 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:04 INFO - 'SHELL': '/bin/bash', 22:54:04 INFO - 'SHLVL': '1', 22:54:04 INFO - 'TERM': 'linux', 22:54:04 INFO - 'TMOUT': '86400', 22:54:04 INFO - 'USER': 'cltbld', 22:54:04 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1453782510.291007-2031243442', 22:54:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:04 INFO - '_': '/tools/buildbot/bin/python'} 22:54:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:04 INFO - Downloading/unpacking flake8 22: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 22: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 22: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 22: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 22: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 22: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 22:54:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:54:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:54:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:54:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:54:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:54:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:54:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:54:06 INFO - no previously-included directories found matching 'docs/_build' 22:54:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:54:06 INFO - Running setup.py install for pep8 22:54:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:54:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:54:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:54:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:54:06 INFO - no previously-included directories found matching 'docs/_build' 22:54:06 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:54:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:54:06 INFO - Cleaning up... 22:54:06 INFO - Return code: 0 22:54:06 INFO - Running post-action listener: _resource_record_post_action 22:54:06 INFO - Running post-action listener: _start_resource_monitoring 22:54:07 INFO - Starting resource monitoring. 22:54:07 INFO - ##### 22:54:07 INFO - ##### Running install step. 22:54:07 INFO - ##### 22:54:07 INFO - Running pre-action listener: _resource_record_pre_action 22:54:07 INFO - Running main action method: install 22:54:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:54:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:54:07 INFO - Reading from file tmpfile_stdout 22:54:07 INFO - Detecting whether we're running mozinstall >=1.0... 22:54:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:54:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:54:07 INFO - Reading from file tmpfile_stdout 22:54:07 INFO - Output received: 22:54:07 INFO - Usage: mozinstall [options] installer 22:54:07 INFO - Options: 22:54:07 INFO - -h, --help show this help message and exit 22:54:07 INFO - -d DEST, --destination=DEST 22:54:07 INFO - Directory to install application into. [default: 22:54:07 INFO - "/builds/slave/test-pgo"] 22:54:07 INFO - --app=APP Application being installed. [default: firefox] 22:54:07 INFO - mkdir: /builds/slave/test-pgo/build/application 22:54:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 22:54:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 22:54:23 INFO - Reading from file tmpfile_stdout 22:54:23 INFO - Output received: 22:54:23 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:54:23 INFO - Running post-action listener: _resource_record_post_action 22:54:23 INFO - ##### 22:54:23 INFO - ##### Running run-tests step. 22:54:23 INFO - ##### 22:54:23 INFO - Running pre-action listener: _resource_record_pre_action 22:54:23 INFO - Running main action method: run_tests 22:54:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:54:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:54:23 INFO - Python 2.7.3 22:54:23 INFO - Return code: 0 22:54:23 INFO - grabbing minidump binary from tooltool 22:54:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:23 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 0x1fdf840>, '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 0x1f4c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f4cb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:54:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 22:54:23 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:54:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:54:23 INFO - Return code: 0 22:54:23 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:54:23 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:54:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:54:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:54:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:54:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:54:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:54:24 INFO - Return code: 0 22:54:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NizjWjVtQ9y8KcmO5ogg2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 22:54:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NizjWjVtQ9y8KcmO5ogg2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:54:24 INFO - Using env: {'DISPLAY': ':0', 22:54:24 INFO - 'HOME': '/home/cltbld', 22:54:24 INFO - 'LANG': 'en_US.UTF-8', 22:54:24 INFO - 'LANGUAGE': 'en_US:en', 22:54:24 INFO - 'LOGNAME': 'cltbld', 22:54:24 INFO - 'MAIL': '/var/mail/cltbld', 22:54:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:54:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:54:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:24 INFO - 'MOZ_NO_REMOTE': '1', 22:54:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:54:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:24 INFO - 'NO_EM_RESTART': '1', 22:54:24 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:24 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:24 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:54:24 INFO - 'SHELL': '/bin/bash', 22:54:24 INFO - 'SHLVL': '1', 22:54:24 INFO - 'TERM': 'linux', 22:54:24 INFO - 'TMOUT': '86400', 22:54:24 INFO - 'USER': 'cltbld', 22:54:24 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1453782510.291007-2031243442', 22:54:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:24 INFO - '_': '/tools/buildbot/bin/python'} 22:54:24 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NizjWjVtQ9y8KcmO5ogg2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:54:24 INFO - mozversion application_buildid: 20160125203202 22:54:24 INFO - mozversion application_changeset: 8160b0c865bff3281a3e8118bce47d099eeb3963 22:54:24 INFO - mozversion application_display_name: Nightly 22:54:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:54:24 INFO - mozversion application_name: Firefox 22:54:24 INFO - mozversion application_remotingname: firefox 22:54:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:54:24 INFO - mozversion application_vendor: Mozilla 22:54:24 INFO - mozversion application_version: 47.0a1 22:54:24 INFO - mozversion platform_buildid: 20160125203202 22:54:24 INFO - mozversion platform_changeset: 8160b0c865bff3281a3e8118bce47d099eeb3963 22:54:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:54:24 INFO - mozversion platform_version: 47.0a1 22:54:24 INFO - using testdate: 1453791264 22:54:24 INFO - actual date: 1453791264 22:54:24 INFO - starting webserver on 'localhost:57939' 22:54:24 INFO - SUITE-START | Running 3 tests 22:54:24 INFO - TEST-START | dromaeo_css 22:54:24 INFO - operating with platform_type : linux_ 22:54:24 INFO - Initialising browser for dromaeo_css test... 22:54:24 INFO - TEST-INFO | started process 10330 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLxFiBe/profile http://localhost:57939/getInfo.html) 22:54:28 INFO - PROCESS | 10330 | 22:54:28 INFO - PROCESS | 10330 | (process:10412): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:54:29 INFO - PROCESS | 10330 | __metrics Screen width/height:1600/1200 22:54:29 INFO - PROCESS | 10330 | colorDepth:24 22:54:29 INFO - PROCESS | 10330 | Browser inner width/height: 1024/697 22:54:29 INFO - PROCESS | 10330 | __metrics 22:54:29 INFO - PROCESS | 10330 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:54:29 INFO - TEST-INFO | 10330: exit 0 22:54:29 INFO - Browser initialized. 22:54:29 INFO - Running cycle 1/1 for dromaeo_css test... 22:54:29 INFO - TEST-INFO | started process 10461 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLxFiBe/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:54:31 INFO - PROCESS | 10461 | 22:54:31 INFO - PROCESS | 10461 | (process:10519): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:54:41 INFO - PROCESS | 10461 | RSS: Main: 152121344 22:54:41 INFO - PROCESS | 10461 | 22:55:31 INFO - PROCESS | 10461 | 1453791331368 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:57:39 INFO - PROCESS | 10461 | Cycle 1(1): loaded http://localhost:57939/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57939/tests/dromaeo/cssquery-ext.html) 22:57:40 INFO - PROCESS | 10461 | RSS: Main: 160694272 22:57:40 INFO - PROCESS | 10461 | 23:00:42 INFO - PROCESS | 10461 | Cycle 1(1): loaded http://localhost:57939/tests/dromaeo/cssquery-ext.html (next: http://localhost:57939/tests/dromaeo/cssquery-jquery.html) 23:00:43 INFO - PROCESS | 10461 | RSS: Main: 155951104 23:00:43 INFO - PROCESS | 10461 | 23:03:45 INFO - PROCESS | 10461 | Cycle 1(1): loaded http://localhost:57939/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57939/tests/dromaeo/cssquery-mootools.html) 23:03:45 INFO - PROCESS | 10461 | RSS: Main: 156123136 23:03:45 INFO - PROCESS | 10461 | 23:06:47 INFO - PROCESS | 10461 | Cycle 1(1): loaded http://localhost:57939/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57939/tests/dromaeo/cssquery-prototype.html) 23:06:48 INFO - PROCESS | 10461 | RSS: Main: 154652672 23:06:48 INFO - PROCESS | 10461 | 23:09:50 INFO - PROCESS | 10461 | Cycle 1(1): loaded http://localhost:57939/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57939/tests/dromaeo/cssquery-yui.html) 23:09:51 INFO - PROCESS | 10461 | RSS: Main: 155865088 23:09:51 INFO - PROCESS | 10461 | 23:12:53 INFO - PROCESS | 10461 | Cycle 1(1): loaded http://localhost:57939/tests/dromaeo/cssquery-yui.html (next: http://localhost:57939/tests/dromaeo/cssquery-dojo.html) 23:12:53 INFO - PROCESS | 10461 | RSS: Main: 159162368 23:12:53 INFO - PROCESS | 10461 | 23:12:53 INFO - PROCESS | 10461 | __start_tp_report 23:12:53 INFO - PROCESS | 10461 | _x_x_mozilla_page_load 23:12:53 INFO - PROCESS | 10461 | _x_x_mozilla_page_load_details 23:12:53 INFO - PROCESS | 10461 | |i|pagename|runs| 23:12:53 INFO - PROCESS | 10461 | |0;dojo.html;3165.6834316568343;3165.715085642293;3201.695838895304;3208.0696597986584;3214.9551395796357;5139.511746384097;5197.532222100011;5200.791968321268;5212.635115541909;5234.162533994561;5210.739463026843;5222.451642577522;5222.608304377178;5264.526192642661;5276.2085687146855;4791.2813078038225;4794.808207671697;4832.371791667096;4909.919817640131;4921.261810728383;4869.269609558577;4875.536824001714;4881.60947124231;4927.605791536686;4976.328195693589;4755.762211889391;4772.4273087229585;4809.182438985364;4849.030193961222;4849.612031037508;4734.4081989751285;4740.241561350167;4741.312509686076;4745.762711864393;4774.689645173053;4675.13510000651;4718.787654555554;4722.8110875564935;4734.976325118387;4758.738269395182;5008.398992120932;5061.974690126526;5140.614453915971;5151.793928242866;5168.173092305213;5659.5755318350875;5679.687617181054;5681.971590142064;5685.886282274373;5686.459786320293;5563.777448902039;5641.379448260688;5728.856778580569;5739.282589676291;5769.855753606152;5285.048691235576;5338.332708411449;5352.090144675414;5369.382521010134;5402.270693456372;5776.33572139201;5783.826485205366;5785.074388097884;5788.855278618068;5809.2738407699035;5517.97917385285;5562.694051827189;5562.833115006556;5617.578681598897;5625.774969001194;5606.85982850432;5647.802326918538;5655.773769049192;5686.516646085046;5686.9715651421475;5595.972020139873;5612.186232996274;5612.691301978349;5627.5779316551425;5642.153676948408;5556.583256255716;5582.7766889323975;5620.57845661577;5641.407652196543;5698.6580805151825;4392.472903251631;4412.117576484716;4427.269500532376;4437.511873693891;4457.621102206284;3907.6873850091924;3937.17319362937;3946.5264168299987;3992.0419099416513;4004.5594984551676;5084.161113416319;5173.663711858717;5288.497592728685;5304.496072873071;5354.625176237626;5682.232898558725;5683.232763576947;5696.772129114789;5699.5725320600295;5701;5218.973905130526;5317.255584218213;5324.946750532523;5329.067413202674;5361.597880159004;4735.479097299294;4739.644526660514;4783.115123702126;4811.735354555463;4837.806487740451;5789.536837053026;5815.651060936358;5824.504917082011;5843.853903652443;5861.1501332307425;5483.698396588226;5547.306586676666;5596.86007849807;5599.32808063035;5645.520130788929;5710.714464276853;5738.139279108167;5741.885162296647;5765.682887441063;5829.621074630136;5496.917546236889;5519.089350257163;5525.696086715269;5547.55619550443;5567.526760225426;5612.943870561242;5636.436356364331;5643.153526970823;5696.544276457957;5699.914501282401;5463.344398672185;5505.834824955257;5529.751161197675;5534.750936207961;5546.140348246028;5439.755211015593;5486.615936884539;5513.117901135799;5514.5864060196445;5518.696471694096;5355.571554275571;5426.07756681373;5438.320209973754;5443.210734443563;5487.533559647474;5450.400455949922;5461.1808228766;5474.178873169057;5512;5534.225208470898;5380.085385484399;5411.83764487066;5425.186222066722;5434.456554344534;5470.398256191896 23:12:53 INFO - PROCESS | 10461 | |1;ext.html;482.27176962786206;523.8559396166052;524.352424755427;558.7122631844601;560.6776103740349;27462.17613471594;34889.82555087224;35046.82476587613;35325.293494130165;35491.112722181955;38029.42955855664;38654.226915461746;38747.41878871819;38755.41866871999;38953.80523097388;8151.470154439972;8391.412601117925;8469.449485783434;8473.872891906627;8483.74548763538;8065.435419520607;8210.958945205266;8237.423380363347;8242.25819676229;8252.46358986667;8226.753197404087;8402.579871006456;8415.579221038954;8417.789555261106;8429.157084291552;8271.751847444586;8280.296174825147;8366.665333386627;8537;8560.828783424358;8338.37462190332;8525.360597955178;8570.27152692022;8588.484690918502;8589;37798;38106;38253;38256.61743382558;38360.42459363112;2722.5099482093215;2962.466755983922;3085.552594873731;3568.50040994261;3642.4900513928073;27871.86064069687;27931.720682793115;28673.426531469464;28738;28882;3337.983310083434;3351.1957130288797;3387.796732196076;3489.2672538766888;3502.369573476773;248892;249002;250468;250625;251434;50536.74731626319;54795.17807232895;55232;55237.44762552404;55398.72300638471;50380.74809625928;58443.41556584465;60592.69703651542;60720;60894.39105608887;13102;13264.734705306033;13265.204087754573;13295.268760218087;13303.600891973063;9856.605735770632;9857.704268871945;9926.652567160114;10001.149902258245;10009.499525023719;18404.539886502946;18567.90716046411;18646.813531864507;18661.720074198896;19318.227270909287;7045.964770176116;7379.8155046124275;7387.039684840936;7390.482666213314;7391.8152046199275;875.4703404440222;878.5607196401799;900.9054049324858;970.5244430229137;1081.34578579958;27839.164825055283;27875.860620696767;28099.719002810118;28373.85813070963;28942;961.1493827962304;969.8739163908647;980.8626792248948;1003.6764889281291;1051.9894801051892;13414;13575.717644240176;13689.931550342384;13707.862921370659;13762.518311859038;309277;316698;317403;317747;318010;48045.75977120092;48249.27626085612;49311.260331095065;49371.75314123406;49411;1270.2378572856212;1282.076904628666;1286.350393051503;1301.6160232731368;1306.3337697774014;25891.870540647174;27214;27320.45359092767;27599.862000689867;27764;43026.78486607547;43649;43679.34480982724;43813.56186438095;43853.342199867664;306467;307554;309310;311550;311800;29215.7078429213;30050.849745752006;30440.086797396114;30550.388992219585;30627;35594.46608300826;35990.46014309735;35999;36361.63638363582;36646.816765916;31277.530837037008;31481.8425907869;31675.20811979719;31821.20446988844;32177.678223218405;31713.682863171074;32025.839870800497;32311.51532727058;32443.675563244065;34357.65642343645;31631;31640;32020;32028.19929501781;34106.82946585251;27157.72842271631;27215.503147327086;28845.855770721013;29215.269618259714;29650.703492964793;22361.578616009007;22899.54200915939;23916.162934297216;24241.878790605933;24434.51130977335 23:12:53 INFO - PROCESS | 10461 | |2;jquery.html;340.1937408342231;340.8091468777485;342.5085003020664;342.68815378006013;344.99999999999994;15411.07533547988;15735.21323933803;16533.586660333498;17382.304707811705;17444.3022279109;14636.41454341825;14944.925275373607;15112.848871511282;15132.773008404884;15207.315670794813;4289.399484072233;4453.198424283628;4458.754768487732;4473.351364052211;4476.1271552047365;4349.34759786033;4379.4525684289465;4421.38100665907;4607.7004994675235;4616.838410655628;4629.930551041737;4631.4442266927845;5971.850703732398;6223.315435302113;6231.376862313778;6160.383961603849;6197.101420294055;6241.251049873998;6687.164104486939;6701.961196014626;6179.721912513947;6410.070539771754;6419;6431.8392040198905;6456.644884531349;19904.402867913985;20399.796002039937;20757.792422075738;21516.56966860654;22205.777942220695;1971.447994561525;2045.98977005114;2109.778473260301;2170.945726356838;2287.656851472276;13645;13698.931505342509;13717.794233086512;13795.379207935666;14393.856061439355;1906.7044608085769;1912.531429799694;1926.3450426854936;1945.1538580717433;1968.5570746582048;50301.24548131781;60444.69777651084;61558.38441615571;63327.366726332606;63605.363946360405;14445.133292002514;14776.33506492189;14853.554393368217;14857.331420086122;14956.551303460914;22085.668714969288;22229.666555001688;22415.887920560293;22444.88777556102;22528.986195621237;8050.315723163597;8083.555404452694;8127.796805079802;8207.220314070153;8226.218509241613;6399.968000160063;6436.903446448307;6463.57986730861;6496.700659867951;6547.574407663486;7415.666295016629;7471.252874712485;7488.4009279257525;7505.324520793155;7605.733799316998;1674.840890115437;1712.8715346349074;1785.544686105035;3074.815511069343;3089.3203495231014;839.0770152831958;841.7306461932245;896.5965315607872;932.6549176804625;1011.701548043329;15446.845531544766;15776.211189440482;15946.760798588031;16292.51122466328;16398;836.431226765793;880.5949263338807;902.4224496322358;904.3172404834309;922.9123233292961;9034.728958131267;9206.76983075415;9385.765355866159;9454.527273636428;9511.953685094633;359181;362141;366041;489984;492658;70276;71494.64252678704;72365.27634723691;74278;74690.62654686692;1095.3592148593002;1098.3025778630627;1104.1222228328497;1115.9677298499018;1131.3777422417802;13453.327333633475;14625.488107916171;14916.328765205375;14917.627059323604;14943.327550260046;27241.591376128978;28180.85909570439;31718.841405792824;33007.83496082504;34052.65947340594;38617.80691096639;39440.40839387354;40682.79658601688;40786.796066020666;40806.591934081465;6490.772822951174;6668.933310667026;6711.697973591103;6765.052892595139;6874.759383421556;5694.658320500783;6305.621662700252;8554.743357699279;10811.297265677706;10825.133989280996;6379;6395.552311338161;6555.868882622416;6618.801435956929;6739.42714869222;6683.933160668331;6869.690863911036;6973.3375329343635;6981.8254543634785;7060.54106483077;6653.833654158685;6798.524103312919;6806.455483561204;6808.863822723617;6847.726090956506;9198.356115071882;9264.907350926405;9316.6273349068;9335.953320233355;9437;9764.170045545923;9814.75463113428;9930.25523085786;9984.900150998397;10003.799924001625 23:12:53 INFO - PROCESS | 10461 | |3;mootools.html;1420.3324437514368;1455.279636579893;1583.5486886237425;1716.828317168284;1741.6516696660663;6985.441164706824;7097.89353159703;7141.85716285674;7197.7480788172425;7293.4894557381;7109.111361079865;7135.2864713528625;7158.749443769456;7186.820329491766;7215.747448839292;2235.0501037059225;2258.367657056027;2276.1236923784295;2281.235786011688;2283.9200627978025;2239.1155493580027;2246.629306164489;2278.646809744492;2291.140822191678;2297.3797074789795;2157.4498502881743;2226.1318085946496;2230.5761905237955;2238.462768935452;2258.2660635293514;2215.324326080545;2241.9775802241934;2253.4479052632128;2256.255435706213;2256.4584499720113;2256.4020534558354;2270.579942710604;2272.556851413975;2280.3842962400226;2282.2696737044153;7205.963970180168;7224.349808517206;7240.420766338681;7253.383462405702;7286.016387787634;4376.496702879178;4468.061707041526;4473.261911784552;4481.2381895077915;4491.505934347219;2802.2153796936686;2894.7828912831624;2904.157794239668;2914.897978570761;2920.7663386928994;869.7912500999778;880.216607219575;896.4934811831295;905.3571963905634;913.7441516375426;9106.27149828012;9240.029796871298;9246.121618446305;9255.120763527455;9269.073092690744;3858;3864.4976153099915;3931.1548017176447;3948;3950.229705207457;7702.114256860421;7869.960650196713;7893.447458677952;7959.681612735426;7973.282404583615;4322.481302243751;4324.805383757738;4339.414179085783;4347.782610869507;4366.628836548865;3926.0577461409057;3955.011247188203;3971.8014099295497;3977.840886364513;3995.6803455724053;3232.3212125453447;3248.464003439406;3262.217067903686;3293.91765205867;3302.1579497228054;978.9706308810747;981.8625392445064;981.9361741486781;982.52838637453;986.2800155886243;914.5107367558325;914.6112902016616;930.8603709443502;998.3161534348994;1086.2884810449168;6667.399934005963;6738.932610673928;6756.223034351015;6763.898541521881;6765.729370825112;1078.8381742738652;1149.3965668024355;1172.2556176827604;1189.5717541684987;1194.8984336331334;5187.351581052369;5247.475252474722;5315.255864179018;5321.3880403754065;5338.172583249602;8257.545834979133;8283.544405057659;8336.458130221516;8514.829703405898;8595.18345757152;8190.754277371689;8274.8345033099;8283.710070147516;8290.87563686533;8300.875486867702;6607.008948657836;6610.3720146586;6676.899846502306;6726.293739157318;6749.797506074826;7015.333543313377;7016.298370163147;7059.329363710439;7086.39765619928;7119.430445564239;7708.49894756839;7801.531908085533;7928.84142317162;7943.364530837403;7957.124716281321;7960.601969901598;8078.515289082674;8358.080611132893;8455.619497122767;8459.534725590152;6588.868222635616;6657.367550082734;6747.224069231905;6759.087523184307;6766.695498702668;6779.932200678128;6823.010663453871;6832.521723479309;6852.965735171292;6884.380405763505;6141.938580614136;6274.6548939808745;6332.145160403286;6336.619802811846;6558.44253238461;6308.84227894288;6342.112104305494;6345.4923606112325;6501.772437964649;6558.901616475852;6079.422454866781;6187.504999600112;6237.625742455286;6288.874222515616;6294.4964402846745;5833;5860.824175274749;5863.2670916135485;5865.970670146622;5882.294124705063;5891.734871930687;5910.024845900378;5918.201042859159;5954.136650185786;5958.106284057426 23:12:53 INFO - PROCESS | 10461 | |4;prototype.html;296.5936666766529;306.60907343137507;311.1676265988482;315.3755563983311;315.4400938334456;6271.937280627192;6283.874322513547;6341.239051313849;6435.903461448071;6505.4145126938565;6225.782097626584;6259.749610015594;6264.749410023605;6265.843353916143;6291.1821463209835;4557.134144512532;4664.230401983668;4739.691920025204;4741.549552792488;4744.027474367764;4673.462551806551;4692.8122875084955;4698.389209402773;4700.318453824193;4704.882377940545;4648.279516674921;4652.837150699726;4653.418322709661;4661.044485880387;4675.4155730533685;4646.628269738413;4675.275332323478;4680.4149481314835;4680.555347242007;4688.296755486705;3851.056491159684;3979.4428779970826;4012.859549915739;4025.054112283611;4030.979845100785;5800.709964501758;5906.438888305604;5930.8813823723285;5931.733072011727;5936.347001829795;5406.243125962368;5416.458354164592;5422.566194704415;5423.918641220345;5432.456754324576;6598.37315455031;6604.900926486107;6613.966930165367;6628.403443690091;6644.634545100018;4283.079137985348;4400.273954797454;4401.075774087413;4410.647148228134;4434.911301773978;6815.454763618898;6868.965655171743;6878;6884.862302753967;6908.169335126146;4439.711418757771;4443.7111587746695;4447.310666846644;4454.420925279693;4456.376107344974;4478.820847166142;4494.820207191741;4501.932471012938;4502.054568540643;4510.684252102321;5195.246689230116;5346.545543628835;5384.19237114436;5389.245505629215;5390.541803946709;6606.735730570724;6623.039659249382;6632.104665870046;6661.800145995628;6667.566608170453;1618.4578166314182;1628.5033064915315;1636.116497091581;1640.0405762628757;1642.1707037945762;1047.9371237725761;1049.275999560301;1066.9946650266854;1069.2141276162015;1082.2316155529504;6239.188905442264;6246.500279977591;6303.338149494329;6304.810855674337;6307.653079080695;6798.626075565891;6809.285025072296;6836.658167091626;6843.110395648534;6850.417714494324;6141.57009009374;6218.284897236786;6233.532485063548;6258.561900667;6272.18461599989;3691.5201023866725;3705.4256590228556;3722.2927643747603;3732.160263940646;3736.3461394255896;7059.18819335783;7127.322904324081;7187.101612298463;7200.891986620205;7203.315685009916;6981.82545436358;7042.119735033121;7055.8236044098285;7059.682314295869;7063.646817659096;7069.787906362714;7224.844024955982;7244.348008679139;7245.963770181115;7263.055802745609;6779.762708305186;6890;6910.7581234656545;6914.827129321807;6915.861682766216;6797.354251346114;6808.183018037867;6831.248562658203;6835.350641689031;6846.383825455733;7092.397146242627;7216.314450127229;7218.242084581043;7225.710971561079;7241.058662373857;4473.955260447354;4487.371767952554;4492.618127459203;4512.774361281857;4523.411956445641;6786.016027676058;6818.386345228953;6866.622335771581;6890.586564806128;6908.930910690829;6571.737130514726;6642.5018123641885;6642.90035649456;6651.600903945779;6681.899771503334;6608.041833934149;6613.272540020497;6618.238902526078;6627.900581491185;6655.134832471941;6531.11829902957;6535.869282614416;6538.83652908662;6549.279579246184;6575.4410875076155;6557.082008518906;6730.192376914802;6730.899036514358;6737.090492783607;6741.22475915276;6443.259025212161;6511.218653761579;6518.956966885466;6519.1199188110895;6545.901811472737 23:12:53 INFO - PROCESS | 10461 | |5;yui.html;616.5529990756702;626.5520153090539;640.5292110298932;772.4824367673656;802.169754304295;12034.69913252168;12204.26774393537;12217.938910305436;12297.508099676013;12343.876561234385;12000.759984800321;12259.877401225986;12294.200876943014;12307.753844923096;12315.69210769729;769.6613490064382;774.28765535707;781.6287263549825;782.1162086841861;782.8825676148595;760.6805141840413;768.1780494870491;783.5847001089431;787.6258777080898;790.4782843323408;806.6087947345533;808.107041718901;812.5612169428501;813.0365516862507;814.2183503836295;800.0519384529351;803.9517628942282;804.6499772598938;805.3677862877643;809.2069771623783;587.9647221166701;593.0955293177896;594.7472324262214;596.1028651878938;596.4095545410013;12385.93807030959;12411.379431028503;12491.875081249253;12495.375231238402;12495.687607809787;11561.595344162914;11674.416279186007;11692.590759323468;11916;12235.93882030593;10188.388696678223;10292.794144117152;10313.742156446075;10354.741131471697;10456.424896630682;3453.4129198036144;3460.480927860816;3531.876384326562;3531.964680353215;3598.3702852000797;47266.29100563494;47553.286700699515;47678.76160619175;47719;47721.76139119282;8577.142285771373;8676.6529338827;8703.39076264668;8731.257843083282;8870.645174193089;14227.644308892153;14232.85767142336;14302.141871487744;14316.141031538142;14319.92840035814;7041;7043.366097051187;7069.363757261871;7118.074650295428;7204.919262110725;3724.6647801697977;3739.775613463201;3836.4820749199057;3888.377859542516;3954.940675889864;2790.107165706954;2805.8877644893973;2815.352468932116;2819.6052552642645;2821.520341541943;503.1094961917459;503.76574892674347;510.91059064663534;513.6994858008107;524.8084449176023;576.1012820000813;578.0721941284262;588.0062694047132;613.3866133866134;616.1774031667774;8034.864898518242;8098.046223492981;8258.256756891788;8286.4199506034;8430.626394644594;604.4620287943734;643.3020173112226;665.3379887012453;682.3654001778393;694.7290556682898;3724.6089160638285;3725.795081270502;3970.82131304092;4056.0265536271672;4129.876103716893;50859.745701271255;53767.731161343945;53882.461175388526;54030.729846350514;54327.72836135794;47592.286115708295;48552.543423697345;48823.511764882605;49168.754156229705;49754.751226243636;42890.78554607207;43603.56396435995;43758.781206094405;44012.779936100116;44231.89420264583;7866.685332586632;8305.833883322179;8474.110218427222;8774;8926.821463570823;32985;33009.33981320408;33015.17462063468;33059.33881322312;33446.83276583699;40473;41957;42216.577834221265;42379.364309534765;42805.35791963185;9654.324197306121;9708.854367184356;10056.145227655732;10116.747081323027;10660.413677247825;10599.366579629477;10763.085137763377;10769.215414250571;10787.406692631981;10985.340879547253;10698.358098514114;10818.242723009314;10925.890741092488;11008.559657613605;11177.441127943408;10204.489775511343;10372.429516376671;10475.371477711056;10528.78942421132;10609.8939010612;10513.526891289757;10851.294665846695;11040.282381645167;11301.321920684784;11465.369404682822;8747.781305467413;8819.60311785984;8875.423097498642;9073.90926090757;9323.673671421468;8702.140465898305;9113;9128.224100951493;9270.737241018172;9271.43091704266 23:12:53 INFO - PROCESS | 10461 | __end_tp_report 23:12:53 INFO - PROCESS | 10461 | __start_cc_report 23:12:53 INFO - PROCESS | 10461 | _x_x_mozilla_cycle_collect,316 23:12:53 INFO - PROCESS | 10461 | __end_cc_report 23:12:53 INFO - PROCESS | 10461 | __startTimestamp1453792373896__endTimestamp 23:12:53 INFO - PROCESS | 10461 | 23:12:53 INFO - PROCESS | 10461 | ------- Summary: start ------- 23:12:53 INFO - PROCESS | 10461 | Number of tests: 6 23:12:53 INFO - PROCESS | 10461 | 23:12:53 INFO - PROCESS | 10461 | [#0] dojo.html Cycles:165 Average:5237.93 Median:5439.76 stddev:565.72 (10.4%) stddev-sans-first:543.60 23:12:53 INFO - PROCESS | 10461 | Values: 3165.7 3165.7 3201.7 3208.1 3215.0 5139.5 5197.5 5200.8 5212.6 5234.2 5210.7 5222.5 5222.6 5264.5 5276.2 4791.3 4794.8 4832.4 4909.9 4921.3 4869.3 4875.5 4881.6 4927.6 4976.3 4755.8 4772.4 4809.2 4849.0 4849.6 4734.4 4740.2 4741.3 4745.8 4774.7 4675.1 4718.8 4722.8 4735.0 4758.7 5008.4 5062.0 5140.6 5151.8 5168.2 5659.6 5679.7 5682.0 5685.9 5686.5 5563.8 5641.4 5728.9 5739.3 5769.9 5285.0 5338.3 5352.1 5369.4 5402.3 5776.3 5783.8 5785.1 5788.9 5809.3 5518.0 5562.7 5562.8 5617.6 5625.8 5606.9 5647.8 5655.8 5686.5 5687.0 5596.0 5612.2 5612.7 5627.6 5642.2 5556.6 5582.8 5620.6 5641.4 5698.7 4392.5 4412.1 4427.3 4437.5 4457.6 3907.7 3937.2 3946.5 3992.0 4004.6 5084.2 5173.7 5288.5 5304.5 5354.6 5682.2 5683.2 5696.8 5699.6 5701.0 5219.0 5317.3 5324.9 5329.1 5361.6 4735.5 4739.6 4783.1 4811.7 4837.8 5789.5 5815.7 5824.5 5843.9 5861.2 5483.7 5547.3 5596.9 5599.3 5645.5 5710.7 5738.1 5741.9 5765.7 5829.6 5496.9 5519.1 5525.7 5547.6 5567.5 5612.9 5636.4 5643.2 5696.5 5699.9 5463.3 5505.8 5529.8 5534.8 5546.1 5439.8 5486.6 5513.1 5514.6 5518.7 5355.6 5426.1 5438.3 5443.2 5487.5 5450.4 5461.2 5474.2 5512.0 5534.2 5380.1 5411.8 5425.2 5434.5 5470.4 23:12:53 INFO - PROCESS | 10461 | 23:12:53 INFO - PROCESS | 10461 | [#1] ext.html Cycles:180 Average:44565.00 Median:34232.24 stddev:76862.30 (224.5%) stddev-sans-first:77006.65 23:12:53 INFO - PROCESS | 10461 | Values: 482.3 523.9 524.4 558.7 560.7 27462.2 34889.8 35046.8 35325.3 35491.1 38029.4 38654.2 38747.4 38755.4 38953.8 8151.5 8391.4 8469.4 8473.9 8483.7 8065.4 8211.0 8237.4 8242.3 8252.5 8226.8 8402.6 8415.6 8417.8 8429.2 8271.8 8280.3 8366.7 8537.0 8560.8 8338.4 8525.4 8570.3 8588.5 8589.0 37798.0 38106.0 38253.0 38256.6 38360.4 2722.5 2962.5 3085.6 3568.5 3642.5 27871.9 27931.7 28673.4 28738.0 28882.0 3338.0 3351.2 3387.8 3489.3 3502.4 248892.0 249002.0 250468.0 250625.0 251434.0 50536.7 54795.2 55232.0 55237.4 55398.7 50380.7 58443.4 60592.7 60720.0 60894.4 13102.0 13264.7 13265.2 13295.3 13303.6 9856.6 9857.7 9926.7 10001.1 10009.5 18404.5 18567.9 18646.8 18661.7 19318.2 7046.0 7379.8 7387.0 7390.5 7391.8 875.5 878.6 900.9 970.5 1081.3 27839.2 27875.9 28099.7 28373.9 28942.0 961.1 969.9 980.9 1003.7 1052.0 13414.0 13575.7 13689.9 13707.9 13762.5 309277.0 316698.0 317403.0 317747.0 318010.0 48045.8 48249.3 49311.3 49371.8 49411.0 1270.2 1282.1 1286.4 1301.6 1306.3 25891.9 27214.0 27320.5 27599.9 27764.0 43026.8 43649.0 43679.3 43813.6 43853.3 306467.0 307554.0 309310.0 311550.0 311800.0 29215.7 30050.8 30440.1 30550.4 30627.0 35594.5 35990.5 35999.0 36361.6 36646.8 31277.5 31481.8 31675.2 31821.2 32177.7 31713.7 32025.8 32311.5 32443.7 34357.7 31631.0 31640.0 32020.0 32028.2 34106.8 27157.7 27215.5 28845.9 29215.3 29650.7 22361.6 22899.5 23916.2 24241.9 24434.5 23:12:53 INFO - PROCESS | 10461 | 23:12:53 INFO - PROCESS | 10461 | [#2] jquery.html Cycles:180 Average:24281.79 Median:4612.27 stddev:68663.82 (1488.7%) stddev-sans-first:68832.91 23:12:53 INFO - PROCESS | 10461 | Values: 340.2 340.8 342.5 342.7 345.0 15411.1 15735.2 16533.6 17382.3 17444.3 14636.4 14944.9 15112.8 15132.8 15207.3 4289.4 4453.2 4458.8 4473.4 4476.1 4349.3 4379.5 4421.4 4607.7 4616.8 4629.9 4631.4 5971.9 6223.3 6231.4 6160.4 6197.1 6241.3 6687.2 6702.0 6179.7 6410.1 6419.0 6431.8 6456.6 19904.4 20399.8 20757.8 21516.6 22205.8 1971.4 2046.0 2109.8 2170.9 2287.7 13645.0 13698.9 13717.8 13795.4 14393.9 1906.7 1912.5 1926.3 1945.2 1968.6 50301.2 60444.7 61558.4 63327.4 63605.4 14445.1 14776.3 14853.6 14857.3 14956.6 22085.7 22229.7 22415.9 22444.9 22529.0 8050.3 8083.6 8127.8 8207.2 8226.2 6400.0 6436.9 6463.6 6496.7 6547.6 7415.7 7471.3 7488.4 7505.3 7605.7 1674.8 1712.9 1785.5 3074.8 3089.3 839.1 841.7 896.6 932.7 1011.7 15446.8 15776.2 15946.8 16292.5 16398.0 836.4 880.6 902.4 904.3 922.9 9034.7 9206.8 9385.8 9454.5 9512.0 359181.0 362141.0 366041.0 489984.0 492658.0 70276.0 71494.6 72365.3 74278.0 74690.6 1095.4 1098.3 1104.1 1116.0 1131.4 13453.3 14625.5 14916.3 14917.6 14943.3 27241.6 28180.9 31718.8 33007.8 34052.7 38617.8 39440.4 40682.8 40786.8 40806.6 6490.8 6668.9 6711.7 6765.1 6874.8 5694.7 6305.6 8554.7 10811.3 10825.1 6379.0 6395.6 6555.9 6618.8 6739.4 6683.9 6869.7 6973.3 6981.8 7060.5 6653.8 6798.5 6806.5 6808.9 6847.7 9198.4 9264.9 9316.6 9336.0 9437.0 9764.2 9814.8 9930.3 9984.9 10003.8 23:12:53 INFO - PROCESS | 10461 | 23:12:53 INFO - PROCESS | 10461 | [#3] mootools.html Cycles:180 Average:5032.61 Median:6339.37 stddev:2527.64 (39.9%) stddev-sans-first:2520.15 23:12:53 INFO - PROCESS | 10461 | Values: 1420.3 1455.3 1583.5 1716.8 1741.7 6985.4 7097.9 7141.9 7197.7 7293.5 7109.1 7135.3 7158.7 7186.8 7215.7 2235.1 2258.4 2276.1 2281.2 2283.9 2239.1 2246.6 2278.6 2291.1 2297.4 2157.4 2226.1 2230.6 2238.5 2258.3 2215.3 2242.0 2253.4 2256.3 2256.5 2256.4 2270.6 2272.6 2280.4 2282.3 7206.0 7224.3 7240.4 7253.4 7286.0 4376.5 4468.1 4473.3 4481.2 4491.5 2802.2 2894.8 2904.2 2914.9 2920.8 869.8 880.2 896.5 905.4 913.7 9106.3 9240.0 9246.1 9255.1 9269.1 3858.0 3864.5 3931.2 3948.0 3950.2 7702.1 7870.0 7893.4 7959.7 7973.3 4322.5 4324.8 4339.4 4347.8 4366.6 3926.1 3955.0 3971.8 3977.8 3995.7 3232.3 3248.5 3262.2 3293.9 3302.2 979.0 981.9 981.9 982.5 986.3 914.5 914.6 930.9 998.3 1086.3 6667.4 6738.9 6756.2 6763.9 6765.7 1078.8 1149.4 1172.3 1189.6 1194.9 5187.4 5247.5 5315.3 5321.4 5338.2 8257.5 8283.5 8336.5 8514.8 8595.2 8190.8 8274.8 8283.7 8290.9 8300.9 6607.0 6610.4 6676.9 6726.3 6749.8 7015.3 7016.3 7059.3 7086.4 7119.4 7708.5 7801.5 7928.8 7943.4 7957.1 7960.6 8078.5 8358.1 8455.6 8459.5 6588.9 6657.4 6747.2 6759.1 6766.7 6779.9 6823.0 6832.5 6853.0 6884.4 6141.9 6274.7 6332.1 6336.6 6558.4 6308.8 6342.1 6345.5 6501.8 6558.9 6079.4 6187.5 6237.6 6288.9 6294.5 5833.0 5860.8 5863.3 5866.0 5882.3 5891.7 5910.0 5918.2 5954.1 5958.1 23:12:53 INFO - PROCESS | 10461 | 23:12:53 INFO - PROCESS | 10461 | [#4] prototype.html Cycles:180 Average:5505.02 Median:6272.06 stddev:1717.16 (27.4%) stddev-sans-first:1676.89 23:12:53 INFO - PROCESS | 10461 | Values: 296.6 306.6 311.2 315.4 315.4 6271.9 6283.9 6341.2 6435.9 6505.4 6225.8 6259.7 6264.7 6265.8 6291.2 4557.1 4664.2 4739.7 4741.5 4744.0 4673.5 4692.8 4698.4 4700.3 4704.9 4648.3 4652.8 4653.4 4661.0 4675.4 4646.6 4675.3 4680.4 4680.6 4688.3 3851.1 3979.4 4012.9 4025.1 4031.0 5800.7 5906.4 5930.9 5931.7 5936.3 5406.2 5416.5 5422.6 5423.9 5432.5 6598.4 6604.9 6614.0 6628.4 6644.6 4283.1 4400.3 4401.1 4410.6 4434.9 6815.5 6869.0 6878.0 6884.9 6908.2 4439.7 4443.7 4447.3 4454.4 4456.4 4478.8 4494.8 4501.9 4502.1 4510.7 5195.2 5346.5 5384.2 5389.2 5390.5 6606.7 6623.0 6632.1 6661.8 6667.6 1618.5 1628.5 1636.1 1640.0 1642.2 1047.9 1049.3 1067.0 1069.2 1082.2 6239.2 6246.5 6303.3 6304.8 6307.7 6798.6 6809.3 6836.7 6843.1 6850.4 6141.6 6218.3 6233.5 6258.6 6272.2 3691.5 3705.4 3722.3 3732.2 3736.3 7059.2 7127.3 7187.1 7200.9 7203.3 6981.8 7042.1 7055.8 7059.7 7063.6 7069.8 7224.8 7244.3 7246.0 7263.1 6779.8 6890.0 6910.8 6914.8 6915.9 6797.4 6808.2 6831.2 6835.4 6846.4 7092.4 7216.3 7218.2 7225.7 7241.1 4474.0 4487.4 4492.6 4512.8 4523.4 6786.0 6818.4 6866.6 6890.6 6908.9 6571.7 6642.5 6642.9 6651.6 6681.9 6608.0 6613.3 6618.2 6627.9 6655.1 6531.1 6535.9 6538.8 6549.3 6575.4 6557.1 6730.2 6730.9 6737.1 6741.2 6443.3 6511.2 6519.0 6519.1 6545.9 23:12:53 INFO - PROCESS | 10461 | 23:12:53 INFO - PROCESS | 10461 | [#5] yui.html Cycles:180 Average:12942.11 Median:47635.52 stddev:15123.23 (31.7%) stddev-sans-first:15137.33 23:12:53 INFO - PROCESS | 10461 | Values: 616.6 626.6 640.5 772.5 802.2 12034.7 12204.3 12217.9 12297.5 12343.9 12000.8 12259.9 12294.2 12307.8 12315.7 769.7 774.3 781.6 782.1 782.9 760.7 768.2 783.6 787.6 790.5 806.6 808.1 812.6 813.0 814.2 800.1 804.0 804.6 805.4 809.2 588.0 593.1 594.7 596.1 596.4 12385.9 12411.4 12491.9 12495.4 12495.7 11561.6 11674.4 11692.6 11916.0 12235.9 10188.4 10292.8 10313.7 10354.7 10456.4 3453.4 3460.5 3531.9 3532.0 3598.4 47266.3 47553.3 47678.8 47719.0 47721.8 8577.1 8676.7 8703.4 8731.3 8870.6 14227.6 14232.9 14302.1 14316.1 14319.9 7041.0 7043.4 7069.4 7118.1 7204.9 3724.7 3739.8 3836.5 3888.4 3954.9 2790.1 2805.9 2815.4 2819.6 2821.5 503.1 503.8 510.9 513.7 524.8 576.1 578.1 588.0 613.4 616.2 8034.9 8098.0 8258.3 8286.4 8430.6 604.5 643.3 665.3 682.4 694.7 3724.6 3725.8 3970.8 4056.0 4129.9 50859.7 53767.7 53882.5 54030.7 54327.7 47592.3 48552.5 48823.5 49168.8 49754.8 42890.8 43603.6 43758.8 44012.8 44231.9 7866.7 8305.8 8474.1 8774.0 8926.8 32985.0 33009.3 33015.2 33059.3 33446.8 40473.0 41957.0 42216.6 42379.4 42805.4 9654.3 9708.9 10056.1 10116.7 10660.4 10599.4 10763.1 10769.2 10787.4 10985.3 10698.4 10818.2 10925.9 11008.6 11177.4 10204.5 10372.4 10475.4 10528.8 10609.9 10513.5 10851.3 11040.3 11301.3 11465.4 8747.8 8819.6 8875.4 9073.9 9323.7 8702.1 9113.0 9128.2 9270.7 9271.4 23:12:53 INFO - PROCESS | 10461 | -------- Summary: end -------- 23:12:53 INFO - PROCESS | 10461 | 23:12:54 INFO - TEST-INFO | 10461: exit 0 23:12:54 INFO - TEST-OK | dromaeo_css | took 1109755ms 23:12:54 INFO - TEST-START | kraken 23:12:54 INFO - operating with platform_type : linux_ 23:12:54 INFO - Initialising browser for kraken test... 23:12:54 INFO - TEST-INFO | started process 10703 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWDE2O3/profile http://localhost:57939/getInfo.html) 23:12:57 INFO - PROCESS | 10703 | 23:12:57 INFO - PROCESS | 10703 | (process:10773): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:12:58 INFO - PROCESS | 10703 | __metrics Screen width/height:1600/1200 23:12:58 INFO - PROCESS | 10703 | colorDepth:24 23:12:58 INFO - PROCESS | 10703 | Browser inner width/height: 1024/697 23:12:58 INFO - PROCESS | 10703 | __metrics 23:12:58 INFO - PROCESS | 10703 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:12:59 INFO - TEST-INFO | 10703: exit 0 23:12:59 INFO - Browser initialized. 23:12:59 INFO - Running cycle 1/1 for kraken test... 23:12:59 INFO - TEST-INFO | started process 10822 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWDE2O3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:13:00 INFO - PROCESS | 10822 | 23:13:00 INFO - PROCESS | 10822 | (process:10880): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:13:11 INFO - PROCESS | 10822 | RSS: Main: 152231936 23:13:11 INFO - PROCESS | 10822 | 23:13:13 INFO - PROCESS | 10822 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57939/tests/kraken/driver.html?testName=audio-beat-detection) 23:13:14 INFO - PROCESS | 10822 | RSS: Main: 155418624 23:13:14 INFO - PROCESS | 10822 | 23:13:17 INFO - PROCESS | 10822 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57939/tests/kraken/driver.html?testName=audio-dft) 23:13:17 INFO - PROCESS | 10822 | RSS: Main: 159178752 23:13:17 INFO - PROCESS | 10822 | 23:13:20 INFO - PROCESS | 10822 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57939/tests/kraken/driver.html?testName=audio-fft) 23:13:21 INFO - PROCESS | 10822 | RSS: Main: 151351296 23:13:21 INFO - PROCESS | 10822 | 23:13:23 INFO - PROCESS | 10822 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57939/tests/kraken/driver.html?testName=audio-oscillator) 23:13:23 INFO - PROCESS | 10822 | RSS: Main: 152580096 23:13:23 INFO - PROCESS | 10822 | 23:13:26 INFO - PROCESS | 10822 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57939/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:13:26 INFO - PROCESS | 10822 | RSS: Main: 152928256 23:13:26 INFO - PROCESS | 10822 | 23:13:29 INFO - PROCESS | 10822 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57939/tests/kraken/driver.html?testName=imaging-darkroom) 23:13:30 INFO - PROCESS | 10822 | RSS: Main: 151568384 23:13:30 INFO - PROCESS | 10822 | 23:13:33 INFO - PROCESS | 10822 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57939/tests/kraken/driver.html?testName=imaging-desaturate) 23:13:34 INFO - PROCESS | 10822 | RSS: Main: 154202112 23:13:34 INFO - PROCESS | 10822 | 23:13:37 INFO - PROCESS | 10822 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57939/tests/kraken/driver.html?testName=json-parse-financial) 23:13:37 INFO - PROCESS | 10822 | RSS: Main: 154583040 23:13:37 INFO - PROCESS | 10822 | 23:13:39 INFO - PROCESS | 10822 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57939/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:13:39 INFO - PROCESS | 10822 | RSS: Main: 155422720 23:13:39 INFO - PROCESS | 10822 | 23:13:41 INFO - PROCESS | 10822 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57939/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:13:42 INFO - PROCESS | 10822 | RSS: Main: 155246592 23:13:42 INFO - PROCESS | 10822 | 23:13:44 INFO - PROCESS | 10822 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57939/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:13:44 INFO - PROCESS | 10822 | RSS: Main: 155938816 23:13:44 INFO - PROCESS | 10822 | 23:13:47 INFO - PROCESS | 10822 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57939/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:13:47 INFO - PROCESS | 10822 | RSS: Main: 155410432 23:13:47 INFO - PROCESS | 10822 | 23:13:50 INFO - PROCESS | 10822 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57939/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:13:51 INFO - PROCESS | 10822 | RSS: Main: 156106752 23:13:51 INFO - PROCESS | 10822 | 23:13:52 INFO - PROCESS | 10822 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57939/tests/kraken/driver.html?testName=ai-astar) 23:13:53 INFO - PROCESS | 10822 | RSS: Main: 156659712 23:13:53 INFO - PROCESS | 10822 | 23:13:53 INFO - PROCESS | 10822 | __start_tp_report 23:13:53 INFO - PROCESS | 10822 | _x_x_mozilla_page_load 23:13:53 INFO - PROCESS | 10822 | _x_x_mozilla_page_load_details 23:13:53 INFO - PROCESS | 10822 | |i|pagename|runs| 23:13:53 INFO - PROCESS | 10822 | |0;ai-astar;110;106;112;110;112;123;112;111;112;110 23:13:53 INFO - PROCESS | 10822 | |1;audio-beat-detection;155;129;163;174;130;154;147;130;164;132 23:13:53 INFO - PROCESS | 10822 | |2;audio-dft;163;163;162;164;162;162;161;164;168;162 23:13:53 INFO - PROCESS | 10822 | |3;audio-fft;72;74;73;74;76;150;74;76;72;74 23:13:53 INFO - PROCESS | 10822 | |4;audio-oscillator;96;96;152;96;96;97;148;96;97;138 23:13:53 INFO - PROCESS | 10822 | |5;imaging-gaussian-blur;118;116;115;116;116;115;116;114;116;116 23:13:53 INFO - PROCESS | 10822 | |6;imaging-darkroom;147;147;147;146;148;146;148;147;146;147 23:13:53 INFO - PROCESS | 10822 | |7;imaging-desaturate;100;96;96;96;98;96;97;97;96;97 23:13:53 INFO - PROCESS | 10822 | |8;json-parse-financial;61;61;65;60;63;62;58;61;76;61 23:13:53 INFO - PROCESS | 10822 | |9;json-stringify-tinderbox;67;69;67;67;69;68;69;67;67;70 23:13:53 INFO - PROCESS | 10822 | |10;stanford-crypto-aes;84;83;87;84;85;84;91;85;91;84 23:13:53 INFO - PROCESS | 10822 | |11;stanford-crypto-ccm;120;118;120;125;119;123;122;122;117;126 23:13:53 INFO - PROCESS | 10822 | |12;stanford-crypto-pbkdf2;143;151;143;149;149;142;152;148;146;141 23:13:53 INFO - PROCESS | 10822 | |13;stanford-crypto-sha256-iterative;68;71;68;68;70;69;71;67;69;72 23:13:53 INFO - PROCESS | 10822 | __end_tp_report 23:13:53 INFO - PROCESS | 10822 | __start_cc_report 23:13:53 INFO - PROCESS | 10822 | _x_x_mozilla_cycle_collect,721 23:13:53 INFO - PROCESS | 10822 | __end_cc_report 23:13:53 INFO - PROCESS | 10822 | __startTimestamp1453792433107__endTimestamp 23:13:53 INFO - PROCESS | 10822 | 23:13:53 INFO - PROCESS | 10822 | ------- Summary: start ------- 23:13:53 INFO - PROCESS | 10822 | Number of tests: 14 23:13:53 INFO - PROCESS | 10822 | 23:13:53 INFO - PROCESS | 10822 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.00 stddev:4.34 (3.9%) stddev-sans-first:4.56 23:13:53 INFO - PROCESS | 10822 | Values: 110.0 106.0 112.0 110.0 112.0 123.0 112.0 111.0 112.0 110.0 23:13:53 INFO - PROCESS | 10822 | 23:13:53 INFO - PROCESS | 10822 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:154.50 stddev:16.69 (10.8%) stddev-sans-first:17.50 23:13:53 INFO - PROCESS | 10822 | Values: 155.0 129.0 163.0 174.0 130.0 154.0 147.0 130.0 164.0 132.0 23:13:53 INFO - PROCESS | 10822 | 23:13:53 INFO - PROCESS | 10822 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:1.97 (1.2%) stddev-sans-first:2.09 23:13:53 INFO - PROCESS | 10822 | Values: 163.0 163.0 162.0 164.0 162.0 162.0 161.0 164.0 168.0 162.0 23:13:53 INFO - PROCESS | 10822 | 23:13:53 INFO - PROCESS | 10822 | [#3] audio-fft Cycles:10 Average:81.50 Median:74.00 stddev:24.11 (32.6%) stddev-sans-first:25.32 23:13:53 INFO - PROCESS | 10822 | Values: 72.0 74.0 73.0 74.0 76.0 150.0 74.0 76.0 72.0 74.0 23:13:53 INFO - PROCESS | 10822 | 23:13:53 INFO - PROCESS | 10822 | [#4] audio-oscillator Cycles:10 Average:111.20 Median:96.00 stddev:24.26 (25.3%) stddev-sans-first:25.10 23:13:53 INFO - PROCESS | 10822 | Values: 96.0 96.0 152.0 96.0 96.0 97.0 148.0 96.0 97.0 138.0 23:13:53 INFO - PROCESS | 10822 | 23:13:53 INFO - PROCESS | 10822 | [#5] imaging-gaussian-blur Cycles:10 Average:115.80 Median:116.00 stddev:1.03 (0.9%) stddev-sans-first:0.73 23:13:53 INFO - PROCESS | 10822 | Values: 118.0 116.0 115.0 116.0 116.0 115.0 116.0 114.0 116.0 116.0 23:13:53 INFO - PROCESS | 10822 | 23:13:53 INFO - PROCESS | 10822 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 23:13:53 INFO - PROCESS | 10822 | Values: 147.0 147.0 147.0 146.0 148.0 146.0 148.0 147.0 146.0 147.0 23:13:53 INFO - PROCESS | 10822 | 23:13:53 INFO - PROCESS | 10822 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:96.50 stddev:1.29 (1.3%) stddev-sans-first:0.73 23:13:53 INFO - PROCESS | 10822 | Values: 100.0 96.0 96.0 96.0 98.0 96.0 97.0 97.0 96.0 97.0 23:13:53 INFO - PROCESS | 10822 | 23:13:53 INFO - PROCESS | 10822 | [#8] json-parse-financial Cycles:10 Average:62.80 Median:61.50 stddev:4.98 (8.1%) stddev-sans-first:5.24 23:13:53 INFO - PROCESS | 10822 | Values: 61.0 61.0 65.0 60.0 63.0 62.0 58.0 61.0 76.0 61.0 23:13:53 INFO - PROCESS | 10822 | 23:13:53 INFO - PROCESS | 10822 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.50 stddev:1.15 (1.7%) stddev-sans-first:1.17 23:13:53 INFO - PROCESS | 10822 | Values: 67.0 69.0 67.0 67.0 69.0 68.0 69.0 67.0 67.0 70.0 23:13:53 INFO - PROCESS | 10822 | 23:13:53 INFO - PROCESS | 10822 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:85.00 stddev:2.94 (3.5%) stddev-sans-first:3.04 23:13:53 INFO - PROCESS | 10822 | Values: 84.0 83.0 87.0 84.0 85.0 84.0 91.0 85.0 91.0 84.0 23:13:53 INFO - PROCESS | 10822 | 23:13:53 INFO - PROCESS | 10822 | [#11] stanford-crypto-ccm Cycles:10 Average:121.20 Median:122.00 stddev:2.94 (2.4%) stddev-sans-first:3.08 23:13:53 INFO - PROCESS | 10822 | Values: 120.0 118.0 120.0 125.0 119.0 123.0 122.0 122.0 117.0 126.0 23:13:53 INFO - PROCESS | 10822 | 23:13:53 INFO - PROCESS | 10822 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.40 Median:148.50 stddev:3.95 (2.7%) stddev-sans-first:3.99 23:13:53 INFO - PROCESS | 10822 | Values: 143.0 151.0 143.0 149.0 149.0 142.0 152.0 148.0 146.0 141.0 23:13:53 INFO - PROCESS | 10822 | 23:13:53 INFO - PROCESS | 10822 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.50 stddev:1.64 (2.4%) stddev-sans-first:1.67 23:13:53 INFO - PROCESS | 10822 | Values: 68.0 71.0 68.0 68.0 70.0 69.0 71.0 67.0 69.0 72.0 23:13:53 INFO - PROCESS | 10822 | -------- Summary: end -------- 23:13:53 INFO - PROCESS | 10822 | 23:13:53 INFO - TEST-INFO | 10822: exit 0 23:13:54 INFO - TEST-OK | kraken | took 59505ms 23:13:54 INFO - TEST-START | v8_7 23:13:54 INFO - operating with platform_type : linux_ 23:13:54 INFO - Initialising browser for v8_7 test... 23:13:54 INFO - TEST-INFO | started process 11108 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3d7_Q6/profile http://localhost:57939/getInfo.html) 23:13:57 INFO - PROCESS | 11108 | 23:13:57 INFO - PROCESS | 11108 | (process:11178): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:13:58 INFO - PROCESS | 11108 | __metrics Screen width/height:1600/1200 23:13:58 INFO - PROCESS | 11108 | colorDepth:24 23:13:58 INFO - PROCESS | 11108 | Browser inner width/height: 1024/697 23:13:58 INFO - PROCESS | 11108 | __metrics 23:13:58 INFO - PROCESS | 11108 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:13:59 INFO - TEST-INFO | 11108: exit 0 23:13:59 INFO - Browser initialized. 23:13:59 INFO - Running cycle 1/1 for v8_7 test... 23:13:59 INFO - TEST-INFO | started process 11227 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3d7_Q6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:14:00 INFO - PROCESS | 11227 | 23:14:00 INFO - PROCESS | 11227 | (process:11285): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:14:10 INFO - PROCESS | 11227 | RSS: Main: 150319104 23:14:10 INFO - PROCESS | 11227 | 23:14:33 INFO - PROCESS | 11227 | Cycle 1(1): loaded http://localhost:57939/tests/v8_7/run.html (next: http://localhost:57939/tests/v8_7/run.html) 23:14:33 INFO - PROCESS | 11227 | RSS: Main: 152231936 23:14:33 INFO - PROCESS | 11227 | 23:14:33 INFO - PROCESS | 11227 | __start_tp_report 23:14:33 INFO - PROCESS | 11227 | _x_x_mozilla_page_load 23:14:33 INFO - PROCESS | 11227 | _x_x_mozilla_page_load_details 23:14:33 INFO - PROCESS | 11227 | |i|pagename|runs| 23:14:33 INFO - PROCESS | 11227 | |0;Richards;166.36167027116952 23:14:33 INFO - PROCESS | 11227 | |1;DeltaBlue;189.3939393939394 23:14:33 INFO - PROCESS | 11227 | |2;Encrypt;273.224043715847 23:14:33 INFO - PROCESS | 11227 | |3;Decrypt;5229.166666666667 23:14:33 INFO - PROCESS | 11227 | |4;RayTrace;1071.8113612004288 23:14:33 INFO - PROCESS | 11227 | |5;Earley;728.5298398835516 23:14:33 INFO - PROCESS | 11227 | |6;Boyer;12456.79012345679 23:14:33 INFO - PROCESS | 11227 | |7;RegExp;41653.06122448979 23:14:33 INFO - PROCESS | 11227 | |8;Splay;573.3866362078812 23:14:33 INFO - PROCESS | 11227 | |9;NavierStokes;4822.115384615385 23:14:33 INFO - PROCESS | 11227 | __end_tp_report 23:14:33 INFO - PROCESS | 11227 | __startTimestamp1453792473719__endTimestamp 23:14:33 INFO - PROCESS | 11227 | 23:14:33 INFO - PROCESS | 11227 | ------- Summary: start ------- 23:14:33 INFO - PROCESS | 11227 | Number of tests: 10 23:14:33 INFO - PROCESS | 11227 | 23:14:33 INFO - PROCESS | 11227 | [#0] Richards Cycles:1 Average:166.36 Median:166.36 stddev:0.00 (0.0%) 23:14:33 INFO - PROCESS | 11227 | Values: 166.4 23:14:33 INFO - PROCESS | 11227 | 23:14:33 INFO - PROCESS | 11227 | [#1] DeltaBlue Cycles:1 Average:189.39 Median:189.39 stddev:0.00 (0.0%) 23:14:33 INFO - PROCESS | 11227 | Values: 189.4 23:14:33 INFO - PROCESS | 11227 | 23:14:33 INFO - PROCESS | 11227 | [#2] Encrypt Cycles:1 Average:273.22 Median:273.22 stddev:0.00 (0.0%) 23:14:33 INFO - PROCESS | 11227 | Values: 273.2 23:14:33 INFO - PROCESS | 11227 | 23:14:33 INFO - PROCESS | 11227 | [#3] Decrypt Cycles:1 Average:5229.17 Median:5229.17 stddev:0.00 (0.0%) 23:14:33 INFO - PROCESS | 11227 | Values: 5229.2 23:14:33 INFO - PROCESS | 11227 | 23:14:33 INFO - PROCESS | 11227 | [#4] RayTrace Cycles:1 Average:1071.81 Median:1071.81 stddev:0.00 (0.0%) 23:14:33 INFO - PROCESS | 11227 | Values: 1071.8 23:14:33 INFO - PROCESS | 11227 | 23:14:33 INFO - PROCESS | 11227 | [#5] Earley Cycles:1 Average:728.53 Median:728.53 stddev:0.00 (0.0%) 23:14:33 INFO - PROCESS | 11227 | Values: 728.5 23:14:33 INFO - PROCESS | 11227 | 23:14:33 INFO - PROCESS | 11227 | [#6] Boyer Cycles:1 Average:12456.79 Median:12456.79 stddev:0.00 (0.0%) 23:14:33 INFO - PROCESS | 11227 | Values: 12456.8 23:14:33 INFO - PROCESS | 11227 | 23:14:33 INFO - PROCESS | 11227 | [#7] RegExp Cycles:1 Average:41653.06 Median:41653.06 stddev:0.00 (0.0%) 23:14:33 INFO - PROCESS | 11227 | Values: 41653.1 23:14:33 INFO - PROCESS | 11227 | 23:14:33 INFO - PROCESS | 11227 | [#8] Splay Cycles:1 Average:573.39 Median:573.39 stddev:0.00 (0.0%) 23:14:33 INFO - PROCESS | 11227 | Values: 573.4 23:14:33 INFO - PROCESS | 11227 | 23:14:33 INFO - PROCESS | 11227 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 23:14:33 INFO - PROCESS | 11227 | Values: 4822.1 23:14:33 INFO - PROCESS | 11227 | -------- Summary: end -------- 23:14:33 INFO - PROCESS | 11227 | 23:14:34 INFO - TEST-INFO | 11227: exit 0 23:14:34 INFO - TEST-OK | v8_7 | took 40580ms 23:14:34 INFO - SUITE-END | took 1209s 23:14:34 INFO - Completed test suite (00:20:09) 23:14:34 INFO - Working with test: dromaeo_css 23:14:34 INFO - Generating results file: dromaeo_css 23:14:34 INFO - Working with test: kraken 23:14:34 INFO - Generating results file: kraken 23:14:34 INFO - javascript benchmark 23:14:34 INFO - Working with test: v8_7 23:14:34 INFO - Generating results file: v8_7 23:14:34 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:14:34 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 23:14:34 INFO - process_Request line: dromaeo_css 6687.40 graph.html#tests=[[72,64,43]] 23:14:34 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:14:34 INFO - process_Request line: kraken 1528.50 graph.html#tests=[[232,64,43]] 23:14:34 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:14:34 INFO - process_Request line: v8_7 20410.80 graph.html#tests=[[230,64,43]] 23:14:34 INFO - RETURN: dromaeo_css: 6687.40 23:14:34 INFO - RETURN: kraken: 1528.50 23:14:34 INFO - RETURN: v8_7: 20410.80 23:14:34 INFO - javascript benchmark 23:14:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3165.6834316568343, 3165.715085642293, 3201.695838895304, 3208.0696597986584, 3214.9551395796357, 5139.511746384097, 5197.532222100011, 5200.791968321268, 5212.635115541909, 5234.162533994561, 5210.739463026843, 5222.451642577522, 5222.608304377178, 5264.526192642661, 5276.2085687146855, 4791.2813078038225, 4794.808207671697, 4832.371791667096, 4909.919817640131, 4921.261810728383, 4869.269609558577, 4875.536824001714, 4881.60947124231, 4927.605791536686, 4976.328195693589, 4755.762211889391, 4772.4273087229585, 4809.182438985364, 4849.030193961222, 4849.612031037508, 4734.4081989751285, 4740.241561350167, 4741.312509686076, 4745.762711864393, 4774.689645173053, 4675.13510000651, 4718.787654555554, 4722.8110875564935, 4734.976325118387, 4758.738269395182, 5008.398992120932, 5061.974690126526, 5140.614453915971, 5151.793928242866, 5168.173092305213, 5659.5755318350875, 5679.687617181054, 5681.971590142064, 5685.886282274373, 5686.459786320293, 5563.777448902039, 5641.379448260688, 5728.856778580569, 5739.282589676291, 5769.855753606152, 5285.048691235576, 5338.332708411449, 5352.090144675414, 5369.382521010134, 5402.270693456372, 5776.33572139201, 5783.826485205366, 5785.074388097884, 5788.855278618068, 5809.2738407699035, 5517.97917385285, 5562.694051827189, 5562.833115006556, 5617.578681598897, 5625.774969001194, 5606.85982850432, 5647.802326918538, 5655.773769049192, 5686.516646085046, 5686.9715651421475, 5595.972020139873, 5612.186232996274, 5612.691301978349, 5627.5779316551425, 5642.153676948408, 5556.583256255716, 5582.7766889323975, 5620.57845661577, 5641.407652196543, 5698.6580805151825, 4392.472903251631, 4412.117576484716, 4427.269500532376, 4437.511873693891, 4457.621102206284, 3907.6873850091924, 3937.17319362937, 3946.5264168299987, 3992.0419099416513, 4004.5594984551676, 5084.161113416319, 5173.663711858717, 5288.497592728685, 5304.496072873071, 5354.625176237626, 5682.232898558725, 5683.232763576947, 5696.772129114789, 5699.5725320600295, 5701.0, 5218.973905130526, 5317.255584218213, 5324.946750532523, 5329.067413202674, 5361.597880159004, 4735.479097299294, 4739.644526660514, 4783.115123702126, 4811.735354555463, 4837.806487740451, 5789.536837053026, 5815.651060936358, 5824.504917082011, 5843.853903652443, 5861.1501332307425, 5483.698396588226, 5547.306586676666, 5596.86007849807, 5599.32808063035, 5645.520130788929, 5710.714464276853, 5738.139279108167, 5741.885162296647, 5765.682887441063, 5829.621074630136, 5496.917546236889, 5519.089350257163, 5525.696086715269, 5547.55619550443, 5567.526760225426, 5612.943870561242, 5636.436356364331, 5643.153526970823, 5696.544276457957, 5699.914501282401, 5463.344398672185, 5505.834824955257, 5529.751161197675, 5534.750936207961, 5546.140348246028, 5439.755211015593, 5486.615936884539, 5513.117901135799, 5514.5864060196445, 5518.696471694096, 5355.571554275571, 5426.07756681373, 5438.320209973754, 5443.210734443563, 5487.533559647474, 5450.400455949922, 5461.1808228766, 5474.178873169057, 5512.0, 5534.225208470898, 5380.085385484399, 5411.83764487066, 5425.186222066722, 5434.456554344534, 5470.398256191896], "unit": "score", "name": "dojo.html", "value": 5202.377069803227}, {"lowerIsBetter": false, "replicates": [482.27176962786206, 523.8559396166052, 524.352424755427, 558.7122631844601, 560.6776103740349, 27462.17613471594, 34889.82555087224, 35046.82476587613, 35325.293494130165, 35491.112722181955, 38029.42955855664, 38654.226915461746, 38747.41878871819, 38755.41866871999, 38953.80523097388, 8151.470154439972, 8391.412601117925, 8469.449485783434, 8473.872891906627, 8483.74548763538, 8065.435419520607, 8210.958945205266, 8237.423380363347, 8242.25819676229, 8252.46358986667, 8226.753197404087, 8402.579871006456, 8415.579221038954, 8417.789555261106, 8429.157084291552, 8271.751847444586, 8280.296174825147, 8366.665333386627, 8537.0, 8560.828783424358, 8338.37462190332, 8525.360597955178, 8570.27152692022, 8588.484690918502, 8589.0, 37798.0, 38106.0, 38253.0, 38256.61743382558, 38360.42459363112, 2722.5099482093215, 2962.466755983922, 3085.552594873731, 3568.50040994261, 3642.4900513928073, 27871.86064069687, 27931.720682793115, 28673.426531469464, 28738.0, 28882.0, 3337.983310083434, 3351.1957130288797, 3387.796732196076, 3489.2672538766888, 3502.369573476773, 248892.0, 249002.0, 250468.0, 250625.0, 251434.0, 50536.74731626319, 54795.17807232895, 55232.0, 55237.44762552404, 55398.72300638471, 50380.74809625928, 58443.41556584465, 60592.69703651542, 60720.0, 60894.39105608887, 13102.0, 13264.734705306033, 13265.204087754573, 13295.268760218087, 13303.600891973063, 9856.605735770632, 9857.704268871945, 9926.652567160114, 10001.149902258245, 10009.499525023719, 18404.539886502946, 18567.90716046411, 18646.813531864507, 18661.720074198896, 19318.227270909287, 7045.964770176116, 7379.8155046124275, 7387.039684840936, 7390.482666213314, 7391.8152046199275, 875.4703404440222, 878.5607196401799, 900.9054049324858, 970.5244430229137, 1081.34578579958, 27839.164825055283, 27875.860620696767, 28099.719002810118, 28373.85813070963, 28942.0, 961.1493827962304, 969.8739163908647, 980.8626792248948, 1003.6764889281291, 1051.9894801051892, 13414.0, 13575.717644240176, 13689.931550342384, 13707.862921370659, 13762.518311859038, 309277.0, 316698.0, 317403.0, 317747.0, 318010.0, 48045.75977120092, 48249.27626085612, 49311.260331095065, 49371.75314123406, 49411.0, 1270.2378572856212, 1282.076904628666, 1286.350393051503, 1301.6160232731368, 1306.3337697774014, 25891.870540647174, 27214.0, 27320.45359092767, 27599.862000689867, 27764.0, 43026.78486607547, 43649.0, 43679.34480982724, 43813.56186438095, 43853.342199867664, 306467.0, 307554.0, 309310.0, 311550.0, 311800.0, 29215.7078429213, 30050.849745752006, 30440.086797396114, 30550.388992219585, 30627.0, 35594.46608300826, 35990.46014309735, 35999.0, 36361.63638363582, 36646.816765916, 31277.530837037008, 31481.8425907869, 31675.20811979719, 31821.20446988844, 32177.678223218405, 31713.682863171074, 32025.839870800497, 32311.51532727058, 32443.675563244065, 34357.65642343645, 31631.0, 31640.0, 32020.0, 32028.19929501781, 34106.82946585251, 27157.72842271631, 27215.503147327086, 28845.855770721013, 29215.269618259714, 29650.703492964793, 22361.578616009007, 22899.54200915939, 23916.162934297216, 24241.878790605933, 24434.51130977335], "unit": "score", "name": "ext.html", "value": 17209.122149884417}, {"lowerIsBetter": false, "replicates": [340.1937408342231, 340.8091468777485, 342.5085003020664, 342.68815378006013, 344.99999999999994, 15411.07533547988, 15735.21323933803, 16533.586660333498, 17382.304707811705, 17444.3022279109, 14636.41454341825, 14944.925275373607, 15112.848871511282, 15132.773008404884, 15207.315670794813, 4289.399484072233, 4453.198424283628, 4458.754768487732, 4473.351364052211, 4476.1271552047365, 4349.34759786033, 4379.4525684289465, 4421.38100665907, 4607.7004994675235, 4616.838410655628, 4629.930551041737, 4631.4442266927845, 5971.850703732398, 6223.315435302113, 6231.376862313778, 6160.383961603849, 6197.101420294055, 6241.251049873998, 6687.164104486939, 6701.961196014626, 6179.721912513947, 6410.070539771754, 6419.0, 6431.8392040198905, 6456.644884531349, 19904.402867913985, 20399.796002039937, 20757.792422075738, 21516.56966860654, 22205.777942220695, 1971.447994561525, 2045.98977005114, 2109.778473260301, 2170.945726356838, 2287.656851472276, 13645.0, 13698.931505342509, 13717.794233086512, 13795.379207935666, 14393.856061439355, 1906.7044608085769, 1912.531429799694, 1926.3450426854936, 1945.1538580717433, 1968.5570746582048, 50301.24548131781, 60444.69777651084, 61558.38441615571, 63327.366726332606, 63605.363946360405, 14445.133292002514, 14776.33506492189, 14853.554393368217, 14857.331420086122, 14956.551303460914, 22085.668714969288, 22229.666555001688, 22415.887920560293, 22444.88777556102, 22528.986195621237, 8050.315723163597, 8083.555404452694, 8127.796805079802, 8207.220314070153, 8226.218509241613, 6399.968000160063, 6436.903446448307, 6463.57986730861, 6496.700659867951, 6547.574407663486, 7415.666295016629, 7471.252874712485, 7488.4009279257525, 7505.324520793155, 7605.733799316998, 1674.840890115437, 1712.8715346349074, 1785.544686105035, 3074.815511069343, 3089.3203495231014, 839.0770152831958, 841.7306461932245, 896.5965315607872, 932.6549176804625, 1011.701548043329, 15446.845531544766, 15776.211189440482, 15946.760798588031, 16292.51122466328, 16398.0, 836.431226765793, 880.5949263338807, 902.4224496322358, 904.3172404834309, 922.9123233292961, 9034.728958131267, 9206.76983075415, 9385.765355866159, 9454.527273636428, 9511.953685094633, 359181.0, 362141.0, 366041.0, 489984.0, 492658.0, 70276.0, 71494.64252678704, 72365.27634723691, 74278.0, 74690.62654686692, 1095.3592148593002, 1098.3025778630627, 1104.1222228328497, 1115.9677298499018, 1131.3777422417802, 13453.327333633475, 14625.488107916171, 14916.328765205375, 14917.627059323604, 14943.327550260046, 27241.591376128978, 28180.85909570439, 31718.841405792824, 33007.83496082504, 34052.65947340594, 38617.80691096639, 39440.40839387354, 40682.79658601688, 40786.796066020666, 40806.591934081465, 6490.772822951174, 6668.933310667026, 6711.697973591103, 6765.052892595139, 6874.759383421556, 5694.658320500783, 6305.621662700252, 8554.743357699279, 10811.297265677706, 10825.133989280996, 6379.0, 6395.552311338161, 6555.868882622416, 6618.801435956929, 6739.42714869222, 6683.933160668331, 6869.690863911036, 6973.3375329343635, 6981.8254543634785, 7060.54106483077, 6653.833654158685, 6798.524103312919, 6806.455483561204, 6808.863822723617, 6847.726090956506, 9198.356115071882, 9264.907350926405, 9316.6273349068, 9335.953320233355, 9437.0, 9764.170045545923, 9814.75463113428, 9930.25523085786, 9984.900150998397, 10003.799924001625], "unit": "score", "name": "jquery.html", "value": 8235.265226361507}, {"lowerIsBetter": false, "replicates": [1420.3324437514368, 1455.279636579893, 1583.5486886237425, 1716.828317168284, 1741.6516696660663, 6985.441164706824, 7097.89353159703, 7141.85716285674, 7197.7480788172425, 7293.4894557381, 7109.111361079865, 7135.2864713528625, 7158.749443769456, 7186.820329491766, 7215.747448839292, 2235.0501037059225, 2258.367657056027, 2276.1236923784295, 2281.235786011688, 2283.9200627978025, 2239.1155493580027, 2246.629306164489, 2278.646809744492, 2291.140822191678, 2297.3797074789795, 2157.4498502881743, 2226.1318085946496, 2230.5761905237955, 2238.462768935452, 2258.2660635293514, 2215.324326080545, 2241.9775802241934, 2253.4479052632128, 2256.255435706213, 2256.4584499720113, 2256.4020534558354, 2270.579942710604, 2272.556851413975, 2280.3842962400226, 2282.2696737044153, 7205.963970180168, 7224.349808517206, 7240.420766338681, 7253.383462405702, 7286.016387787634, 4376.496702879178, 4468.061707041526, 4473.261911784552, 4481.2381895077915, 4491.505934347219, 2802.2153796936686, 2894.7828912831624, 2904.157794239668, 2914.897978570761, 2920.7663386928994, 869.7912500999778, 880.216607219575, 896.4934811831295, 905.3571963905634, 913.7441516375426, 9106.27149828012, 9240.029796871298, 9246.121618446305, 9255.120763527455, 9269.073092690744, 3858.0, 3864.4976153099915, 3931.1548017176447, 3948.0, 3950.229705207457, 7702.114256860421, 7869.960650196713, 7893.447458677952, 7959.681612735426, 7973.282404583615, 4322.481302243751, 4324.805383757738, 4339.414179085783, 4347.782610869507, 4366.628836548865, 3926.0577461409057, 3955.011247188203, 3971.8014099295497, 3977.840886364513, 3995.6803455724053, 3232.3212125453447, 3248.464003439406, 3262.217067903686, 3293.91765205867, 3302.1579497228054, 978.9706308810747, 981.8625392445064, 981.9361741486781, 982.52838637453, 986.2800155886243, 914.5107367558325, 914.6112902016616, 930.8603709443502, 998.3161534348994, 1086.2884810449168, 6667.399934005963, 6738.932610673928, 6756.223034351015, 6763.898541521881, 6765.729370825112, 1078.8381742738652, 1149.3965668024355, 1172.2556176827604, 1189.5717541684987, 1194.8984336331334, 5187.351581052369, 5247.475252474722, 5315.255864179018, 5321.3880403754065, 5338.172583249602, 8257.545834979133, 8283.544405057659, 8336.458130221516, 8514.829703405898, 8595.18345757152, 8190.754277371689, 8274.8345033099, 8283.710070147516, 8290.87563686533, 8300.875486867702, 6607.008948657836, 6610.3720146586, 6676.899846502306, 6726.293739157318, 6749.797506074826, 7015.333543313377, 7016.298370163147, 7059.329363710439, 7086.39765619928, 7119.430445564239, 7708.49894756839, 7801.531908085533, 7928.84142317162, 7943.364530837403, 7957.124716281321, 7960.601969901598, 8078.515289082674, 8358.080611132893, 8455.619497122767, 8459.534725590152, 6588.868222635616, 6657.367550082734, 6747.224069231905, 6759.087523184307, 6766.695498702668, 6779.932200678128, 6823.010663453871, 6832.521723479309, 6852.965735171292, 6884.380405763505, 6141.938580614136, 6274.6548939808745, 6332.145160403286, 6336.619802811846, 6558.44253238461, 6308.84227894288, 6342.112104305494, 6345.4923606112325, 6501.772437964649, 6558.901616475852, 6079.422454866781, 6187.504999600112, 6237.625742455286, 6288.874222515616, 6294.4964402846745, 5833.0, 5860.824175274749, 5863.2670916135485, 5865.970670146622, 5882.294124705063, 5891.734871930687, 5910.024845900378, 5918.201042859159, 5954.136650185786, 5958.106284057426], "unit": "score", "name": "mootools.html", "value": 4169.864457710867}, {"lowerIsBetter": false, "replicates": [296.5936666766529, 306.60907343137507, 311.1676265988482, 315.3755563983311, 315.4400938334456, 6271.937280627192, 6283.874322513547, 6341.239051313849, 6435.903461448071, 6505.4145126938565, 6225.782097626584, 6259.749610015594, 6264.749410023605, 6265.843353916143, 6291.1821463209835, 4557.134144512532, 4664.230401983668, 4739.691920025204, 4741.549552792488, 4744.027474367764, 4673.462551806551, 4692.8122875084955, 4698.389209402773, 4700.318453824193, 4704.882377940545, 4648.279516674921, 4652.837150699726, 4653.418322709661, 4661.044485880387, 4675.4155730533685, 4646.628269738413, 4675.275332323478, 4680.4149481314835, 4680.555347242007, 4688.296755486705, 3851.056491159684, 3979.4428779970826, 4012.859549915739, 4025.054112283611, 4030.979845100785, 5800.709964501758, 5906.438888305604, 5930.8813823723285, 5931.733072011727, 5936.347001829795, 5406.243125962368, 5416.458354164592, 5422.566194704415, 5423.918641220345, 5432.456754324576, 6598.37315455031, 6604.900926486107, 6613.966930165367, 6628.403443690091, 6644.634545100018, 4283.079137985348, 4400.273954797454, 4401.075774087413, 4410.647148228134, 4434.911301773978, 6815.454763618898, 6868.965655171743, 6878.0, 6884.862302753967, 6908.169335126146, 4439.711418757771, 4443.7111587746695, 4447.310666846644, 4454.420925279693, 4456.376107344974, 4478.820847166142, 4494.820207191741, 4501.932471012938, 4502.054568540643, 4510.684252102321, 5195.246689230116, 5346.545543628835, 5384.19237114436, 5389.245505629215, 5390.541803946709, 6606.735730570724, 6623.039659249382, 6632.104665870046, 6661.800145995628, 6667.566608170453, 1618.4578166314182, 1628.5033064915315, 1636.116497091581, 1640.0405762628757, 1642.1707037945762, 1047.9371237725761, 1049.275999560301, 1066.9946650266854, 1069.2141276162015, 1082.2316155529504, 6239.188905442264, 6246.500279977591, 6303.338149494329, 6304.810855674337, 6307.653079080695, 6798.626075565891, 6809.285025072296, 6836.658167091626, 6843.110395648534, 6850.417714494324, 6141.57009009374, 6218.284897236786, 6233.532485063548, 6258.561900667, 6272.18461599989, 3691.5201023866725, 3705.4256590228556, 3722.2927643747603, 3732.160263940646, 3736.3461394255896, 7059.18819335783, 7127.322904324081, 7187.101612298463, 7200.891986620205, 7203.315685009916, 6981.82545436358, 7042.119735033121, 7055.8236044098285, 7059.682314295869, 7063.646817659096, 7069.787906362714, 7224.844024955982, 7244.348008679139, 7245.963770181115, 7263.055802745609, 6779.762708305186, 6890.0, 6910.7581234656545, 6914.827129321807, 6915.861682766216, 6797.354251346114, 6808.183018037867, 6831.248562658203, 6835.350641689031, 6846.383825455733, 7092.397146242627, 7216.314450127229, 7218.242084581043, 7225.710971561079, 7241.058662373857, 4473.955260447354, 4487.371767952554, 4492.618127459203, 4512.774361281857, 4523.411956445641, 6786.016027676058, 6818.386345228953, 6866.622335771581, 6890.586564806128, 6908.930910690829, 6571.737130514726, 6642.5018123641885, 6642.90035649456, 6651.600903945779, 6681.899771503334, 6608.041833934149, 6613.272540020497, 6618.238902526078, 6627.900581491185, 6655.134832471941, 6531.11829902957, 6535.869282614416, 6538.83652908662, 6549.279579246184, 6575.4410875076155, 6557.082008518906, 6730.192376914802, 6730.899036514358, 6737.090492783607, 6741.22475915276, 6443.259025212161, 6511.218653761579, 6518.956966885466, 6519.1199188110895, 6545.901811472737], "unit": "score", "name": "prototype.html", "value": 4929.596629356081}, {"lowerIsBetter": false, "replicates": [616.5529990756702, 626.5520153090539, 640.5292110298932, 772.4824367673656, 802.169754304295, 12034.69913252168, 12204.26774393537, 12217.938910305436, 12297.508099676013, 12343.876561234385, 12000.759984800321, 12259.877401225986, 12294.200876943014, 12307.753844923096, 12315.69210769729, 769.6613490064382, 774.28765535707, 781.6287263549825, 782.1162086841861, 782.8825676148595, 760.6805141840413, 768.1780494870491, 783.5847001089431, 787.6258777080898, 790.4782843323408, 806.6087947345533, 808.107041718901, 812.5612169428501, 813.0365516862507, 814.2183503836295, 800.0519384529351, 803.9517628942282, 804.6499772598938, 805.3677862877643, 809.2069771623783, 587.9647221166701, 593.0955293177896, 594.7472324262214, 596.1028651878938, 596.4095545410013, 12385.93807030959, 12411.379431028503, 12491.875081249253, 12495.375231238402, 12495.687607809787, 11561.595344162914, 11674.416279186007, 11692.590759323468, 11916.0, 12235.93882030593, 10188.388696678223, 10292.794144117152, 10313.742156446075, 10354.741131471697, 10456.424896630682, 3453.4129198036144, 3460.480927860816, 3531.876384326562, 3531.964680353215, 3598.3702852000797, 47266.29100563494, 47553.286700699515, 47678.76160619175, 47719.0, 47721.76139119282, 8577.142285771373, 8676.6529338827, 8703.39076264668, 8731.257843083282, 8870.645174193089, 14227.644308892153, 14232.85767142336, 14302.141871487744, 14316.141031538142, 14319.92840035814, 7041.0, 7043.366097051187, 7069.363757261871, 7118.074650295428, 7204.919262110725, 3724.6647801697977, 3739.775613463201, 3836.4820749199057, 3888.377859542516, 3954.940675889864, 2790.107165706954, 2805.8877644893973, 2815.352468932116, 2819.6052552642645, 2821.520341541943, 503.1094961917459, 503.76574892674347, 510.91059064663534, 513.6994858008107, 524.8084449176023, 576.1012820000813, 578.0721941284262, 588.0062694047132, 613.3866133866134, 616.1774031667774, 8034.864898518242, 8098.046223492981, 8258.256756891788, 8286.4199506034, 8430.626394644594, 604.4620287943734, 643.3020173112226, 665.3379887012453, 682.3654001778393, 694.7290556682898, 3724.6089160638285, 3725.795081270502, 3970.82131304092, 4056.0265536271672, 4129.876103716893, 50859.745701271255, 53767.731161343945, 53882.461175388526, 54030.729846350514, 54327.72836135794, 47592.286115708295, 48552.543423697345, 48823.511764882605, 49168.754156229705, 49754.751226243636, 42890.78554607207, 43603.56396435995, 43758.781206094405, 44012.779936100116, 44231.89420264583, 7866.685332586632, 8305.833883322179, 8474.110218427222, 8774.0, 8926.821463570823, 32985.0, 33009.33981320408, 33015.17462063468, 33059.33881322312, 33446.83276583699, 40473.0, 41957.0, 42216.577834221265, 42379.364309534765, 42805.35791963185, 9654.324197306121, 9708.854367184356, 10056.145227655732, 10116.747081323027, 10660.413677247825, 10599.366579629477, 10763.085137763377, 10769.215414250571, 10787.406692631981, 10985.340879547253, 10698.358098514114, 10818.242723009314, 10925.890741092488, 11008.559657613605, 11177.441127943408, 10204.489775511343, 10372.429516376671, 10475.371477711056, 10528.78942421132, 10609.8939010612, 10513.526891289757, 10851.294665846695, 11040.282381645167, 11301.321920684784, 11465.369404682822, 8747.781305467413, 8819.60311785984, 8875.423097498642, 9073.90926090757, 9323.673671421468, 8702.140465898305, 9113.0, 9128.224100951493, 9270.737241018172, 9271.43091704266], "unit": "score", "name": "yui.html", "value": 5901.132298777969}], "name": "dromaeo_css", "value": 6687.401635116761}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 106.0, 112.0, 110.0, 112.0, 123.0, 112.0, 111.0, 112.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.8}, {"lowerIsBetter": true, "replicates": [155.0, 129.0, 163.0, 174.0, 130.0, 154.0, 147.0, 130.0, 164.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 147.8}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 162.0, 164.0, 162.0, 162.0, 161.0, 164.0, 168.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.1}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 73.0, 74.0, 76.0, 150.0, 74.0, 76.0, 72.0, 74.0], "unit": "score", "name": "audio-fft", "value": 81.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 152.0, 96.0, 96.0, 97.0, 148.0, 96.0, 97.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 111.2}, {"lowerIsBetter": true, "replicates": [118.0, 116.0, 115.0, 116.0, 116.0, 115.0, 116.0, 114.0, 116.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.8}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 146.0, 148.0, 146.0, 148.0, 147.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [100.0, 96.0, 96.0, 96.0, 98.0, 96.0, 97.0, 97.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.9}, {"lowerIsBetter": true, "replicates": [61.0, 61.0, 65.0, 60.0, 63.0, 62.0, 58.0, 61.0, 76.0, 61.0], "unit": "score", "name": "json-parse-financial", "value": 62.8}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 67.0, 67.0, 69.0, 68.0, 69.0, 67.0, 67.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 87.0, 84.0, 85.0, 84.0, 91.0, 85.0, 91.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.8}, {"lowerIsBetter": true, "replicates": [120.0, 118.0, 120.0, 125.0, 119.0, 123.0, 122.0, 122.0, 117.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.2}, {"lowerIsBetter": true, "replicates": [143.0, 151.0, 143.0, 149.0, 149.0, 142.0, 152.0, 148.0, 146.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.4}, {"lowerIsBetter": true, "replicates": [68.0, 71.0, 68.0, 68.0, 70.0, 69.0, 71.0, 67.0, 69.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.3}], "name": "kraken", "value": 1528.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.36167027116952], "unit": "score", "name": "Richards", "value": 212.20032200000009}, {"lowerIsBetter": false, "replicates": [189.3939393939394], "unit": "score", "name": "DeltaBlue", "value": 349.1030400000001}, {"lowerIsBetter": false, "replicates": [273.224043715847], "unit": "score", "name": "Encrypt", "value": 974.2224600000001}, {"lowerIsBetter": false, "replicates": [5229.166666666667], "unit": "score", "name": "Decrypt", "value": 50.90313944223106}, {"lowerIsBetter": false, "replicates": [1071.8113612004288], "unit": "score", "name": "RayTrace", "value": 690.4097369999998}, {"lowerIsBetter": false, "replicates": [728.5298398835516], "unit": "score", "name": "Earley", "value": 914.8053566433571}, {"lowerIsBetter": false, "replicates": [12456.79012345679], "unit": "score", "name": "Boyer", "value": 53.501985133795806}, {"lowerIsBetter": false, "replicates": [41653.06122448979], "unit": "score", "name": "RegExp", "value": 21.870781479666846}, {"lowerIsBetter": false, "replicates": [573.3866362078812], "unit": "score", "name": "Splay", "value": 142.1222519920318}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 20410.797319893813}]} 23:14:34 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20410.80"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1528.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6687.40"}}} 23:14:34 INFO - Return code: 0 23:14:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:14:34 INFO - # TBPL SUCCESS # 23:14:34 INFO - Running post-action listener: _resource_record_post_action 23:14:34 INFO - Running post-run listener: _resource_record_post_run 23:14:36 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 0; Write bytes: 550977536; Read time: 0; Write time: 373632 23:14:36 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 236478464; Read time: 0; Write time: 204272 23:14:36 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 314499072; Read time: 0; Write time: 169360 23:14:36 INFO - Running post-run listener: _upload_blobber_files 23:14:36 INFO - Blob upload gear active. 23:14:36 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:14:36 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:14:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 23:14:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 23:14:36 INFO - (blobuploader) - INFO - Open directory for files ... 23:14:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:14:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:14:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:14:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:14:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:14:37 INFO - (blobuploader) - INFO - Done attempting. 23:14:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:14:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:14:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:14:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:14:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:14:38 INFO - (blobuploader) - INFO - Done attempting. 23:14:38 INFO - (blobuploader) - INFO - Iteration through files over. 23:14:38 INFO - Return code: 0 23:14:38 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:14:38 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:14:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7576a3beb900a4ab852ce74c6a8b3816ebb4776de04ce215e3d3db5cfdc180c7d8ff7b53f69ddfd46710c4ca4c12eed19f7049d39475a14c0a02779d9e2fe7cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8866f02805deb2066403b5bb1bf72f52663303b306ff514b8c5c10246427641fa3d4112af4e169e94a36f21c261f50a36a914401850d9c3f34bab5f386e53ce6"} 23:14:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:14:38 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:14:38 INFO - Contents: 23:14:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7576a3beb900a4ab852ce74c6a8b3816ebb4776de04ce215e3d3db5cfdc180c7d8ff7b53f69ddfd46710c4ca4c12eed19f7049d39475a14c0a02779d9e2fe7cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8866f02805deb2066403b5bb1bf72f52663303b306ff514b8c5c10246427641fa3d4112af4e169e94a36f21c261f50a36a914401850d9c3f34bab5f386e53ce6"} 23:14:38 INFO - Running post-run listener: copy_logs_to_upload_dir 23:14:38 INFO - Copying logs to upload dir... 23:14:38 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 23:14:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.546738 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-01-25 23:14:38.233397) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-25 23:14:38.236721) ========= 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=1f5564757af27664ca02d71f000001b0-1453782510.291007-2031243442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7576a3beb900a4ab852ce74c6a8b3816ebb4776de04ce215e3d3db5cfdc180c7d8ff7b53f69ddfd46710c4ca4c12eed19f7049d39475a14c0a02779d9e2fe7cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8866f02805deb2066403b5bb1bf72f52663303b306ff514b8c5c10246427641fa3d4112af4e169e94a36f21c261f50a36a914401850d9c3f34bab5f386e53ce6"} build_url:https://queue.taskcluster.net/v1/task/NizjWjVtQ9y8KcmO5ogg2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011427 build_url: 'https://queue.taskcluster.net/v1/task/NizjWjVtQ9y8KcmO5ogg2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7576a3beb900a4ab852ce74c6a8b3816ebb4776de04ce215e3d3db5cfdc180c7d8ff7b53f69ddfd46710c4ca4c12eed19f7049d39475a14c0a02779d9e2fe7cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8866f02805deb2066403b5bb1bf72f52663303b306ff514b8c5c10246427641fa3d4112af4e169e94a36f21c261f50a36a914401850d9c3f34bab5f386e53ce6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-25 23:14:38.261970) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 23:14:38.262355) ========= 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=1f5564757af27664ca02d71f000001b0-1453782510.291007-2031243442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 23:14:38.345444) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 23:14:38.345789) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 23:14:38.346131) ========= ========= Total master_lag: 0.32 =========