builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-011 starttime: 1452851520.21 results: success (0) buildid: 20160114233009 builduid: 15ee8dc665a14911b0c547f620d4cb75 revision: 0ae26b71481ae676e540a0a2841837fbb939cb88 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:00.209123) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:00.209562) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:00.210120) ========= 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=5cf47e208febbcd81da23b2e0000026f-1452850945.378970-1360290163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005991 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:00.262828) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:00.263107) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:00.358966) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:00.359308) ========= 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=5cf47e208febbcd81da23b2e0000026f-1452850945.378970-1360290163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022700 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:00.432366) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:00.432733) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:00.433109) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:00.433385) ========= 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=5cf47e208febbcd81da23b2e0000026f-1452850945.378970-1360290163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-15 01:52:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 229M=0s 2016-01-15 01:52:00 (229 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.241491 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:00.699699) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:00.700001) ========= 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=5cf47e208febbcd81da23b2e0000026f-1452850945.378970-1360290163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.151065 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:00.871743) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:00.874675) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0ae26b71481ae676e540a0a2841837fbb939cb88 --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 0ae26b71481ae676e540a0a2841837fbb939cb88 --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=5cf47e208febbcd81da23b2e0000026f-1452850945.378970-1360290163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-15 01:52:01,079 truncating revision to first 12 chars 2016-01-15 01:52:01,079 Setting DEBUG logging. 2016-01-15 01:52:01,079 attempt 1/10 2016-01-15 01:52:01,079 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0ae26b71481a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-15 01:52:01,428 unpacking tar archive at: fx-team-0ae26b71481a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.725035 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:01.619964) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:01.620293) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:01.629157) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:01.629502) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 01:52:01.629956) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2016-01-15 01:52:01.630254) ========= /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=5cf47e208febbcd81da23b2e0000026f-1452850945.378970-1360290163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:52:02 INFO - MultiFileLogger online at 20160115 01:52:02 in /builds/slave/test-pgo 01:52:02 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 01:52:02 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 01:52:02 INFO - {'append_to_log': False, 01:52:02 INFO - 'base_work_dir': '/builds/slave/test-pgo', 01:52:02 INFO - 'blob_upload_branch': 'Fx-Team', 01:52:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 01:52:02 INFO - 'branch': 'Fx-Team', 01:52:02 INFO - 'buildbot_json_path': 'buildprops.json', 01:52:02 INFO - 'config_files': ('talos/linux_config.py',), 01:52:02 INFO - 'default_actions': ('clobber', 01:52:02 INFO - 'read-buildbot-config', 01:52:02 INFO - 'download-and-extract', 01:52:02 INFO - 'populate-webroot', 01:52:02 INFO - 'create-virtualenv', 01:52:02 INFO - 'install', 01:52:02 INFO - 'run-tests'), 01:52:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:52:02 INFO - 'download_minidump_stackwalk': True, 01:52:02 INFO - 'download_symbols': 'ondemand', 01:52:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:52:02 INFO - 'tooltool.py': '/tools/tooltool.py', 01:52:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:52:02 INFO - '/tools/misc-python/virtualenv.py')}, 01:52:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:52:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:52:02 INFO - 'installer_path': 'installer.exe', 01:52:02 INFO - 'log_level': 'info', 01:52:02 INFO - 'log_name': 'talos', 01:52:02 INFO - 'log_to_console': True, 01:52:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:52:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:52:02 INFO - 'opt_config_files': (), 01:52:02 INFO - 'pip_index': False, 01:52:02 INFO - 'sps_profile': False, 01:52:02 INFO - 'sps_profile_interval': 0, 01:52:02 INFO - 'suite': 'dromaeojs-e10s', 01:52:02 INFO - 'system_bits': '32', 01:52:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:52:02 INFO - 'title': 'talos-linux64-ix-011', 01:52:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:52:02 INFO - 'use_talos_json': True, 01:52:02 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 01:52:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:52:02 INFO - 'work_dir': 'build'} 01:52:02 INFO - ##### 01:52:02 INFO - ##### Running clobber step. 01:52:02 INFO - ##### 01:52:02 INFO - Running pre-action listener: _resource_record_pre_action 01:52:02 INFO - Running main action method: clobber 01:52:02 INFO - rmtree: /builds/slave/test-pgo/build 01:52:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 01:52:10 INFO - Running post-action listener: _resource_record_post_action 01:52:10 INFO - ##### 01:52:10 INFO - ##### Running read-buildbot-config step. 01:52:10 INFO - ##### 01:52:10 INFO - Running pre-action listener: _resource_record_pre_action 01:52:10 INFO - Running main action method: read_buildbot_config 01:52:10 INFO - Using buildbot properties: 01:52:10 INFO - { 01:52:10 INFO - "project": "", 01:52:10 INFO - "product": "firefox", 01:52:10 INFO - "script_repo_revision": "production", 01:52:10 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 01:52:10 INFO - "repository": "", 01:52:10 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 01:52:10 INFO - "buildid": "20160114233009", 01:52:10 INFO - "pgo_build": "True", 01:52:10 INFO - "basedir": "/builds/slave/test-pgo", 01:52:10 INFO - "buildnumber": 127, 01:52:10 INFO - "slavename": "talos-linux64-ix-011", 01:52:10 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:52:10 INFO - "platform": "ubuntu64_hw", 01:52:10 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 01:52:10 INFO - "branch": "fx-team", 01:52:10 INFO - "repo_path": "integration/fx-team", 01:52:10 INFO - "revision": "0ae26b71481ae676e540a0a2841837fbb939cb88", 01:52:10 INFO - "stage_platform": "linux64-pgo", 01:52:10 INFO - "builduid": "15ee8dc665a14911b0c547f620d4cb75", 01:52:10 INFO - "slavebuilddir": "test" 01:52:10 INFO - } 01:52:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 01:52:10 INFO - Running post-action listener: _resource_record_post_action 01:52:10 INFO - ##### 01:52:10 INFO - ##### Running download-and-extract step. 01:52:10 INFO - ##### 01:52:10 INFO - Running pre-action listener: _resource_record_pre_action 01:52:10 INFO - Running main action method: download_and_extract 01:52:10 INFO - mkdir: /builds/slave/test-pgo/build/tests 01:52:10 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')]} 01:52:10 INFO - https://queue.taskcluster.net/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:52:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/test_packages.json 01:52:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/test_packages.json 01:52:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 01:52:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 01:52:10 INFO - Downloaded 1448 bytes. 01:52:10 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 01:52:10 INFO - Using the following test package requirements: 01:52:10 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:52:10 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:52:10 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:52:10 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:52:10 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:52:10 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:52:10 INFO - u'jsshell-linux-x86_64.zip'], 01:52:10 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:52:10 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:52:10 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:52:10 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:52:10 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:52:10 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:52:10 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:52:10 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:52:10 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:52:10 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:52:10 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:52:10 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:52:10 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:52:10 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')]} 01:52:10 INFO - https://queue.taskcluster.net/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:52:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:52:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:52:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:52:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:52:18 INFO - Downloaded 22439149 bytes. 01:52:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 01:52:18 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 01:52:19 INFO - Return code: 0 01:52:19 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:52:19 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')]} 01:52:19 INFO - https://queue.taskcluster.net/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:52:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:52:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:52:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:52:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:52:24 INFO - Downloaded 22439149 bytes. 01:52:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 01:52:24 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 01:52:26 INFO - Return code: 0 01:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:26 INFO - https://queue.taskcluster.net/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:52:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:52:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:52:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:52:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:52:28 INFO - Downloaded 11132144 bytes. 01:52:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 01:52:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 01:52:28 INFO - Return code: 0 01:52:28 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')]} 01:52:28 INFO - https://queue.taskcluster.net/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:52:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:52:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:52:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:52:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:52:31 INFO - Downloaded 55958686 bytes. 01:52:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:52:31 INFO - mkdir: /builds/slave/test-pgo/properties 01:52:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 01:52:31 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 01:52:31 INFO - Contents: 01:52:31 INFO - build_url:https://queue.taskcluster.net/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:52:31 INFO - Running post-action listener: _resource_record_post_action 01:52:31 INFO - Running post-action listener: set_extra_try_arguments 01:52:31 INFO - ##### 01:52:31 INFO - ##### Running populate-webroot step. 01:52:31 INFO - ##### 01:52:31 INFO - Running pre-action listener: _resource_record_pre_action 01:52:31 INFO - Running main action method: populate_webroot 01:52:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:52:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:52:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:52:31 INFO - '--tppagecycles', 01:52:31 INFO - '7'], 01:52:31 INFO - 'tests': ['tsvgm']}}, 01:52:31 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:52:31 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:52:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:52:31 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:52:31 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:52:31 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:52:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:52:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:31 INFO - 'talos_options': ['--e10s'], 01:52:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:52:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:31 INFO - 'tests': ['damp', 'tps']}, 01:52:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:31 INFO - 'talos_options': ['--e10s'], 01:52:31 INFO - 'tests': ['damp', 'tps']}, 01:52:31 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:52:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:52:31 INFO - 'other': {'tests': ['a11yr', 01:52:31 INFO - 'ts_paint', 01:52:31 INFO - 'tpaint', 01:52:31 INFO - 'sessionrestore', 01:52:31 INFO - 'sessionrestore_no_auto_restore']}, 01:52:31 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:52:31 INFO - 'tests': ['a11yr', 01:52:31 INFO - 'ts_paint', 01:52:31 INFO - 'tpaint', 01:52:31 INFO - 'sessionrestore', 01:52:31 INFO - 'sessionrestore_no_auto_restore']}, 01:52:31 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:52:31 INFO - 'tests': ['a11yr', 01:52:31 INFO - 'ts_paint', 01:52:31 INFO - 'tpaint', 01:52:31 INFO - 'sessionrestore', 01:52:31 INFO - 'sessionrestore_no_auto_restore']}, 01:52:31 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:52:31 INFO - 'tests': ['a11yr', 01:52:31 INFO - 'ts_paint', 01:52:31 INFO - 'tpaint', 01:52:31 INFO - 'sessionrestore', 01:52:31 INFO - 'sessionrestore_no_auto_restore']}, 01:52:31 INFO - 'other_l64': {'tests': ['a11yr', 01:52:31 INFO - 'ts_paint', 01:52:31 INFO - 'tpaint', 01:52:31 INFO - 'sessionrestore', 01:52:31 INFO - 'sessionrestore_no_auto_restore']}, 01:52:31 INFO - 'other_nol64': {'tests': ['a11yr', 01:52:31 INFO - 'ts_paint', 01:52:31 INFO - 'tpaint', 01:52:31 INFO - 'sessionrestore', 01:52:31 INFO - 'sessionrestore_no_auto_restore']}, 01:52:31 INFO - 'svgr': {'tests': ['tsvgx', 01:52:31 INFO - 'tsvgr_opacity', 01:52:31 INFO - 'tart', 01:52:31 INFO - 'tscrollx', 01:52:31 INFO - 'cart']}, 01:52:31 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:52:31 INFO - 'tests': ['tsvgx', 01:52:31 INFO - 'tsvgr_opacity', 01:52:31 INFO - 'tart', 01:52:31 INFO - 'tscrollx', 01:52:31 INFO - 'cart']}, 01:52:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:31 INFO - 'tests': ['tp5o']}, 01:52:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:31 INFO - 'talos_options': ['--e10s'], 01:52:31 INFO - 'tests': ['tp5o']}, 01:52:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:31 INFO - 'talos_options': ['--xperf_path', 01:52:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:52:31 INFO - 'tests': ['tp5n']}, 01:52:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:52:31 INFO - 'talos_options': ['--e10s', 01:52:31 INFO - '--xperf_path', 01:52:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:52:31 INFO - 'tests': ['tp5n']}}, 01:52:31 INFO - 'talos.zip': {'path': '', 01:52:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:52:31 INFO - Running post-action listener: _resource_record_post_action 01:52:31 INFO - ##### 01:52:31 INFO - ##### Running create-virtualenv step. 01:52:31 INFO - ##### 01:52:31 INFO - Running pre-action listener: _resource_record_pre_action 01:52:31 INFO - Running main action method: create_virtualenv 01:52:31 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 01:52:31 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 01:52:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 01:52:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:52:31 INFO - Using real prefix '/usr' 01:52:31 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 01:52:32 INFO - Installing distribute.............................................................................................................................................................................................done. 01:52:34 INFO - Installing pip.................done. 01:52:34 INFO - Return code: 0 01:52:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 01:52:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:34 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6a9d560f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdeb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7c840>, '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 0xde96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde9b60>, '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': '5cf47e208febbcd81da23b2e0000026f-1452850945.378970-1360290163', '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 01:52:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 01:52:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:52:34 INFO - Using env: {'DISPLAY': ':0', 01:52:34 INFO - 'HOME': '/home/cltbld', 01:52:34 INFO - 'LANG': 'en_US.UTF-8', 01:52:34 INFO - 'LANGUAGE': 'en_US:en', 01:52:34 INFO - 'LOGNAME': 'cltbld', 01:52:34 INFO - 'MAIL': '/var/mail/cltbld', 01:52:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:34 INFO - 'MOZ_NO_REMOTE': '1', 01:52:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:34 INFO - 'NO_EM_RESTART': '1', 01:52:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:52:34 INFO - 'PWD': '/builds/slave/test-pgo', 01:52:34 INFO - 'SHELL': '/bin/bash', 01:52:34 INFO - 'SHLVL': '1', 01:52:34 INFO - 'TERM': 'linux', 01:52:34 INFO - 'TMOUT': '86400', 01:52:34 INFO - 'USER': 'cltbld', 01:52:34 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1452850945.378970-1360290163', 01:52:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:34 INFO - '_': '/tools/buildbot/bin/python'} 01:52:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:35 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 01:52:35 INFO - Cleaning up... 01:52:35 INFO - Return code: 0 01:52:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 01:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:35 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6a9d560f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdeb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7c840>, '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 0xde96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde9b60>, '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': '5cf47e208febbcd81da23b2e0000026f-1452850945.378970-1360290163', '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 01:52:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 01:52:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:52:35 INFO - Using env: {'DISPLAY': ':0', 01:52:35 INFO - 'HOME': '/home/cltbld', 01:52:35 INFO - 'LANG': 'en_US.UTF-8', 01:52:35 INFO - 'LANGUAGE': 'en_US:en', 01:52:35 INFO - 'LOGNAME': 'cltbld', 01:52:35 INFO - 'MAIL': '/var/mail/cltbld', 01:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:35 INFO - 'MOZ_NO_REMOTE': '1', 01:52:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:35 INFO - 'NO_EM_RESTART': '1', 01:52:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:52:35 INFO - 'PWD': '/builds/slave/test-pgo', 01:52:35 INFO - 'SHELL': '/bin/bash', 01:52:35 INFO - 'SHLVL': '1', 01:52:35 INFO - 'TERM': 'linux', 01:52:35 INFO - 'TMOUT': '86400', 01:52:35 INFO - 'USER': 'cltbld', 01:52:35 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1452850945.378970-1360290163', 01:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:35 INFO - '_': '/tools/buildbot/bin/python'} 01:52:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:35 INFO - Downloading/unpacking psutil>=0.7.1 01:52:35 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 01:52:35 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 01:52:35 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 01:52:35 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 01:52:35 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 01:52:35 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 01:52:37 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 01:52:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 01:52:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 01:52:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:52:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:52:37 INFO - Installing collected packages: psutil 01:52:37 INFO - Running setup.py install for psutil 01:52:37 INFO - building 'psutil._psutil_linux' extension 01:52:37 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 01:52:39 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 01:52:39 INFO - building 'psutil._psutil_posix' extension 01:52:39 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 01:52:39 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 01:52:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:52:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:52:39 INFO - Successfully installed psutil 01:52:39 INFO - Cleaning up... 01:52:39 INFO - Return code: 0 01:52:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 01:52:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6a9d560f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdeb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7c840>, '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 0xde96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde9b60>, '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': '5cf47e208febbcd81da23b2e0000026f-1452850945.378970-1360290163', '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 01:52:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 01:52:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:52:39 INFO - Using env: {'DISPLAY': ':0', 01:52:39 INFO - 'HOME': '/home/cltbld', 01:52:39 INFO - 'LANG': 'en_US.UTF-8', 01:52:39 INFO - 'LANGUAGE': 'en_US:en', 01:52:39 INFO - 'LOGNAME': 'cltbld', 01:52:39 INFO - 'MAIL': '/var/mail/cltbld', 01:52:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:39 INFO - 'MOZ_NO_REMOTE': '1', 01:52:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:39 INFO - 'NO_EM_RESTART': '1', 01:52:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:52:39 INFO - 'PWD': '/builds/slave/test-pgo', 01:52:39 INFO - 'SHELL': '/bin/bash', 01:52:39 INFO - 'SHLVL': '1', 01:52:39 INFO - 'TERM': 'linux', 01:52:39 INFO - 'TMOUT': '86400', 01:52:39 INFO - 'USER': 'cltbld', 01:52:39 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1452850945.378970-1360290163', 01:52:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:39 INFO - '_': '/tools/buildbot/bin/python'} 01:52:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:52:39 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 01:52:39 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 01:52:39 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 01:52:39 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 01:52:39 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 01:52:39 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 01:52:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:52:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 01:52:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:52:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:52:41 INFO - Installing collected packages: mozsystemmonitor 01:52:41 INFO - Running setup.py install for mozsystemmonitor 01:52:41 INFO - Successfully installed mozsystemmonitor 01:52:41 INFO - Cleaning up... 01:52:41 INFO - Return code: 0 01:52:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 01:52: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')]} 01:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52: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')]} 01:52:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6a9d560f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdeb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7c840>, '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 0xde96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde9b60>, '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': '5cf47e208febbcd81da23b2e0000026f-1452850945.378970-1360290163', '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 01:52:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 01:52:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:52:41 INFO - Using env: {'DISPLAY': ':0', 01:52:41 INFO - 'HOME': '/home/cltbld', 01:52:41 INFO - 'LANG': 'en_US.UTF-8', 01:52:41 INFO - 'LANGUAGE': 'en_US:en', 01:52:41 INFO - 'LOGNAME': 'cltbld', 01:52:41 INFO - 'MAIL': '/var/mail/cltbld', 01:52:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:41 INFO - 'MOZ_NO_REMOTE': '1', 01:52:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:41 INFO - 'NO_EM_RESTART': '1', 01:52:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:52:41 INFO - 'PWD': '/builds/slave/test-pgo', 01:52:41 INFO - 'SHELL': '/bin/bash', 01:52:41 INFO - 'SHLVL': '1', 01:52:41 INFO - 'TERM': 'linux', 01:52:41 INFO - 'TMOUT': '86400', 01:52:41 INFO - 'USER': 'cltbld', 01:52:41 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1452850945.378970-1360290163', 01:52:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:41 INFO - '_': '/tools/buildbot/bin/python'} 01:52:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:42 INFO - Downloading/unpacking blobuploader==1.2.4 01:52:42 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 01:52:42 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 01:52:42 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 01:52:42 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 01:52:42 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 01:52:42 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 01:52:43 INFO - Downloading blobuploader-1.2.4.tar.gz 01:52:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 01:52:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:52:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:52:43 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 01:52:43 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 01:52:43 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 01:52:43 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 01:52:43 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 01:52:43 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 01:52:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 01:52:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 01:52:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:52:44 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 01:52:44 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 01:52:44 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 01:52:44 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 01:52:44 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 01:52:44 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 01:52:44 INFO - Downloading docopt-0.6.1.tar.gz 01:52:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 01:52:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 01:52:44 INFO - Installing collected packages: blobuploader, requests, docopt 01:52:44 INFO - Running setup.py install for blobuploader 01:52:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:52:44 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 01:52:44 INFO - Running setup.py install for requests 01:52:44 INFO - Running setup.py install for docopt 01:52:45 INFO - Successfully installed blobuploader requests docopt 01:52:45 INFO - Cleaning up... 01:52:45 INFO - Return code: 0 01:52:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:52:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6a9d560f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdeb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7c840>, '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 0xde96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde9b60>, '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': '5cf47e208febbcd81da23b2e0000026f-1452850945.378970-1360290163', '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 01:52:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 01:52:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:52:45 INFO - Using env: {'DISPLAY': ':0', 01:52:45 INFO - 'HOME': '/home/cltbld', 01:52:45 INFO - 'LANG': 'en_US.UTF-8', 01:52:45 INFO - 'LANGUAGE': 'en_US:en', 01:52:45 INFO - 'LOGNAME': 'cltbld', 01:52:45 INFO - 'MAIL': '/var/mail/cltbld', 01:52:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:45 INFO - 'MOZ_NO_REMOTE': '1', 01:52:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:45 INFO - 'NO_EM_RESTART': '1', 01:52:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:52:45 INFO - 'PWD': '/builds/slave/test-pgo', 01:52:45 INFO - 'SHELL': '/bin/bash', 01:52:45 INFO - 'SHLVL': '1', 01:52:45 INFO - 'TERM': 'linux', 01:52:45 INFO - 'TMOUT': '86400', 01:52:45 INFO - 'USER': 'cltbld', 01:52:45 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1452850945.378970-1360290163', 01:52:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:45 INFO - '_': '/tools/buildbot/bin/python'} 01:52:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:52:45 INFO - Running setup.py (path:/tmp/pip-V0ULLP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:52:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:52:45 INFO - Running setup.py (path:/tmp/pip-ZnU9z5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:52:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:52:45 INFO - Running setup.py (path:/tmp/pip-mNQcBq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:52:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:52:45 INFO - Running setup.py (path:/tmp/pip-CzEsB_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:52:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:52:45 INFO - Running setup.py (path:/tmp/pip-zjdafI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:52:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:52:45 INFO - Running setup.py (path:/tmp/pip-Xg_JFb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:52:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:52:45 INFO - Running setup.py (path:/tmp/pip-9JIaEv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:52:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:52:45 INFO - Running setup.py (path:/tmp/pip-TUMyrM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:52:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:52:45 INFO - Running setup.py (path:/tmp/pip-zr4zj_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:52:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:52:45 INFO - Running setup.py (path:/tmp/pip-C9pJga-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:52:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:52:45 INFO - Running setup.py (path:/tmp/pip-WdyUbp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:52:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:52:46 INFO - Running setup.py (path:/tmp/pip-pISo__-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:52:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:52:46 INFO - Running setup.py (path:/tmp/pip-0bO9UQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:52:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:52:46 INFO - Running setup.py (path:/tmp/pip-mR2rzN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:52:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:52:46 INFO - Running setup.py (path:/tmp/pip-mntQ4r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:52:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:52:46 INFO - Running setup.py (path:/tmp/pip-k2xx39-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:52:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:52:46 INFO - Running setup.py (path:/tmp/pip-CKUfF_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:52:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:52:46 INFO - Running setup.py install for manifestparser 01:52:46 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 01:52:46 INFO - Running setup.py install for mozcrash 01:52:46 INFO - Running setup.py install for mozdebug 01:52:46 INFO - Running setup.py install for mozdevice 01:52:46 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 01:52:46 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 01:52:46 INFO - Running setup.py install for mozfile 01:52:47 INFO - Running setup.py install for mozhttpd 01:52:47 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 01:52:47 INFO - Running setup.py install for mozinfo 01:52:47 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 01:52:47 INFO - Running setup.py install for mozInstall 01:52:47 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 01:52:47 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 01:52:47 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 01:52:47 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 01:52:47 INFO - Running setup.py install for mozleak 01:52:47 INFO - Running setup.py install for mozlog 01:52:47 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 01:52:47 INFO - Running setup.py install for moznetwork 01:52:47 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 01:52:47 INFO - Running setup.py install for mozprocess 01:52:47 INFO - Running setup.py install for mozprofile 01:52:47 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 01:52:47 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 01:52:47 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 01:52:47 INFO - Running setup.py install for mozrunner 01:52:47 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 01:52:47 INFO - Running setup.py install for mozscreenshot 01:52:48 INFO - Running setup.py install for moztest 01:52:48 INFO - Running setup.py install for mozversion 01:52:48 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 01:52:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:52:48 INFO - Cleaning up... 01:52:48 INFO - Return code: 0 01:52:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:52:48 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')]} 01:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:48 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')]} 01:52:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6a9d560f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdeb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7c840>, '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 0xde96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde9b60>, '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': '5cf47e208febbcd81da23b2e0000026f-1452850945.378970-1360290163', '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 01:52:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 01:52:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:52:48 INFO - Using env: {'DISPLAY': ':0', 01:52:48 INFO - 'HOME': '/home/cltbld', 01:52:48 INFO - 'LANG': 'en_US.UTF-8', 01:52:48 INFO - 'LANGUAGE': 'en_US:en', 01:52:48 INFO - 'LOGNAME': 'cltbld', 01:52:48 INFO - 'MAIL': '/var/mail/cltbld', 01:52:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:48 INFO - 'MOZ_NO_REMOTE': '1', 01:52:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:48 INFO - 'NO_EM_RESTART': '1', 01:52:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:52:48 INFO - 'PWD': '/builds/slave/test-pgo', 01:52:48 INFO - 'SHELL': '/bin/bash', 01:52:48 INFO - 'SHLVL': '1', 01:52:48 INFO - 'TERM': 'linux', 01:52:48 INFO - 'TMOUT': '86400', 01:52:48 INFO - 'USER': 'cltbld', 01:52:48 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1452850945.378970-1360290163', 01:52:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:48 INFO - '_': '/tools/buildbot/bin/python'} 01:52:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:52:48 INFO - Running setup.py (path:/tmp/pip-8c9UYK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:52:48 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)) 01:52:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:52:48 INFO - Running setup.py (path:/tmp/pip-mTrS0G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:52:48 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)) 01:52:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:52:48 INFO - Running setup.py (path:/tmp/pip-c3c7wk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:52:48 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)) 01:52:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:52:48 INFO - Running setup.py (path:/tmp/pip-vn9nqD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:52:48 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)) 01:52:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:52:48 INFO - Running setup.py (path:/tmp/pip-LguUN1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:52:48 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)) 01:52:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:52:48 INFO - Running setup.py (path:/tmp/pip-eE_uik-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:52:48 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)) 01:52:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:52:48 INFO - Running setup.py (path:/tmp/pip-ekPwbe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:52:48 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)) 01:52:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:52:48 INFO - Running setup.py (path:/tmp/pip-kcRq2a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:52:49 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)) 01:52:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:52:49 INFO - Running setup.py (path:/tmp/pip-R5URTw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:52:49 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)) 01:52:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:52:49 INFO - Running setup.py (path:/tmp/pip-DnHuYN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:52:49 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)) 01:52:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:52:49 INFO - Running setup.py (path:/tmp/pip-fWuCtf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:52:49 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)) 01:52:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:52:49 INFO - Running setup.py (path:/tmp/pip-6znare-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:52:49 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)) 01:52:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:52:49 INFO - Running setup.py (path:/tmp/pip-WM5Rc_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:52:49 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)) 01:52:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:52:49 INFO - Running setup.py (path:/tmp/pip-DmQrns-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:52:49 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)) 01:52:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:52:49 INFO - Running setup.py (path:/tmp/pip-OJ9tkj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:52:49 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)) 01:52:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:52:49 INFO - Running setup.py (path:/tmp/pip-nBD1b5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:52:49 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)) 01:52:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:52:49 INFO - Running setup.py (path:/tmp/pip-9Qjbn1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:52:49 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)) 01:52:49 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)) 01:52:49 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)) 01:52:49 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)) 01:52:49 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)) 01:52:49 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)) 01:52:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 01:52: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 01:52: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 01:52: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 01:52: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 01:52: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 01:52: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 01:52:51 INFO - Downloading blessings-1.5.1.tar.gz 01:52:51 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 01:52:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 01:52:51 INFO - Installing collected packages: blessings 01:52:51 INFO - Running setup.py install for blessings 01:52:51 INFO - Successfully installed blessings 01:52:51 INFO - Cleaning up... 01:52:51 INFO - Return code: 0 01:52:51 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 01:52:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:52:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:52:51 INFO - Reading from file tmpfile_stdout 01:52:51 INFO - Current package versions: 01:52:51 INFO - argparse == 1.2.1 01:52:51 INFO - blessings == 1.5.1 01:52:51 INFO - blobuploader == 1.2.4 01:52:51 INFO - docopt == 0.6.1 01:52:51 INFO - manifestparser == 1.1 01:52:51 INFO - mozInstall == 1.12 01:52:51 INFO - mozcrash == 0.16 01:52:51 INFO - mozdebug == 0.1 01:52:51 INFO - mozdevice == 0.48 01:52:51 INFO - mozfile == 1.2 01:52:51 INFO - mozhttpd == 0.7 01:52:51 INFO - mozinfo == 0.9 01:52:51 INFO - mozleak == 0.1 01:52:51 INFO - mozlog == 3.1 01:52:51 INFO - moznetwork == 0.27 01:52:51 INFO - mozprocess == 0.22 01:52:51 INFO - mozprofile == 0.28 01:52:51 INFO - mozrunner == 6.11 01:52:51 INFO - mozscreenshot == 0.1 01:52:51 INFO - mozsystemmonitor == 0.0 01:52:51 INFO - moztest == 0.7 01:52:51 INFO - mozversion == 1.4 01:52:51 INFO - psutil == 3.1.1 01:52:51 INFO - requests == 1.2.3 01:52:51 INFO - wsgiref == 0.1.2 01:52:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:52: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')]} 01:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52: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')]} 01:52:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6a9d560f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdeb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7c840>, '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 0xde96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde9b60>, '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': '5cf47e208febbcd81da23b2e0000026f-1452850945.378970-1360290163', '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 01:52:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 01:52:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:52:51 INFO - Using env: {'DISPLAY': ':0', 01:52:51 INFO - 'HOME': '/home/cltbld', 01:52:51 INFO - 'LANG': 'en_US.UTF-8', 01:52:51 INFO - 'LANGUAGE': 'en_US:en', 01:52:51 INFO - 'LOGNAME': 'cltbld', 01:52:51 INFO - 'MAIL': '/var/mail/cltbld', 01:52:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:51 INFO - 'MOZ_NO_REMOTE': '1', 01:52:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:51 INFO - 'NO_EM_RESTART': '1', 01:52:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:52:51 INFO - 'PWD': '/builds/slave/test-pgo', 01:52:51 INFO - 'SHELL': '/bin/bash', 01:52:51 INFO - 'SHLVL': '1', 01:52:51 INFO - 'TERM': 'linux', 01:52:51 INFO - 'TMOUT': '86400', 01:52:51 INFO - 'USER': 'cltbld', 01:52:51 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1452850945.378970-1360290163', 01:52:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:51 INFO - '_': '/tools/buildbot/bin/python'} 01:52:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:52 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)) 01:52:52 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)) 01:52:52 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)) 01:52:52 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)) 01:52:52 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)) 01:52:52 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)) 01:52:52 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)) 01:52:52 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)) 01:52:52 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)) 01:52:52 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)) 01:52:52 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)) 01:52:52 INFO - Cleaning up... 01:52:52 INFO - Return code: 0 01:52:52 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 01:52:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:52:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6a9d560f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdeb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7c840>, '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 0xde96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde9b60>, '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': '5cf47e208febbcd81da23b2e0000026f-1452850945.378970-1360290163', '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 01:52:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 01:52:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:52:52 INFO - Using env: {'DISPLAY': ':0', 01:52:52 INFO - 'HOME': '/home/cltbld', 01:52:52 INFO - 'LANG': 'en_US.UTF-8', 01:52:52 INFO - 'LANGUAGE': 'en_US:en', 01:52:52 INFO - 'LOGNAME': 'cltbld', 01:52:52 INFO - 'MAIL': '/var/mail/cltbld', 01:52:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:52 INFO - 'MOZ_NO_REMOTE': '1', 01:52:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:52 INFO - 'NO_EM_RESTART': '1', 01:52:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:52:52 INFO - 'PWD': '/builds/slave/test-pgo', 01:52:52 INFO - 'SHELL': '/bin/bash', 01:52:52 INFO - 'SHLVL': '1', 01:52:52 INFO - 'TERM': 'linux', 01:52:52 INFO - 'TMOUT': '86400', 01:52:52 INFO - 'USER': 'cltbld', 01:52:52 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1452850945.378970-1360290163', 01:52:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:52 INFO - '_': '/tools/buildbot/bin/python'} 01:52:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:52 INFO - Downloading/unpacking jsonschema 01:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:52:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 01:52:54 INFO - Downloading/unpacking functools32 (from jsonschema) 01:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:54 INFO - Downloading functools32-3.2.3-2.tar.gz 01:52:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 01:52:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 01:52:54 INFO - warning: no files found matching '*.txt' 01:52:54 INFO - no previously-included directories found matching 'build' 01:52:54 INFO - no previously-included directories found matching 'dist' 01:52:54 INFO - no previously-included directories found matching '.git*' 01:52:54 INFO - Installing collected packages: jsonschema, functools32 01:52:54 INFO - Running setup.py install for functools32 01:52:54 INFO - warning: no files found matching '*.txt' 01:52:54 INFO - no previously-included directories found matching 'build' 01:52:54 INFO - no previously-included directories found matching 'dist' 01:52:54 INFO - no previously-included directories found matching '.git*' 01:52:54 INFO - Successfully installed jsonschema functools32 01:52:54 INFO - Cleaning up... 01:52:54 INFO - Return code: 0 01:52:54 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 01:52: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')]} 01:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:52:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52: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')]} 01:52:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:52:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:52:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6a9d560f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdeb630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7c840>, '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 0xde96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde9b60>, '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': '5cf47e208febbcd81da23b2e0000026f-1452850945.378970-1360290163', '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 01:52:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 01:52:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:52:54 INFO - Using env: {'DISPLAY': ':0', 01:52:54 INFO - 'HOME': '/home/cltbld', 01:52:54 INFO - 'LANG': 'en_US.UTF-8', 01:52:54 INFO - 'LANGUAGE': 'en_US:en', 01:52:54 INFO - 'LOGNAME': 'cltbld', 01:52:54 INFO - 'MAIL': '/var/mail/cltbld', 01:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:52:54 INFO - 'MOZ_NO_REMOTE': '1', 01:52:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:52:54 INFO - 'NO_EM_RESTART': '1', 01:52:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:52:54 INFO - 'PWD': '/builds/slave/test-pgo', 01:52:54 INFO - 'SHELL': '/bin/bash', 01:52:54 INFO - 'SHLVL': '1', 01:52:54 INFO - 'TERM': 'linux', 01:52:54 INFO - 'TMOUT': '86400', 01:52:54 INFO - 'USER': 'cltbld', 01:52:54 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1452850945.378970-1360290163', 01:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:52:54 INFO - '_': '/tools/buildbot/bin/python'} 01:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:52:54 INFO - Downloading/unpacking flake8 01:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:52:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 01:52:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:52:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 01:52:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 01:52:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:52:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 01:52:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 01:52:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:52:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:52:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:52:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:52:57 INFO - no previously-included directories found matching 'docs/_build' 01:52:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:52:57 INFO - Running setup.py install for pep8 01:52:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:52:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:52:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:52:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:52:57 INFO - no previously-included directories found matching 'docs/_build' 01:52:57 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 01:52:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:52:57 INFO - Cleaning up... 01:52:57 INFO - Return code: 0 01:52:57 INFO - Running post-action listener: _resource_record_post_action 01:52:57 INFO - Running post-action listener: _start_resource_monitoring 01:52:57 INFO - Starting resource monitoring. 01:52:57 INFO - ##### 01:52:57 INFO - ##### Running install step. 01:52:57 INFO - ##### 01:52:57 INFO - Running pre-action listener: _resource_record_pre_action 01:52:57 INFO - Running main action method: install 01:52:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:52:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:52:57 INFO - Reading from file tmpfile_stdout 01:52:57 INFO - Detecting whether we're running mozinstall >=1.0... 01:52:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 01:52:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 01:52:57 INFO - Reading from file tmpfile_stdout 01:52:57 INFO - Output received: 01:52:57 INFO - Usage: mozinstall [options] installer 01:52:57 INFO - Options: 01:52:57 INFO - -h, --help show this help message and exit 01:52:57 INFO - -d DEST, --destination=DEST 01:52:57 INFO - Directory to install application into. [default: 01:52:57 INFO - "/builds/slave/test-pgo"] 01:52:57 INFO - --app=APP Application being installed. [default: firefox] 01:52:57 INFO - mkdir: /builds/slave/test-pgo/build/application 01:52:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 01:52:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 01:53:13 INFO - Reading from file tmpfile_stdout 01:53:13 INFO - Output received: 01:53:13 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 01:53:13 INFO - Running post-action listener: _resource_record_post_action 01:53:13 INFO - ##### 01:53:13 INFO - ##### Running run-tests step. 01:53:13 INFO - ##### 01:53:13 INFO - Running pre-action listener: _resource_record_pre_action 01:53:13 INFO - Running main action method: run_tests 01:53:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 01:53:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 01:53:13 INFO - Python 2.7.3 01:53:13 INFO - Return code: 0 01:53:13 INFO - grabbing minidump binary from tooltool 01:53:13 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')]} 01:53:13 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 0xe7c840>, '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 0xde96b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde9b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 01:53:13 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 01:53:13 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 01:53:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:53:13 INFO - Return code: 0 01:53:13 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 01:53:13 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 01:53:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 01:53:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 01:53:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 01:53:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 01:53:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 01:53:14 INFO - Return code: 0 01:53:14 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/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 01:53:14 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/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 01:53:14 INFO - Using env: {'DISPLAY': ':0', 01:53:14 INFO - 'HOME': '/home/cltbld', 01:53:14 INFO - 'LANG': 'en_US.UTF-8', 01:53:14 INFO - 'LANGUAGE': 'en_US:en', 01:53:14 INFO - 'LOGNAME': 'cltbld', 01:53:14 INFO - 'MAIL': '/var/mail/cltbld', 01:53:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:53:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 01:53:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:53:14 INFO - 'MOZ_NO_REMOTE': '1', 01:53:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:53:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:53:14 INFO - 'NO_EM_RESTART': '1', 01:53:14 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:53:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:53:14 INFO - 'PWD': '/builds/slave/test-pgo', 01:53:14 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 01:53:14 INFO - 'SHELL': '/bin/bash', 01:53:14 INFO - 'SHLVL': '1', 01:53:14 INFO - 'TERM': 'linux', 01:53:14 INFO - 'TMOUT': '86400', 01:53:14 INFO - 'USER': 'cltbld', 01:53:14 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1452850945.378970-1360290163', 01:53:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:53:14 INFO - '_': '/tools/buildbot/bin/python'} 01:53:14 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/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 01:53:15 INFO - mozversion application_buildid: 20160114233009 01:53:15 INFO - mozversion application_changeset: 0ae26b71481ae676e540a0a2841837fbb939cb88 01:53:15 INFO - mozversion application_display_name: Nightly 01:53:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:53:15 INFO - mozversion application_name: Firefox 01:53:15 INFO - mozversion application_remotingname: firefox 01:53:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:53:15 INFO - mozversion application_vendor: Mozilla 01:53:15 INFO - mozversion application_version: 46.0a1 01:53:15 INFO - mozversion platform_buildid: 20160114233009 01:53:15 INFO - mozversion platform_changeset: 0ae26b71481ae676e540a0a2841837fbb939cb88 01:53:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:53:15 INFO - mozversion platform_version: 46.0a1 01:53:15 INFO - using testdate: 1452851595 01:53:15 INFO - actual date: 1452851595 01:53:15 INFO - starting webserver on 'localhost:32947' 01:53:15 INFO - SUITE-START | Running 3 tests 01:53:15 INFO - TEST-START | dromaeo_css 01:53:15 INFO - operating with platform_type : linux_ 01:53:15 INFO - Initialising browser for dromaeo_css test... 01:53:15 INFO - TEST-INFO | started process 3436 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiV3Ofb/profile http://localhost:32947/getInfo.html) 01:53:22 INFO - PROCESS | 3436 | 01:53:22 INFO - PROCESS | 3436 | (process:3520): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:53:24 INFO - PROCESS | 3436 | __metrics Screen width/height:1600/1200 01:53:24 INFO - PROCESS | 3436 | colorDepth:24 01:53:24 INFO - PROCESS | 3436 | Browser inner width/height: 1024/697 01:53:24 INFO - PROCESS | 3436 | __metrics 01:53:24 INFO - PROCESS | 3436 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 01:53:25 INFO - TEST-INFO | 3436: exit 0 01:53:25 INFO - Browser initialized. 01:53:25 INFO - Running cycle 1/1 for dromaeo_css test... 01:53:25 INFO - TEST-INFO | started process 3569 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiV3Ofb/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:53:26 INFO - PROCESS | 3569 | 01:53:26 INFO - PROCESS | 3569 | (process:3628): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:53:37 INFO - PROCESS | 3569 | RSS: Main: 150249472 01:53:37 INFO - PROCESS | 3569 | 01:54:26 INFO - PROCESS | 3569 | 1452851666921 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] 01:56:35 INFO - PROCESS | 3569 | Cycle 1(1): loaded http://localhost:32947/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32947/tests/dromaeo/cssquery-ext.html) 01:56:36 INFO - PROCESS | 3569 | RSS: Main: 156549120 01:56:36 INFO - PROCESS | 3569 | 01:59:38 INFO - PROCESS | 3569 | Cycle 1(1): loaded http://localhost:32947/tests/dromaeo/cssquery-ext.html (next: http://localhost:32947/tests/dromaeo/cssquery-jquery.html) 01:59:38 INFO - PROCESS | 3569 | RSS: Main: 151805952 01:59:38 INFO - PROCESS | 3569 | 02:02:40 INFO - PROCESS | 3569 | Cycle 1(1): loaded http://localhost:32947/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32947/tests/dromaeo/cssquery-mootools.html) 02:02:41 INFO - PROCESS | 3569 | RSS: Main: 151371776 02:02:41 INFO - PROCESS | 3569 | 02:05:42 INFO - PROCESS | 3569 | Cycle 1(1): loaded http://localhost:32947/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32947/tests/dromaeo/cssquery-prototype.html) 02:05:43 INFO - PROCESS | 3569 | RSS: Main: 151195648 02:05:43 INFO - PROCESS | 3569 | 02:08:45 INFO - PROCESS | 3569 | Cycle 1(1): loaded http://localhost:32947/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32947/tests/dromaeo/cssquery-yui.html) 02:08:46 INFO - PROCESS | 3569 | RSS: Main: 151560192 02:08:46 INFO - PROCESS | 3569 | 02:11:48 INFO - PROCESS | 3569 | Cycle 1(1): loaded http://localhost:32947/tests/dromaeo/cssquery-yui.html (next: http://localhost:32947/tests/dromaeo/cssquery-dojo.html) 02:11:49 INFO - PROCESS | 3569 | RSS: Main: 153284608 02:11:49 INFO - PROCESS | 3569 | 02:11:49 INFO - PROCESS | 3569 | __start_tp_report 02:11:49 INFO - PROCESS | 3569 | _x_x_mozilla_page_load 02:11:49 INFO - PROCESS | 3569 | _x_x_mozilla_page_load_details 02:11:49 INFO - PROCESS | 3569 | |i|pagename|runs| 02:11:49 INFO - PROCESS | 3569 | |0;dojo.html;3179.904602861914;3187.505936579831;3217.8230197339167;3227.1932016995756;3231.127595549202;5252.47475252475;5274.630775845682;5310.681359118451;5322.574194064475;5328.094223981932;5265.236540701606;5292.841214763564;5319.0957537218665;5365.03429382711;5368.1679339702405;4844.20070688336;4865.245886887538;4931.778069986841;4959.578435832958;5009.549140577347;341.96246594798606;4621.560951709582;4761.190597598399;4869;4875.804967801284;4807.375041244633;4870.756462176894;4891.559759621651;4900.068986892479;4955.752212389366;4850.5877000455;4853.781579828917;4863.975680121612;4868.513148685139;4908.0429316283335;4793.113274044313;4801.903961920742;4870;4884.926726099111;4915.827946021872;5107.846764597068;5174.715390653512;5174.974125129388;5213.061648903196;5215.191645294985;5737.885242295172;5750.5687073469235;5766.481016708516;5768.42315768424;5831.300243970708;5671.602987790856;5766.913496297559;5776.451237132465;5834.066549352126;5891.675957822318;5288.788448462057;5356.1697936819855;5360.410354860962;5370.758315875834;5372.086745253317;5818.709064546756;5837.532997360201;5838.7080645967535;5846.8538286542325;5846.941530584725;5540.501354878081;5605.579581531401;5674.773009079673;5752.539796816244;5797.4782269595935;5619.072852979294;5643.294588176478;5669.914951275734;5696.8006119785605;5705.4009329019855;5584.246126772915;5653.067243904709;5656.43435656431;5659.377468478464;5666.744996475169;5715.571332150105;5758.942410575924;5764.481196692318;5821.2141360916585;5851;4424.80088396023;4429.82280708768;4445.177642136216;4449.688521803508;4452.510223875371;3869.613038696164;3959.1289916218384;3985.362342025262;4005.859794907164;4027.9930017495626;5319.202119682079;5336.62643614951;5388.838334849961;5399.190121481809;5431.321084864392;5738.913916291259;5747.08046712524;5765.04876695349;5769.538436925036;5791.391903850035;5259.15853463444;5339.012282727708;5371.060064488699;5372.946270537244;5432.239486471897;4857.441394239637;4866.8053277868485;4879.658423910292;4912;4947.060058588857;5940.138679891392;5942.346341902387;5945.881082378415;5955.612885162451;5960.37416071315;5566.638168519034;5671.631343962629;5710.543156547383;5718.599698021098;5735.77056917727;5960.1357803117435;5971.253593300838;5972.552058595709;5980;6030;5630.099184130683;5692.203091567101;5697.515711164431;5705.885882282248;5731.512821410227;5639.774409023593;5727.083666613322;5742.224799651994;5775.422457754191;5813.709314534341;5571.8885622288135;5609.831705048855;5611.6352437091455;5640.210370548209;5648.661080335193;5602.355729091207;5630.127330263816;5632.831015069554;5640.125780504029;5659.405762395054;5496.422875598005;5532.2254884315425;5543.445655434424;5547.1679248113105;5566.777328906798;5589.860253493533;5626.2967129108865;5647.745851436777;5662.462066103713;5663;5529.668219906657;5529.917051244315;5530.281063461724;5534.142207957773;5544.473275038865 02:11:49 INFO - PROCESS | 3569 | |1;ext.html;513.5891286970425;531.7713383245205;534.901043306988;536.2546060975245;557.4676184244046;29008.419831603354;36250.8187459063;36326;36649.45025824615;36691.26617467652;38927;38992.80503597478;39274.21451570967;39289.41065884014;39496.012599685026;8312.958435207831;8467.449615774985;8546.230839224469;8560.229579337858;8590.570471476402;8275.296599788995;8353.289970352527;8383.62273697682;8390.412671113025;8417.284530814888;8325;8459.53472559009;8511.489310641351;8518.148185181495;8546.61540230688;8330.83338333233;8429.578521073952;8450.070492245848;8641.913580864237;8643.438176518506;8515.616797244138;8598.613062412143;8617.827643447095;8634.784130396727;8656.091110433377;38998.220035599414;39294.803525982476;39321.80339098315;39375.80312098421;39384.60615393838;3141.9371612567847;3171.1913462067255;3177.539256807773;3312.072619666473;3519.9120021999397;29092.127236182947;29264.853675731698;29382.265443363875;29772.255693607618;30425;3876.8061596920325;3918.9020274493364;3945.684345252373;4069.1454794493193;4132.91734165315;253751;256027;256225;256624;257428;42212.577874220864;42789.35815962763;42869.14261714748;42888.57111428908;56212.71893640506;43935.34096988484;44085.77957110258;44147;44167.233310667856;44230.77884610556;14884.62788430298;15146.924265378602;15160.469383571522;15232.390704371923;15272.236388180547;11710.180287379972;12009.579664711693;12010.198470229361;12053;12272.631821045383;14260.85739142616;14395.640108997359;14395.712085758227;14462.566123016326;14594.124352538669;5680.14797780328;5809.593328467051;5828.825135245949;5862.736176872051;5922.555808314393;918.2103391083663;942.9575669094908;993.3295025857517;1027.4759872465097;1040.3029969920171;25535;25688;25716.228513144637;25908.481830363664;25958.610620840704;994.3735446668552;1017.7353887989028;1050.3487837540774;1102.9191392435457;1141.3095077478172;13269;13431.865681343257;13432.529861454803;13576.456941722417;13635.795463067863;303858;303877;305680;306943;307497;51049.74475127675;51178.74410627923;51374.486255137715;51628.48371516312;51778.48221517812;1328.8006798980036;1332.9400176992058;1343.0867010432803;1344.8520662727092;1358.0968655843753;24573.631395528722;25464;25581.3604659885;25711;25726.228213153634;45606;45873;45911.08177836491;45958.54041459676;45983.31025034694;284667;286671;286921;286995;289116;32370.676293236767;42020.57979420289;42636;42676.78661606672;42703.3594496089;40854.38718419167;41776.58223417727;42159.7892010538;42406;42922.35616465818;35602.64397356097;35862;35878;36127.45808812923;36627.816860915525;35643.28713425769;35824.632166664764;36086.819565902006;36208.637913621584;36263.81868090643;34858.302833943686;35390.11524711903;35393.46909796304;35494.64505354913;35725.46411803877;29327.85336073306;31631.52552711757;31875.20311992219;31978.840105800253;32186.517202241517;24546.31186599666;24565.631515526922;24713;24906.626400603644;24929.252122436355 02:11:49 INFO - PROCESS | 3569 | |2;jquery.html;347.9217176135369;351.493848857645;355.52182314786637;360.6303538872657;363.6999475432767;15443.768343474843;16344;17764.200610972504;17817.465476035723;18572.164252608633;13610.11534250273;16427.507174784776;16706.24821883015;16851.325946962108;16927.49217523476;4938.1111399947995;5076.086304465195;5140.4859514048485;5145.048166089286;5146.279520867081;5046.52058054486;5097.694138351692;5129.358830146231;5418.2685337479525;5433.402325744165;5430.049741295277;5461.836144915659;6491.156149700532;6763.729450821961;6765.883629201176;6532;6669.9666501667425;6690.899636505456;6693.330666933292;6828.658567071627;6391.77628782995;6646.468282537386;6664.733410663568;6666.866662666719;6692.866142677168;21163.788362116335;21347.466313342135;21692.457688557755;22450.663240051414;22613.32160035185;2148.52732398872;2267.8299127565333;2292.2321022457495;2341.7072865891764;2383.1897154967396;13008.34958252093;13542.255175965318;13870.791938120936;14290.785638215435;14543.563693089118;1938.5250613599617;1941.679622862226;1963.8036196380247;1972.5857569910336;1979.8020197980086;61382.69308653473;64166.03750943786;65354;65772.3422765771;66802;14894.627634309012;15147.848521514865;15275.847241527665;15285.694286114216;15385.923070384577;23507.17724879621;23574.646380304308;23745.525089498115;23994.28017159488;24018.39954001164;6936.237013928464;7254.129504459499;7612.276833700789;7649.087728067983;9220.492872892055;7611.505252158592;7686.269804368576;7740.961295193488;7745.380369570421;7788.571628560484;4530.750808705553;4561.840335588305;4568.543145685471;4620.029793743352;4628.213203755302;1835.5301202416606;1877.7840548337117;1889.0837943597344;1903.2767548331544;1924.5765931495048;922.2437601166979;932.6036434515304;950.6245033211843;950.6862735297335;1001.464216644092;14294.928525357514;16571.25429355682;16586.75599330031;16671.833281667026;16999.150042497826;909.2044461096541;953.8044700836311;954.0983770337103;958.7890664053897;1001.1490233301636;8907.866382004275;9134.086591340945;9144.451332920045;9159.267258619428;9207.125323094295;489212;496171;496679;507344;511510;46313;62169.37830621636;62542.374576254566;72110.63944680244;73956.15109622195;1111.572044762756;1119.1047162270152;1119.8152304869768;1125.1561329003248;1130.112861403794;14180.787288190892;14459.204743739196;14832.629184270048;15047;15270.389184432943;22664;24314.635280470455;28750;30037.5494367589;30628.693713062585;40401.39397909093;40734;41301.173976520906;42695;43998.340024900295;7201.747938822116;7430.922516235008;7519.849603008019;7703.691852326068;7805.14143444232;8059.637316320663;10969.122470202525;11681.240719353214;11918.761624767629;12225.510979561073;7476.5887876167335;7514.023176986957;7557.470977031775;7809.726659566888;7840.529568225925;7892.4869883457395;8152.225538573826;8190.262876341158;8268.2558569729;8303.252707256375;7815.179406162271;7836.138024817152;7893.644785984759;7896.09194942589;7922.683092676229;10044.146247568746;10239.641612543524;10382.42896640692;10581.841272380767;10801.135909127408;7495.850082998419;7985.441019128605;10521.421321827373;10672.786544269227;10783.24517283814 02:11:49 INFO - PROCESS | 3569 | |3;mootools.html;1453.5566652171087;1478.0835881753314;1616.2161351744403;1760.9383671571497;1771.264925056101;7709.961450192748;7846.72536461224;7962.601869906503;7974.7208847690345;7982.560959147252;7713.884291735629;7716.7684969451;7726.96136519318;7814.296713295802;7843.215678432154;2338.590746619339;2353.62342025276;2360.303710405426;2372.8457650252676;2373.3473294843884;2345.95308093838;2371.5494056129282;2374.976250237493;2375.6080246759266;2381.9166329178483;2310.06442390832;2314.537092581482;2333.4866329407505;2357.8938947747306;2376.4771750215014;2340.8595484270913;2350.8001819845163;2391.9043238270447;2392.306231192952;2398.328468028955;2366.6923299971068;2378.881055947196;2382.594958856981;2399.8800059997106;2405.927822165338;7871.134175240719;8044.074931382907;8067.435279530435;8100.47346922454;8146.063202731643;4814.542618451242;4980.178270585349;4987.501249875019;4995.200767877159;5005.74971251436;3096.8916087936814;3149.6062992125985;3171.5242713592916;3179.2369831240567;3181.490961446181;1110.9944450277696;1113.4655365424642;1147.288681017766;1177.7350096228365;1189.9464524096436;11026.558937642485;11101.611443599435;11113;11131.888681113085;11154.832677509843;4204.894877628022;4272.444582204355;4332.978335108304;4354.085642015149;4360.716553424018;9037.68368107113;9048.321375896703;9056;9061.59222834974;9063.728088157366;4828.66199366048;4862.562369386701;4875.68308059975;4879.1461494238365;4884.853454396374;4403.273459879084;4459.777011149495;4460.50934397216;4473.015936493966;4485.865424037284;3387.187075101958;3500.7374446916583;3510.5080340855034;3515.525404070469;3521.542199514047;1054.488573042074;1060.6340812419703;1082.4858192358568;1087.5649740104022;1092.137211602825;959.9616015359447;1049.5801679328329;1098.0117893895558;1160.7968605494004;1281.5770795637418;7143.9285607143265;7162.641867906584;7221.927780722231;7256.854862902713;7279.272072792678;627.4791922704145;644.5616980453243;646.5732616473106;648.8929326661142;778.9143194248628;5629.268195134607;5706.743196556165;5745.712714364265;5752.453516915886;5779.450952159538;8861.601227944759;9055.094490550891;9102.95316038664;9197.034311397341;9211.493367864698;8953.507557084424;9185.127412895765;9209.907900921038;9402.764930876783;9405.294602904673;7243.203247642755;7298.452616053817;7319.085114360599;7336.303051210127;7364.926350736424;6979.127609048869;7041.5422997505;7076.929230707627;7110.4667149965;7133.643317834191;8310.293625041697;8311.916880831357;8340.499570025819;8460.407771455939;8537.18896704812;8365.62354694028;8601.526916019679;8626.913730862861;8631.136886311318;8694.130586941255;6594.208694956636;6633.2040155181685;6678.265390806911;6683.8663226734225;6732.865342693217;7262.237465066303;7419.443541734499;7465.328120469184;7497.775066748006;7531.3598344141365;6950.374466298057;7020.648967551704;7039.577625342496;7222.422206223385;7241.094863142107;6791.100284044038;6909.481788865955;6916.757913473004;6936.861262774615;7186.209516953027;6660.700268488026;6714.3957043866285;6775.966120169564;6810.353016463428;6822.897656535057;6365.077063825812;6375.266844312778;6387.968060159669;6395.584287021329;6398.808035758934;6266.216722909637;6346.174997250512;6378.712957916812;6438.3883531064475;6467.3209313023335 02:11:49 INFO - PROCESS | 3569 | |4;prototype.html;340.47566747209294;350.58980992239077;351.88036067736965;354.6240984556369;355.839872057574;6277.740013595102;6304.211973503312;6430.228372595289;6470.870582588345;6476;6314.305426403103;6361.395667411589;6363.71363288652;6380;6408.26304974928;4810.422749270093;4824.614030877521;4826.227803551433;4828.927566086511;4829.299751536025;4822.951770482286;4823.107725070856;4823.975880120612;4824.059308434857;4824.565789078983;4687.507811679776;4787.138315103298;4793.952060479385;4796.232602783555;4811.30236115763;4732;4748.335233067339;4755.667103302771;4765.404324459442;4780.09178256132;4121.835126594962;4123.958760412387;4139.627433530966;4153.522344930341;4162.458880345566;6018.127371531104;6023.698815059273;6026.2165918430765;6028.698565071729;6048.092786082079;5480.616356855022;5617.775288988436;5617.960677274717;5618.831435056954;5641.210230567724;6698.732050717966;6714.362135597111;6744.190697116328;6745.898811517831;6751.864962700768;4583.2666773316105;4612.630989520831;4618.35343051973;4629.398178236807;4631.907361852778;6805.353491418307;6958.582485050913;7003.474739394565;7067.9293207067785;7070.434365250768;4669.976650116728;4737.170995075848;4742.881427964328;4761.309610106515;4764.8332308369045;4813.350197723333;4824.734639594786;4827.806887724451;4828.637852161102;4833.589144922721;5556.555475561945;5570.888582228333;5576.33084029919;5578.41426650204;5592.3009623797025;6540.869182616321;6751.156105486814;6768.458523318122;6786.558873673195;6788.490863185182;1647.8022637283602;1674.5646132005766;1689.3918189451788;1690.5773556610848;1691.687037897993;1092.4810714910514;1115.9721006974892;1123.1688550472754;1124.746931940307;1136.8806275341135;6202.72087756052;6210.813675589649;6240.687965601702;6285.685715714196;6303.212098487689;6741.59550426976;6813.454923606099;6815.488838337144;6822.351876571718;6826.044353790473;6135.478484328882;6235.469985051231;6236.563440559208;6242.750289988349;6268.310485846553;3695.0762309422644;3709.5177626908867;3716.717732382324;3719.962800372016;3721.348763966295;7072.8939065914055;7074.151101867706;7125.857482850314;7133.500654954103;7148.428125749928;6992.6853291602;6993.720251189896;7001.089858318386;7003.719851205997;7007;7354.411647068328;7357.889631655529;7359.337659610661;7359.558426494427;7365.373943214887;6962;6999.055127557918;7017.05269788572;7019.649017549;7025.192102908231;6807.353301436356;6931.653417329214;6933.826654333682;6938.098047253825;6953.33943275388;7315.158756743042;7330.486865919334;7339.605474959741;7340.2292759261645;7357.926420735724;4731.574158325767;4763.333133361401;4777.928331074967;4778.187708089564;4782.187028205283;6866.279040700854;6910.343517365842;7029.156501219886;7047.330503602149;7058.788236352918;6811.557248778813;6824.146981627297;6846.452283817183;6855.280195579392;6871.759488417882;6781;6797.116374871235;6810.353016463428;6822.215445223665;6835.14560679915;6562.671866406565;6673.366030227121;6698.22970358415;6705.262421133574;6722.226943901514;6832.419244364285;6888.380045795902;6894.793156205322;6896;6898.827529311808;6593.406593406617;6665.233498147775;6675.833104172434;6677.632730199885;6711.966440167963 02:11:49 INFO - PROCESS | 3569 | |5;yui.html;797.984040319194;803.7421435453515;817.4049865662557;820.0282665041922;824.3981893217953;13158.473661053558;13282.402291896864;13397.464101435955;13429.597112086629;13470.326483675814;12573.622791316275;12816.807747883766;12838.614841554769;12848.421821018053;13495.865041349609;806.435495153392;807.9353651707879;809.158475185809;809.8582748019103;810.9594520273993;800.7237503061434;802.0415603353995;805.8227190018187;807.4549678966704;808.4260175275562;839.0686338164633;843.2158092973532;843.5866425451546;844.2823599940064;844.2950136635916;839.7858546070773;841.4278290762279;841.9284360829306;842.8819965204876;843.8734189871507;614.8032629558543;616.5622408090261;616.5899676714979;618.6442795392667;620.764109638339;12430.192037517623;12479.126461147724;12480.687982800411;12515.812262816065;12516.624501264885;11333.886661133365;11352.375619340934;11384.601538946097;11543.191976561644;11632.825507617308;9538.904610953941;9709.271804614611;9840.852387214198;9868;9896.851547226725;3519.577650681909;3522.788632682047;3606.098475381155;3622.7464077514583;3675.6140605236333;45775.31337029914;46003.30995035077;48182.51817481816;54651.72674136644;55500.722496387665;10572.682819515427;10670.62652807148;10774.4074075925;10846.078083363003;11257.887421125848;18754.24983000692;18778.248870045318;18829.152688129067;18851;18877.33929312495;7363.9631801841715;8156.469829461066;8158.755237342771;8308.833823323499;8351.540665263468;4267.679924005712;4310.353446982977;4375.7155784873885;4386.934195987063;4426.291793313055;3120.968790312113;3146.1819926818735;3164.651888292286;3166.683331666815;3167.319026409333;581.5870731780399;587.1808826686748;587.9265091863517;596.7672607683007;606.771288141517;536.1368197202501;543.7906406033705;572.5562688916124;589.6108568344872;656.1044174701498;8170.550619715854;8190.918090819135;8368.217458449417;8436.746897593082;8490.490570565786;511.72878374461595;528.1707718881396;529.7007190937109;533.5198321510594;642.4828013449124;3858.305505009125;3906.4726261954843;4021;4066.755994640331;4106.240345536085;56037.439625604035;61480.69259653763;61501.69249153815;61508.384916150266;61556.69221653863;51027.48972510227;51802;54909;55802.88394232093;57421.71289143527;47684;50079.15699053597;54004.18993715097;54306.56934306538;55261.89476210453;8560.743177704679;8683.609237584198;8763.474191548528;8804.383693141675;8995.145461181177;35907;35998;36573.45139822958;37158.44262336013;37433.43849842309;43985;46544.301835473176;47002.29496557486;47777;47782;11196.552137914392;11249.156313276373;11318.717032074264;11319.434028298718;11406.82889756671;10690.037896589345;10820.729481763019;11889.167758257185;11948.820767688318;12613;10795.298305610424;10980.725481863017;11097.611583594535;11315.773684526428;11329.660110196708;10823.945880270863;10871.474480528756;11216.607418740305;11224.66326010221;11604.496170297558;10211.948940255548;10581.418022008864;10602.734931626772;10627.93720627931;10632.627858025242;9044.773880653036;9213.355065145644;9281.953590232006;9293.814123717622;9440.291978101806;7757.573333466714;8636.524991125549;9641.517924103908;9671.758206044624;9944.651937182163 02:11:49 INFO - PROCESS | 3569 | __end_tp_report 02:11:49 INFO - PROCESS | 3569 | __start_cc_report 02:11:49 INFO - PROCESS | 3569 | _x_x_mozilla_cycle_collect,319 02:11:49 INFO - PROCESS | 3569 | __end_cc_report 02:11:49 INFO - PROCESS | 3569 | __startTimestamp1452852709148__endTimestamp 02:11:49 INFO - PROCESS | 3569 | 02:11:49 INFO - PROCESS | 3569 | ------- Summary: start ------- 02:11:49 INFO - PROCESS | 3569 | Number of tests: 6 02:11:49 INFO - PROCESS | 3569 | 02:11:49 INFO - PROCESS | 3569 | [#0] dojo.html Cycles:165 Average:5295.12 Median:5543.45 stddev:706.50 (12.7%) stddev-sans-first:688.91 02:11:49 INFO - PROCESS | 3569 | Values: 3179.9 3187.5 3217.8 3227.2 3231.1 5252.5 5274.6 5310.7 5322.6 5328.1 5265.2 5292.8 5319.1 5365.0 5368.2 4844.2 4865.2 4931.8 4959.6 5009.5 342.0 4621.6 4761.2 4869.0 4875.8 4807.4 4870.8 4891.6 4900.1 4955.8 4850.6 4853.8 4864.0 4868.5 4908.0 4793.1 4801.9 4870.0 4884.9 4915.8 5107.8 5174.7 5175.0 5213.1 5215.2 5737.9 5750.6 5766.5 5768.4 5831.3 5671.6 5766.9 5776.5 5834.1 5891.7 5288.8 5356.2 5360.4 5370.8 5372.1 5818.7 5837.5 5838.7 5846.9 5846.9 5540.5 5605.6 5674.8 5752.5 5797.5 5619.1 5643.3 5669.9 5696.8 5705.4 5584.2 5653.1 5656.4 5659.4 5666.7 5715.6 5758.9 5764.5 5821.2 5851.0 4424.8 4429.8 4445.2 4449.7 4452.5 3869.6 3959.1 3985.4 4005.9 4028.0 5319.2 5336.6 5388.8 5399.2 5431.3 5738.9 5747.1 5765.0 5769.5 5791.4 5259.2 5339.0 5371.1 5372.9 5432.2 4857.4 4866.8 4879.7 4912.0 4947.1 5940.1 5942.3 5945.9 5955.6 5960.4 5566.6 5671.6 5710.5 5718.6 5735.8 5960.1 5971.3 5972.6 5980.0 6030.0 5630.1 5692.2 5697.5 5705.9 5731.5 5639.8 5727.1 5742.2 5775.4 5813.7 5571.9 5609.8 5611.6 5640.2 5648.7 5602.4 5630.1 5632.8 5640.1 5659.4 5496.4 5532.2 5543.4 5547.2 5566.8 5589.9 5626.3 5647.7 5662.5 5663.0 5529.7 5529.9 5530.3 5534.1 5544.5 02:11:49 INFO - PROCESS | 3569 | 02:11:49 INFO - PROCESS | 3569 | [#1] ext.html Cycles:180 Average:44165.44 Median:36229.73 stddev:74054.42 (204.4%) stddev-sans-first:74189.64 02:11:49 INFO - PROCESS | 3569 | Values: 513.6 531.8 534.9 536.3 557.5 29008.4 36250.8 36326.0 36649.5 36691.3 38927.0 38992.8 39274.2 39289.4 39496.0 8313.0 8467.4 8546.2 8560.2 8590.6 8275.3 8353.3 8383.6 8390.4 8417.3 8325.0 8459.5 8511.5 8518.1 8546.6 8330.8 8429.6 8450.1 8641.9 8643.4 8515.6 8598.6 8617.8 8634.8 8656.1 38998.2 39294.8 39321.8 39375.8 39384.6 3141.9 3171.2 3177.5 3312.1 3519.9 29092.1 29264.9 29382.3 29772.3 30425.0 3876.8 3918.9 3945.7 4069.1 4132.9 253751.0 256027.0 256225.0 256624.0 257428.0 42212.6 42789.4 42869.1 42888.6 56212.7 43935.3 44085.8 44147.0 44167.2 44230.8 14884.6 15146.9 15160.5 15232.4 15272.2 11710.2 12009.6 12010.2 12053.0 12272.6 14260.9 14395.6 14395.7 14462.6 14594.1 5680.1 5809.6 5828.8 5862.7 5922.6 918.2 943.0 993.3 1027.5 1040.3 25535.0 25688.0 25716.2 25908.5 25958.6 994.4 1017.7 1050.3 1102.9 1141.3 13269.0 13431.9 13432.5 13576.5 13635.8 303858.0 303877.0 305680.0 306943.0 307497.0 51049.7 51178.7 51374.5 51628.5 51778.5 1328.8 1332.9 1343.1 1344.9 1358.1 24573.6 25464.0 25581.4 25711.0 25726.2 45606.0 45873.0 45911.1 45958.5 45983.3 284667.0 286671.0 286921.0 286995.0 289116.0 32370.7 42020.6 42636.0 42676.8 42703.4 40854.4 41776.6 42159.8 42406.0 42922.4 35602.6 35862.0 35878.0 36127.5 36627.8 35643.3 35824.6 36086.8 36208.6 36263.8 34858.3 35390.1 35393.5 35494.6 35725.5 29327.9 31631.5 31875.2 31978.8 32186.5 24546.3 24565.6 24713.0 24906.6 24929.3 02:11:49 INFO - PROCESS | 3569 | 02:11:49 INFO - PROCESS | 3569 | [#2] jquery.html Cycles:180 Average:26857.68 Median:4565.19 stddev:81635.94 (1788.2%) stddev-sans-first:81840.68 02:11:49 INFO - PROCESS | 3569 | Values: 347.9 351.5 355.5 360.6 363.7 15443.8 16344.0 17764.2 17817.5 18572.2 13610.1 16427.5 16706.2 16851.3 16927.5 4938.1 5076.1 5140.5 5145.0 5146.3 5046.5 5097.7 5129.4 5418.3 5433.4 5430.0 5461.8 6491.2 6763.7 6765.9 6532.0 6670.0 6690.9 6693.3 6828.7 6391.8 6646.5 6664.7 6666.9 6692.9 21163.8 21347.5 21692.5 22450.7 22613.3 2148.5 2267.8 2292.2 2341.7 2383.2 13008.3 13542.3 13870.8 14290.8 14543.6 1938.5 1941.7 1963.8 1972.6 1979.8 61382.7 64166.0 65354.0 65772.3 66802.0 14894.6 15147.8 15275.8 15285.7 15385.9 23507.2 23574.6 23745.5 23994.3 24018.4 6936.2 7254.1 7612.3 7649.1 9220.5 7611.5 7686.3 7741.0 7745.4 7788.6 4530.8 4561.8 4568.5 4620.0 4628.2 1835.5 1877.8 1889.1 1903.3 1924.6 922.2 932.6 950.6 950.7 1001.5 14294.9 16571.3 16586.8 16671.8 16999.2 909.2 953.8 954.1 958.8 1001.1 8907.9 9134.1 9144.5 9159.3 9207.1 489212.0 496171.0 496679.0 507344.0 511510.0 46313.0 62169.4 62542.4 72110.6 73956.2 1111.6 1119.1 1119.8 1125.2 1130.1 14180.8 14459.2 14832.6 15047.0 15270.4 22664.0 24314.6 28750.0 30037.5 30628.7 40401.4 40734.0 41301.2 42695.0 43998.3 7201.7 7430.9 7519.8 7703.7 7805.1 8059.6 10969.1 11681.2 11918.8 12225.5 7476.6 7514.0 7557.5 7809.7 7840.5 7892.5 8152.2 8190.3 8268.3 8303.3 7815.2 7836.1 7893.6 7896.1 7922.7 10044.1 10239.6 10382.4 10581.8 10801.1 7495.9 7985.4 10521.4 10672.8 10783.2 02:11:49 INFO - PROCESS | 3569 | 02:11:49 INFO - PROCESS | 3569 | [#3] mootools.html Cycles:180 Average:5466.99 Median:6391.78 stddev:2825.92 (44.2%) stddev-sans-first:2817.75 02:11:49 INFO - PROCESS | 3569 | Values: 1453.6 1478.1 1616.2 1760.9 1771.3 7710.0 7846.7 7962.6 7974.7 7982.6 7713.9 7716.8 7727.0 7814.3 7843.2 2338.6 2353.6 2360.3 2372.8 2373.3 2346.0 2371.5 2375.0 2375.6 2381.9 2310.1 2314.5 2333.5 2357.9 2376.5 2340.9 2350.8 2391.9 2392.3 2398.3 2366.7 2378.9 2382.6 2399.9 2405.9 7871.1 8044.1 8067.4 8100.5 8146.1 4814.5 4980.2 4987.5 4995.2 5005.7 3096.9 3149.6 3171.5 3179.2 3181.5 1111.0 1113.5 1147.3 1177.7 1189.9 11026.6 11101.6 11113.0 11131.9 11154.8 4204.9 4272.4 4333.0 4354.1 4360.7 9037.7 9048.3 9056.0 9061.6 9063.7 4828.7 4862.6 4875.7 4879.1 4884.9 4403.3 4459.8 4460.5 4473.0 4485.9 3387.2 3500.7 3510.5 3515.5 3521.5 1054.5 1060.6 1082.5 1087.6 1092.1 960.0 1049.6 1098.0 1160.8 1281.6 7143.9 7162.6 7221.9 7256.9 7279.3 627.5 644.6 646.6 648.9 778.9 5629.3 5706.7 5745.7 5752.5 5779.5 8861.6 9055.1 9103.0 9197.0 9211.5 8953.5 9185.1 9209.9 9402.8 9405.3 7243.2 7298.5 7319.1 7336.3 7364.9 6979.1 7041.5 7076.9 7110.5 7133.6 8310.3 8311.9 8340.5 8460.4 8537.2 8365.6 8601.5 8626.9 8631.1 8694.1 6594.2 6633.2 6678.3 6683.9 6732.9 7262.2 7419.4 7465.3 7497.8 7531.4 6950.4 7020.6 7039.6 7222.4 7241.1 6791.1 6909.5 6916.8 6936.9 7186.2 6660.7 6714.4 6776.0 6810.4 6822.9 6365.1 6375.3 6388.0 6395.6 6398.8 6266.2 6346.2 6378.7 6438.4 6467.3 02:11:49 INFO - PROCESS | 3569 | 02:11:49 INFO - PROCESS | 3569 | [#4] prototype.html Cycles:180 Average:5621.42 Median:6303.71 stddev:1715.54 (27.2%) stddev-sans-first:1673.94 02:11:49 INFO - PROCESS | 3569 | Values: 340.5 350.6 351.9 354.6 355.8 6277.7 6304.2 6430.2 6470.9 6476.0 6314.3 6361.4 6363.7 6380.0 6408.3 4810.4 4824.6 4826.2 4828.9 4829.3 4823.0 4823.1 4824.0 4824.1 4824.6 4687.5 4787.1 4794.0 4796.2 4811.3 4732.0 4748.3 4755.7 4765.4 4780.1 4121.8 4124.0 4139.6 4153.5 4162.5 6018.1 6023.7 6026.2 6028.7 6048.1 5480.6 5617.8 5618.0 5618.8 5641.2 6698.7 6714.4 6744.2 6745.9 6751.9 4583.3 4612.6 4618.4 4629.4 4631.9 6805.4 6958.6 7003.5 7067.9 7070.4 4670.0 4737.2 4742.9 4761.3 4764.8 4813.4 4824.7 4827.8 4828.6 4833.6 5556.6 5570.9 5576.3 5578.4 5592.3 6540.9 6751.2 6768.5 6786.6 6788.5 1647.8 1674.6 1689.4 1690.6 1691.7 1092.5 1116.0 1123.2 1124.7 1136.9 6202.7 6210.8 6240.7 6285.7 6303.2 6741.6 6813.5 6815.5 6822.4 6826.0 6135.5 6235.5 6236.6 6242.8 6268.3 3695.1 3709.5 3716.7 3720.0 3721.3 7072.9 7074.2 7125.9 7133.5 7148.4 6992.7 6993.7 7001.1 7003.7 7007.0 7354.4 7357.9 7359.3 7359.6 7365.4 6962.0 6999.1 7017.1 7019.6 7025.2 6807.4 6931.7 6933.8 6938.1 6953.3 7315.2 7330.5 7339.6 7340.2 7357.9 4731.6 4763.3 4777.9 4778.2 4782.2 6866.3 6910.3 7029.2 7047.3 7058.8 6811.6 6824.1 6846.5 6855.3 6871.8 6781.0 6797.1 6810.4 6822.2 6835.1 6562.7 6673.4 6698.2 6705.3 6722.2 6832.4 6888.4 6894.8 6896.0 6898.8 6593.4 6665.2 6675.8 6677.6 6712.0 02:11:49 INFO - PROCESS | 3569 | 02:11:49 INFO - PROCESS | 3569 | [#5] yui.html Cycles:180 Average:14180.50 Median:25769.61 stddev:17043.11 (66.1%) stddev-sans-first:17061.29 02:11:49 INFO - PROCESS | 3569 | Values: 798.0 803.7 817.4 820.0 824.4 13158.5 13282.4 13397.5 13429.6 13470.3 12573.6 12816.8 12838.6 12848.4 13495.9 806.4 807.9 809.2 809.9 811.0 800.7 802.0 805.8 807.5 808.4 839.1 843.2 843.6 844.3 844.3 839.8 841.4 841.9 842.9 843.9 614.8 616.6 616.6 618.6 620.8 12430.2 12479.1 12480.7 12515.8 12516.6 11333.9 11352.4 11384.6 11543.2 11632.8 9538.9 9709.3 9840.9 9868.0 9896.9 3519.6 3522.8 3606.1 3622.7 3675.6 45775.3 46003.3 48182.5 54651.7 55500.7 10572.7 10670.6 10774.4 10846.1 11257.9 18754.2 18778.2 18829.2 18851.0 18877.3 7364.0 8156.5 8158.8 8308.8 8351.5 4267.7 4310.4 4375.7 4386.9 4426.3 3121.0 3146.2 3164.7 3166.7 3167.3 581.6 587.2 587.9 596.8 606.8 536.1 543.8 572.6 589.6 656.1 8170.6 8190.9 8368.2 8436.7 8490.5 511.7 528.2 529.7 533.5 642.5 3858.3 3906.5 4021.0 4066.8 4106.2 56037.4 61480.7 61501.7 61508.4 61556.7 51027.5 51802.0 54909.0 55802.9 57421.7 47684.0 50079.2 54004.2 54306.6 55261.9 8560.7 8683.6 8763.5 8804.4 8995.1 35907.0 35998.0 36573.5 37158.4 37433.4 43985.0 46544.3 47002.3 47777.0 47782.0 11196.6 11249.2 11318.7 11319.4 11406.8 10690.0 10820.7 11889.2 11948.8 12613.0 10795.3 10980.7 11097.6 11315.8 11329.7 10823.9 10871.5 11216.6 11224.7 11604.5 10211.9 10581.4 10602.7 10627.9 10632.6 9044.8 9213.4 9282.0 9293.8 9440.3 7757.6 8636.5 9641.5 9671.8 9944.7 02:11:49 INFO - PROCESS | 3569 | -------- Summary: end -------- 02:11:49 INFO - PROCESS | 3569 | 02:11:49 INFO - TEST-INFO | 3569: exit 0 02:11:49 INFO - TEST-OK | dromaeo_css | took 1114547ms 02:11:49 INFO - TEST-START | kraken 02:11:49 INFO - operating with platform_type : linux_ 02:11:49 INFO - Initialising browser for kraken test... 02:11:49 INFO - TEST-INFO | started process 3808 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprX38wW/profile http://localhost:32947/getInfo.html) 02:11:54 INFO - PROCESS | 3808 | 02:11:54 INFO - PROCESS | 3808 | (process:3880): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:11:55 INFO - PROCESS | 3808 | __metrics Screen width/height:1600/1200 02:11:55 INFO - PROCESS | 3808 | colorDepth:24 02:11:55 INFO - PROCESS | 3808 | Browser inner width/height: 1024/697 02:11:55 INFO - PROCESS | 3808 | __metrics 02:11:56 INFO - PROCESS | 3808 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:11:56 INFO - PROCESS | 3808 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 02:11:57 INFO - TEST-INFO | 3808: exit 0 02:11:57 INFO - Browser initialized. 02:11:57 INFO - Running cycle 1/1 for kraken test... 02:11:57 INFO - TEST-INFO | started process 3929 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprX38wW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:11:58 INFO - PROCESS | 3929 | 02:11:58 INFO - PROCESS | 3929 | (process:3986): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:12:08 INFO - PROCESS | 3929 | RSS: Main: 150454272 02:12:08 INFO - PROCESS | 3929 | 02:12:11 INFO - PROCESS | 3929 | Cycle 1(1): loaded http://localhost:32947/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32947/tests/kraken/driver.html?testName=audio-beat-detection) 02:12:12 INFO - PROCESS | 3929 | RSS: Main: 151093248 02:12:12 INFO - PROCESS | 3929 | 02:12:14 INFO - PROCESS | 3929 | Cycle 1(1): loaded http://localhost:32947/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32947/tests/kraken/driver.html?testName=audio-dft) 02:12:15 INFO - PROCESS | 3929 | RSS: Main: 154927104 02:12:15 INFO - PROCESS | 3929 | 02:12:18 INFO - PROCESS | 3929 | Cycle 1(1): loaded http://localhost:32947/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32947/tests/kraken/driver.html?testName=audio-fft) 02:12:18 INFO - PROCESS | 3929 | RSS: Main: 146677760 02:12:18 INFO - PROCESS | 3929 | 02:12:20 INFO - PROCESS | 3929 | Cycle 1(1): loaded http://localhost:32947/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32947/tests/kraken/driver.html?testName=audio-oscillator) 02:12:21 INFO - PROCESS | 3929 | RSS: Main: 147148800 02:12:21 INFO - PROCESS | 3929 | 02:12:23 INFO - PROCESS | 3929 | Cycle 1(1): loaded http://localhost:32947/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32947/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:12:24 INFO - PROCESS | 3929 | RSS: Main: 147591168 02:12:24 INFO - PROCESS | 3929 | 02:12:27 INFO - PROCESS | 3929 | Cycle 1(1): loaded http://localhost:32947/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32947/tests/kraken/driver.html?testName=imaging-darkroom) 02:12:27 INFO - PROCESS | 3929 | RSS: Main: 148770816 02:12:27 INFO - PROCESS | 3929 | 02:12:31 INFO - PROCESS | 3929 | Cycle 1(1): loaded http://localhost:32947/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32947/tests/kraken/driver.html?testName=imaging-desaturate) 02:12:31 INFO - PROCESS | 3929 | RSS: Main: 148684800 02:12:31 INFO - PROCESS | 3929 | 02:12:34 INFO - PROCESS | 3929 | Cycle 1(1): loaded http://localhost:32947/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32947/tests/kraken/driver.html?testName=json-parse-financial) 02:12:35 INFO - PROCESS | 3929 | RSS: Main: 149835776 02:12:35 INFO - PROCESS | 3929 | 02:12:36 INFO - PROCESS | 3929 | Cycle 1(1): loaded http://localhost:32947/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32947/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:12:37 INFO - PROCESS | 3929 | RSS: Main: 150704128 02:12:37 INFO - PROCESS | 3929 | 02:12:39 INFO - PROCESS | 3929 | Cycle 1(1): loaded http://localhost:32947/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32947/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:12:39 INFO - PROCESS | 3929 | RSS: Main: 150548480 02:12:39 INFO - PROCESS | 3929 | 02:12:41 INFO - PROCESS | 3929 | Cycle 1(1): loaded http://localhost:32947/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32947/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:12:42 INFO - PROCESS | 3929 | RSS: Main: 150892544 02:12:42 INFO - PROCESS | 3929 | 02:12:44 INFO - PROCESS | 3929 | Cycle 1(1): loaded http://localhost:32947/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32947/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:12:45 INFO - PROCESS | 3929 | RSS: Main: 151220224 02:12:45 INFO - PROCESS | 3929 | 02:12:49 INFO - PROCESS | 3929 | Cycle 1(1): loaded http://localhost:32947/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32947/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:12:50 INFO - PROCESS | 3929 | RSS: Main: 144756736 02:12:50 INFO - PROCESS | 3929 | 02:12:51 INFO - PROCESS | 3929 | Cycle 1(1): loaded http://localhost:32947/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32947/tests/kraken/driver.html?testName=ai-astar) 02:12:52 INFO - PROCESS | 3929 | RSS: Main: 146026496 02:12:52 INFO - PROCESS | 3929 | 02:12:52 INFO - PROCESS | 3929 | __start_tp_report 02:12:52 INFO - PROCESS | 3929 | _x_x_mozilla_page_load 02:12:52 INFO - PROCESS | 3929 | _x_x_mozilla_page_load_details 02:12:52 INFO - PROCESS | 3929 | |i|pagename|runs| 02:12:52 INFO - PROCESS | 3929 | |0;ai-astar;112;107;113;113;111;122;114;110;111;113 02:12:52 INFO - PROCESS | 3929 | |1;audio-beat-detection;154;131;150;166;128;150;156;129;168;129 02:12:52 INFO - PROCESS | 3929 | |2;audio-dft;162;162;162;163;162;161;162;163;169;161 02:12:52 INFO - PROCESS | 3929 | |3;audio-fft;72;75;72;73;71;74;162;75;74;74 02:12:52 INFO - PROCESS | 3929 | |4;audio-oscillator;97;96;149;95;98;96;137;96;96;137 02:12:52 INFO - PROCESS | 3929 | |5;imaging-gaussian-blur;110;110;109;110;109;110;110;109;110;109 02:12:52 INFO - PROCESS | 3929 | |6;imaging-darkroom;147;146;146;146;146;147;147;147;147;147 02:12:52 INFO - PROCESS | 3929 | |7;imaging-desaturate;96;97;96;97;96;96;96;97;95;97 02:12:52 INFO - PROCESS | 3929 | |8;json-parse-financial;59;59;58;57;61;59;59;59;55;61 02:12:52 INFO - PROCESS | 3929 | |9;json-stringify-tinderbox;67;71;69;67;67;70;68;68;69;68 02:12:52 INFO - PROCESS | 3929 | |10;stanford-crypto-aes;80;89;82;82;84;83;83;83;84;82 02:12:52 INFO - PROCESS | 3929 | |11;stanford-crypto-ccm;115;124;122;135;128;117;118;116;121;121 02:12:52 INFO - PROCESS | 3929 | |12;stanford-crypto-pbkdf2;138;145;139;149;142;136;142;147;155;152 02:12:52 INFO - PROCESS | 3929 | |13;stanford-crypto-sha256-iterative;68;70;69;68;67;68;67;67;69;67 02:12:52 INFO - PROCESS | 3929 | __end_tp_report 02:12:52 INFO - PROCESS | 3929 | __start_cc_report 02:12:52 INFO - PROCESS | 3929 | _x_x_mozilla_cycle_collect,737 02:12:52 INFO - PROCESS | 3929 | __end_cc_report 02:12:52 INFO - PROCESS | 3929 | __startTimestamp1452852772037__endTimestamp 02:12:52 INFO - PROCESS | 3929 | 02:12:52 INFO - PROCESS | 3929 | ------- Summary: start ------- 02:12:52 INFO - PROCESS | 3929 | Number of tests: 14 02:12:52 INFO - PROCESS | 3929 | 02:12:52 INFO - PROCESS | 3929 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.00 stddev:3.86 (3.4%) stddev-sans-first:4.09 02:12:52 INFO - PROCESS | 3929 | Values: 112.0 107.0 113.0 113.0 111.0 122.0 114.0 110.0 111.0 113.0 02:12:52 INFO - PROCESS | 3929 | 02:12:52 INFO - PROCESS | 3929 | [#1] audio-beat-detection Cycles:10 Average:146.10 Median:152.00 stddev:15.66 (10.3%) stddev-sans-first:16.35 02:12:52 INFO - PROCESS | 3929 | Values: 154.0 131.0 150.0 166.0 128.0 150.0 156.0 129.0 168.0 129.0 02:12:52 INFO - PROCESS | 3929 | 02:12:52 INFO - PROCESS | 3929 | [#2] audio-dft Cycles:10 Average:162.70 Median:162.00 stddev:2.31 (1.4%) stddev-sans-first:2.44 02:12:52 INFO - PROCESS | 3929 | Values: 162.0 162.0 162.0 163.0 162.0 161.0 162.0 163.0 169.0 161.0 02:12:52 INFO - PROCESS | 3929 | 02:12:52 INFO - PROCESS | 3929 | [#3] audio-fft Cycles:10 Average:82.20 Median:74.00 stddev:28.07 (37.9%) stddev-sans-first:29.53 02:12:52 INFO - PROCESS | 3929 | Values: 72.0 75.0 72.0 73.0 71.0 74.0 162.0 75.0 74.0 74.0 02:12:52 INFO - PROCESS | 3929 | 02:12:52 INFO - PROCESS | 3929 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:96.00 stddev:21.86 (22.8%) stddev-sans-first:22.70 02:12:52 INFO - PROCESS | 3929 | Values: 97.0 96.0 149.0 95.0 98.0 96.0 137.0 96.0 96.0 137.0 02:12:52 INFO - PROCESS | 3929 | 02:12:52 INFO - PROCESS | 3929 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 02:12:52 INFO - PROCESS | 3929 | Values: 110.0 110.0 109.0 110.0 109.0 110.0 110.0 109.0 110.0 109.0 02:12:52 INFO - PROCESS | 3929 | 02:12:52 INFO - PROCESS | 3929 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 02:12:52 INFO - PROCESS | 3929 | Values: 147.0 146.0 146.0 146.0 146.0 147.0 147.0 147.0 147.0 147.0 02:12:52 INFO - PROCESS | 3929 | 02:12:52 INFO - PROCESS | 3929 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 02:12:52 INFO - PROCESS | 3929 | Values: 96.0 97.0 96.0 97.0 96.0 96.0 96.0 97.0 95.0 97.0 02:12:52 INFO - PROCESS | 3929 | 02:12:52 INFO - PROCESS | 3929 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:59.00 stddev:1.77 (3.0%) stddev-sans-first:1.87 02:12:52 INFO - PROCESS | 3929 | Values: 59.0 59.0 58.0 57.0 61.0 59.0 59.0 59.0 55.0 61.0 02:12:52 INFO - PROCESS | 3929 | 02:12:52 INFO - PROCESS | 3929 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.50 stddev:1.35 (2.0%) stddev-sans-first:1.33 02:12:52 INFO - PROCESS | 3929 | Values: 67.0 71.0 69.0 67.0 67.0 70.0 68.0 68.0 69.0 68.0 02:12:52 INFO - PROCESS | 3929 | 02:12:52 INFO - PROCESS | 3929 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.00 stddev:2.35 (2.8%) stddev-sans-first:2.19 02:12:52 INFO - PROCESS | 3929 | Values: 80.0 89.0 82.0 82.0 84.0 83.0 83.0 83.0 84.0 82.0 02:12:52 INFO - PROCESS | 3929 | 02:12:52 INFO - PROCESS | 3929 | [#11] stanford-crypto-ccm Cycles:10 Average:121.70 Median:121.50 stddev:6.11 (5.0%) stddev-sans-first:5.98 02:12:52 INFO - PROCESS | 3929 | Values: 115.0 124.0 122.0 135.0 128.0 117.0 118.0 116.0 121.0 121.0 02:12:52 INFO - PROCESS | 3929 | 02:12:52 INFO - PROCESS | 3929 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.50 Median:146.00 stddev:6.24 (4.3%) stddev-sans-first:6.16 02:12:52 INFO - PROCESS | 3929 | Values: 138.0 145.0 139.0 149.0 142.0 136.0 142.0 147.0 155.0 152.0 02:12:52 INFO - PROCESS | 3929 | 02:12:52 INFO - PROCESS | 3929 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:1.05 (1.6%) stddev-sans-first:1.12 02:12:52 INFO - PROCESS | 3929 | Values: 68.0 70.0 69.0 68.0 67.0 68.0 67.0 67.0 69.0 67.0 02:12:52 INFO - PROCESS | 3929 | -------- Summary: end -------- 02:12:52 INFO - PROCESS | 3929 | 02:12:53 INFO - TEST-INFO | 3929: exit 0 02:12:53 INFO - TEST-OK | kraken | took 63172ms 02:12:53 INFO - TEST-START | v8_7 02:12:53 INFO - operating with platform_type : linux_ 02:12:53 INFO - Initialising browser for v8_7 test... 02:12:53 INFO - TEST-INFO | started process 4214 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwOZO0j/profile http://localhost:32947/getInfo.html) 02:12:57 INFO - PROCESS | 4214 | 02:12:57 INFO - PROCESS | 4214 | (process:4288): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:12:58 INFO - PROCESS | 4214 | __metrics Screen width/height:1600/1200 02:12:58 INFO - PROCESS | 4214 | colorDepth:24 02:12:58 INFO - PROCESS | 4214 | Browser inner width/height: 1024/697 02:12:58 INFO - PROCESS | 4214 | __metrics 02:12:58 INFO - PROCESS | 4214 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:12:59 INFO - PROCESS | 4214 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 02:12:59 INFO - TEST-INFO | 4214: exit 0 02:12:59 INFO - Browser initialized. 02:12:59 INFO - Running cycle 1/1 for v8_7 test... 02:12:59 INFO - TEST-INFO | started process 4337 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwOZO0j/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:13:01 INFO - PROCESS | 4337 | 02:13:01 INFO - PROCESS | 4337 | (process:4394): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:13:11 INFO - PROCESS | 4337 | RSS: Main: 150867968 02:13:11 INFO - PROCESS | 4337 | 02:13:34 INFO - PROCESS | 4337 | Cycle 1(1): loaded http://localhost:32947/tests/v8_7/run.html (next: http://localhost:32947/tests/v8_7/run.html) 02:13:34 INFO - PROCESS | 4337 | RSS: Main: 146964480 02:13:34 INFO - PROCESS | 4337 | 02:13:34 INFO - PROCESS | 4337 | __start_tp_report 02:13:34 INFO - PROCESS | 4337 | _x_x_mozilla_page_load 02:13:34 INFO - PROCESS | 4337 | _x_x_mozilla_page_load_details 02:13:34 INFO - PROCESS | 4337 | |i|pagename|runs| 02:13:34 INFO - PROCESS | 4337 | |0;Richards;168.01075268817203 02:13:34 INFO - PROCESS | 4337 | |1;DeltaBlue;191.05846388995033 02:13:34 INFO - PROCESS | 4337 | |2;Encrypt;278.9400278940028 02:13:34 INFO - PROCESS | 4337 | |3;Decrypt;5213.541666666667 02:13:34 INFO - PROCESS | 4337 | |4;RayTrace;1071.8113612004288 02:13:34 INFO - PROCESS | 4337 | |5;Earley;711.7437722419929 02:13:34 INFO - PROCESS | 4337 | |6;Boyer;12231.707317073171 02:13:34 INFO - PROCESS | 4337 | |7;RegExp;40940 02:13:34 INFO - PROCESS | 4337 | |8;Splay;572.737686139748 02:13:34 INFO - PROCESS | 4337 | |9;NavierStokes;4822.115384615385 02:13:34 INFO - PROCESS | 4337 | __end_tp_report 02:13:34 INFO - PROCESS | 4337 | __startTimestamp1452852814472__endTimestamp 02:13:34 INFO - PROCESS | 4337 | 02:13:34 INFO - PROCESS | 4337 | ------- Summary: start ------- 02:13:34 INFO - PROCESS | 4337 | Number of tests: 10 02:13:34 INFO - PROCESS | 4337 | 02:13:34 INFO - PROCESS | 4337 | [#0] Richards Cycles:1 Average:168.01 Median:168.01 stddev:0.00 (0.0%) 02:13:34 INFO - PROCESS | 4337 | Values: 168.0 02:13:34 INFO - PROCESS | 4337 | 02:13:34 INFO - PROCESS | 4337 | [#1] DeltaBlue Cycles:1 Average:191.06 Median:191.06 stddev:0.00 (0.0%) 02:13:34 INFO - PROCESS | 4337 | Values: 191.1 02:13:34 INFO - PROCESS | 4337 | 02:13:34 INFO - PROCESS | 4337 | [#2] Encrypt Cycles:1 Average:278.94 Median:278.94 stddev:0.00 (0.0%) 02:13:34 INFO - PROCESS | 4337 | Values: 278.9 02:13:34 INFO - PROCESS | 4337 | 02:13:34 INFO - PROCESS | 4337 | [#3] Decrypt Cycles:1 Average:5213.54 Median:5213.54 stddev:0.00 (0.0%) 02:13:34 INFO - PROCESS | 4337 | Values: 5213.5 02:13:34 INFO - PROCESS | 4337 | 02:13:34 INFO - PROCESS | 4337 | [#4] RayTrace Cycles:1 Average:1071.81 Median:1071.81 stddev:0.00 (0.0%) 02:13:34 INFO - PROCESS | 4337 | Values: 1071.8 02:13:34 INFO - PROCESS | 4337 | 02:13:34 INFO - PROCESS | 4337 | [#5] Earley Cycles:1 Average:711.74 Median:711.74 stddev:0.00 (0.0%) 02:13:34 INFO - PROCESS | 4337 | Values: 711.7 02:13:34 INFO - PROCESS | 4337 | 02:13:34 INFO - PROCESS | 4337 | [#6] Boyer Cycles:1 Average:12231.71 Median:12231.71 stddev:0.00 (0.0%) 02:13:34 INFO - PROCESS | 4337 | Values: 12231.7 02:13:34 INFO - PROCESS | 4337 | 02:13:34 INFO - PROCESS | 4337 | [#7] RegExp Cycles:1 Average:40940.00 Median:40940.00 stddev:0.00 (0.0%) 02:13:34 INFO - PROCESS | 4337 | Values: 40940.0 02:13:34 INFO - PROCESS | 4337 | 02:13:34 INFO - PROCESS | 4337 | [#8] Splay Cycles:1 Average:572.74 Median:572.74 stddev:0.00 (0.0%) 02:13:34 INFO - PROCESS | 4337 | Values: 572.7 02:13:34 INFO - PROCESS | 4337 | 02:13:34 INFO - PROCESS | 4337 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 02:13:34 INFO - PROCESS | 4337 | Values: 4822.1 02:13:34 INFO - PROCESS | 4337 | -------- Summary: end -------- 02:13:34 INFO - PROCESS | 4337 | 02:13:35 INFO - TEST-INFO | 4337: exit 0 02:13:35 INFO - TEST-OK | v8_7 | took 42304ms 02:13:35 INFO - SUITE-END | took 1220s 02:13:35 INFO - Completed test suite (00:20:20) 02:13:35 INFO - Working with test: dromaeo_css 02:13:35 INFO - Generating results file: dromaeo_css 02:13:35 INFO - Working with test: kraken 02:13:35 INFO - Generating results file: kraken 02:13:35 INFO - javascript benchmark 02:13:35 INFO - Working with test: v8_7 02:13:35 INFO - Generating results file: v8_7 02:13:35 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:13:35 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 02:13:35 INFO - process_Request line: dromaeo_css 6940.30 graph.html#tests=[[72,64,43]] 02:13:35 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:13:35 INFO - process_Request line: kraken 1510.30 graph.html#tests=[[232,64,43]] 02:13:35 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:13:35 INFO - process_Request line: v8_7 20457.08 graph.html#tests=[[230,64,43]] 02:13:35 INFO - RETURN: dromaeo_css: 6940.30 02:13:35 INFO - RETURN: kraken: 1510.30 02:13:35 INFO - RETURN: v8_7: 20457.08 02:13:35 INFO - javascript benchmark 02:13:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3179.904602861914, 3187.505936579831, 3217.8230197339167, 3227.1932016995756, 3231.127595549202, 5252.47475252475, 5274.630775845682, 5310.681359118451, 5322.574194064475, 5328.094223981932, 5265.236540701606, 5292.841214763564, 5319.0957537218665, 5365.03429382711, 5368.1679339702405, 4844.20070688336, 4865.245886887538, 4931.778069986841, 4959.578435832958, 5009.549140577347, 341.96246594798606, 4621.560951709582, 4761.190597598399, 4869.0, 4875.804967801284, 4807.375041244633, 4870.756462176894, 4891.559759621651, 4900.068986892479, 4955.752212389366, 4850.5877000455, 4853.781579828917, 4863.975680121612, 4868.513148685139, 4908.0429316283335, 4793.113274044313, 4801.903961920742, 4870.0, 4884.926726099111, 4915.827946021872, 5107.846764597068, 5174.715390653512, 5174.974125129388, 5213.061648903196, 5215.191645294985, 5737.885242295172, 5750.5687073469235, 5766.481016708516, 5768.42315768424, 5831.300243970708, 5671.602987790856, 5766.913496297559, 5776.451237132465, 5834.066549352126, 5891.675957822318, 5288.788448462057, 5356.1697936819855, 5360.410354860962, 5370.758315875834, 5372.086745253317, 5818.709064546756, 5837.532997360201, 5838.7080645967535, 5846.8538286542325, 5846.941530584725, 5540.501354878081, 5605.579581531401, 5674.773009079673, 5752.539796816244, 5797.4782269595935, 5619.072852979294, 5643.294588176478, 5669.914951275734, 5696.8006119785605, 5705.4009329019855, 5584.246126772915, 5653.067243904709, 5656.43435656431, 5659.377468478464, 5666.744996475169, 5715.571332150105, 5758.942410575924, 5764.481196692318, 5821.2141360916585, 5851.0, 4424.80088396023, 4429.82280708768, 4445.177642136216, 4449.688521803508, 4452.510223875371, 3869.613038696164, 3959.1289916218384, 3985.362342025262, 4005.859794907164, 4027.9930017495626, 5319.202119682079, 5336.62643614951, 5388.838334849961, 5399.190121481809, 5431.321084864392, 5738.913916291259, 5747.08046712524, 5765.04876695349, 5769.538436925036, 5791.391903850035, 5259.15853463444, 5339.012282727708, 5371.060064488699, 5372.946270537244, 5432.239486471897, 4857.441394239637, 4866.8053277868485, 4879.658423910292, 4912.0, 4947.060058588857, 5940.138679891392, 5942.346341902387, 5945.881082378415, 5955.612885162451, 5960.37416071315, 5566.638168519034, 5671.631343962629, 5710.543156547383, 5718.599698021098, 5735.77056917727, 5960.1357803117435, 5971.253593300838, 5972.552058595709, 5980.0, 6030.0, 5630.099184130683, 5692.203091567101, 5697.515711164431, 5705.885882282248, 5731.512821410227, 5639.774409023593, 5727.083666613322, 5742.224799651994, 5775.422457754191, 5813.709314534341, 5571.8885622288135, 5609.831705048855, 5611.6352437091455, 5640.210370548209, 5648.661080335193, 5602.355729091207, 5630.127330263816, 5632.831015069554, 5640.125780504029, 5659.405762395054, 5496.422875598005, 5532.2254884315425, 5543.445655434424, 5547.1679248113105, 5566.777328906798, 5589.860253493533, 5626.2967129108865, 5647.745851436777, 5662.462066103713, 5663.0, 5529.668219906657, 5529.917051244315, 5530.281063461724, 5534.142207957773, 5544.473275038865], "unit": "score", "name": "dojo.html", "value": 5250.8857178276585}, {"lowerIsBetter": false, "replicates": [513.5891286970425, 531.7713383245205, 534.901043306988, 536.2546060975245, 557.4676184244046, 29008.419831603354, 36250.8187459063, 36326.0, 36649.45025824615, 36691.26617467652, 38927.0, 38992.80503597478, 39274.21451570967, 39289.41065884014, 39496.012599685026, 8312.958435207831, 8467.449615774985, 8546.230839224469, 8560.229579337858, 8590.570471476402, 8275.296599788995, 8353.289970352527, 8383.62273697682, 8390.412671113025, 8417.284530814888, 8325.0, 8459.53472559009, 8511.489310641351, 8518.148185181495, 8546.61540230688, 8330.83338333233, 8429.578521073952, 8450.070492245848, 8641.913580864237, 8643.438176518506, 8515.616797244138, 8598.613062412143, 8617.827643447095, 8634.784130396727, 8656.091110433377, 38998.220035599414, 39294.803525982476, 39321.80339098315, 39375.80312098421, 39384.60615393838, 3141.9371612567847, 3171.1913462067255, 3177.539256807773, 3312.072619666473, 3519.9120021999397, 29092.127236182947, 29264.853675731698, 29382.265443363875, 29772.255693607618, 30425.0, 3876.8061596920325, 3918.9020274493364, 3945.684345252373, 4069.1454794493193, 4132.91734165315, 253751.0, 256027.0, 256225.0, 256624.0, 257428.0, 42212.577874220864, 42789.35815962763, 42869.14261714748, 42888.57111428908, 56212.71893640506, 43935.34096988484, 44085.77957110258, 44147.0, 44167.233310667856, 44230.77884610556, 14884.62788430298, 15146.924265378602, 15160.469383571522, 15232.390704371923, 15272.236388180547, 11710.180287379972, 12009.579664711693, 12010.198470229361, 12053.0, 12272.631821045383, 14260.85739142616, 14395.640108997359, 14395.712085758227, 14462.566123016326, 14594.124352538669, 5680.14797780328, 5809.593328467051, 5828.825135245949, 5862.736176872051, 5922.555808314393, 918.2103391083663, 942.9575669094908, 993.3295025857517, 1027.4759872465097, 1040.3029969920171, 25535.0, 25688.0, 25716.228513144637, 25908.481830363664, 25958.610620840704, 994.3735446668552, 1017.7353887989028, 1050.3487837540774, 1102.9191392435457, 1141.3095077478172, 13269.0, 13431.865681343257, 13432.529861454803, 13576.456941722417, 13635.795463067863, 303858.0, 303877.0, 305680.0, 306943.0, 307497.0, 51049.74475127675, 51178.74410627923, 51374.486255137715, 51628.48371516312, 51778.48221517812, 1328.8006798980036, 1332.9400176992058, 1343.0867010432803, 1344.8520662727092, 1358.0968655843753, 24573.631395528722, 25464.0, 25581.3604659885, 25711.0, 25726.228213153634, 45606.0, 45873.0, 45911.08177836491, 45958.54041459676, 45983.31025034694, 284667.0, 286671.0, 286921.0, 286995.0, 289116.0, 32370.676293236767, 42020.57979420289, 42636.0, 42676.78661606672, 42703.3594496089, 40854.38718419167, 41776.58223417727, 42159.7892010538, 42406.0, 42922.35616465818, 35602.64397356097, 35862.0, 35878.0, 36127.45808812923, 36627.816860915525, 35643.28713425769, 35824.632166664764, 36086.819565902006, 36208.637913621584, 36263.81868090643, 34858.302833943686, 35390.11524711903, 35393.46909796304, 35494.64505354913, 35725.46411803877, 29327.85336073306, 31631.52552711757, 31875.20311992219, 31978.840105800253, 32186.517202241517, 24546.31186599666, 24565.631515526922, 24713.0, 24906.626400603644, 24929.252122436355], "unit": "score", "name": "ext.html", "value": 17527.812726261487}, {"lowerIsBetter": false, "replicates": [347.9217176135369, 351.493848857645, 355.52182314786637, 360.6303538872657, 363.6999475432767, 15443.768343474843, 16344.0, 17764.200610972504, 17817.465476035723, 18572.164252608633, 13610.11534250273, 16427.507174784776, 16706.24821883015, 16851.325946962108, 16927.49217523476, 4938.1111399947995, 5076.086304465195, 5140.4859514048485, 5145.048166089286, 5146.279520867081, 5046.52058054486, 5097.694138351692, 5129.358830146231, 5418.2685337479525, 5433.402325744165, 5430.049741295277, 5461.836144915659, 6491.156149700532, 6763.729450821961, 6765.883629201176, 6532.0, 6669.9666501667425, 6690.899636505456, 6693.330666933292, 6828.658567071627, 6391.77628782995, 6646.468282537386, 6664.733410663568, 6666.866662666719, 6692.866142677168, 21163.788362116335, 21347.466313342135, 21692.457688557755, 22450.663240051414, 22613.32160035185, 2148.52732398872, 2267.8299127565333, 2292.2321022457495, 2341.7072865891764, 2383.1897154967396, 13008.34958252093, 13542.255175965318, 13870.791938120936, 14290.785638215435, 14543.563693089118, 1938.5250613599617, 1941.679622862226, 1963.8036196380247, 1972.5857569910336, 1979.8020197980086, 61382.69308653473, 64166.03750943786, 65354.0, 65772.3422765771, 66802.0, 14894.627634309012, 15147.848521514865, 15275.847241527665, 15285.694286114216, 15385.923070384577, 23507.17724879621, 23574.646380304308, 23745.525089498115, 23994.28017159488, 24018.39954001164, 6936.237013928464, 7254.129504459499, 7612.276833700789, 7649.087728067983, 9220.492872892055, 7611.505252158592, 7686.269804368576, 7740.961295193488, 7745.380369570421, 7788.571628560484, 4530.750808705553, 4561.840335588305, 4568.543145685471, 4620.029793743352, 4628.213203755302, 1835.5301202416606, 1877.7840548337117, 1889.0837943597344, 1903.2767548331544, 1924.5765931495048, 922.2437601166979, 932.6036434515304, 950.6245033211843, 950.6862735297335, 1001.464216644092, 14294.928525357514, 16571.25429355682, 16586.75599330031, 16671.833281667026, 16999.150042497826, 909.2044461096541, 953.8044700836311, 954.0983770337103, 958.7890664053897, 1001.1490233301636, 8907.866382004275, 9134.086591340945, 9144.451332920045, 9159.267258619428, 9207.125323094295, 489212.0, 496171.0, 496679.0, 507344.0, 511510.0, 46313.0, 62169.37830621636, 62542.374576254566, 72110.63944680244, 73956.15109622195, 1111.572044762756, 1119.1047162270152, 1119.8152304869768, 1125.1561329003248, 1130.112861403794, 14180.787288190892, 14459.204743739196, 14832.629184270048, 15047.0, 15270.389184432943, 22664.0, 24314.635280470455, 28750.0, 30037.5494367589, 30628.693713062585, 40401.39397909093, 40734.0, 41301.173976520906, 42695.0, 43998.340024900295, 7201.747938822116, 7430.922516235008, 7519.849603008019, 7703.691852326068, 7805.14143444232, 8059.637316320663, 10969.122470202525, 11681.240719353214, 11918.761624767629, 12225.510979561073, 7476.5887876167335, 7514.023176986957, 7557.470977031775, 7809.726659566888, 7840.529568225925, 7892.4869883457395, 8152.225538573826, 8190.262876341158, 8268.2558569729, 8303.252707256375, 7815.179406162271, 7836.138024817152, 7893.644785984759, 7896.09194942589, 7922.683092676229, 10044.146247568746, 10239.641612543524, 10382.42896640692, 10581.841272380767, 10801.135909127408, 7495.850082998419, 7985.441019128605, 10521.421321827373, 10672.786544269227, 10783.24517283814], "unit": "score", "name": "jquery.html", "value": 8565.50782862484}, {"lowerIsBetter": false, "replicates": [1453.5566652171087, 1478.0835881753314, 1616.2161351744403, 1760.9383671571497, 1771.264925056101, 7709.961450192748, 7846.72536461224, 7962.601869906503, 7974.7208847690345, 7982.560959147252, 7713.884291735629, 7716.7684969451, 7726.96136519318, 7814.296713295802, 7843.215678432154, 2338.590746619339, 2353.62342025276, 2360.303710405426, 2372.8457650252676, 2373.3473294843884, 2345.95308093838, 2371.5494056129282, 2374.976250237493, 2375.6080246759266, 2381.9166329178483, 2310.06442390832, 2314.537092581482, 2333.4866329407505, 2357.8938947747306, 2376.4771750215014, 2340.8595484270913, 2350.8001819845163, 2391.9043238270447, 2392.306231192952, 2398.328468028955, 2366.6923299971068, 2378.881055947196, 2382.594958856981, 2399.8800059997106, 2405.927822165338, 7871.134175240719, 8044.074931382907, 8067.435279530435, 8100.47346922454, 8146.063202731643, 4814.542618451242, 4980.178270585349, 4987.501249875019, 4995.200767877159, 5005.74971251436, 3096.8916087936814, 3149.6062992125985, 3171.5242713592916, 3179.2369831240567, 3181.490961446181, 1110.9944450277696, 1113.4655365424642, 1147.288681017766, 1177.7350096228365, 1189.9464524096436, 11026.558937642485, 11101.611443599435, 11113.0, 11131.888681113085, 11154.832677509843, 4204.894877628022, 4272.444582204355, 4332.978335108304, 4354.085642015149, 4360.716553424018, 9037.68368107113, 9048.321375896703, 9056.0, 9061.59222834974, 9063.728088157366, 4828.66199366048, 4862.562369386701, 4875.68308059975, 4879.1461494238365, 4884.853454396374, 4403.273459879084, 4459.777011149495, 4460.50934397216, 4473.015936493966, 4485.865424037284, 3387.187075101958, 3500.7374446916583, 3510.5080340855034, 3515.525404070469, 3521.542199514047, 1054.488573042074, 1060.6340812419703, 1082.4858192358568, 1087.5649740104022, 1092.137211602825, 959.9616015359447, 1049.5801679328329, 1098.0117893895558, 1160.7968605494004, 1281.5770795637418, 7143.9285607143265, 7162.641867906584, 7221.927780722231, 7256.854862902713, 7279.272072792678, 627.4791922704145, 644.5616980453243, 646.5732616473106, 648.8929326661142, 778.9143194248628, 5629.268195134607, 5706.743196556165, 5745.712714364265, 5752.453516915886, 5779.450952159538, 8861.601227944759, 9055.094490550891, 9102.95316038664, 9197.034311397341, 9211.493367864698, 8953.507557084424, 9185.127412895765, 9209.907900921038, 9402.764930876783, 9405.294602904673, 7243.203247642755, 7298.452616053817, 7319.085114360599, 7336.303051210127, 7364.926350736424, 6979.127609048869, 7041.5422997505, 7076.929230707627, 7110.4667149965, 7133.643317834191, 8310.293625041697, 8311.916880831357, 8340.499570025819, 8460.407771455939, 8537.18896704812, 8365.62354694028, 8601.526916019679, 8626.913730862861, 8631.136886311318, 8694.130586941255, 6594.208694956636, 6633.2040155181685, 6678.265390806911, 6683.8663226734225, 6732.865342693217, 7262.237465066303, 7419.443541734499, 7465.328120469184, 7497.775066748006, 7531.3598344141365, 6950.374466298057, 7020.648967551704, 7039.577625342496, 7222.422206223385, 7241.094863142107, 6791.100284044038, 6909.481788865955, 6916.757913473004, 6936.861262774615, 7186.209516953027, 6660.700268488026, 6714.3957043866285, 6775.966120169564, 6810.353016463428, 6822.897656535057, 6365.077063825812, 6375.266844312778, 6387.968060159669, 6395.584287021329, 6398.808035758934, 6266.216722909637, 6346.174997250512, 6378.712957916812, 6438.3883531064475, 6467.3209313023335], "unit": "score", "name": "mootools.html", "value": 4461.747413985819}, {"lowerIsBetter": false, "replicates": [340.47566747209294, 350.58980992239077, 351.88036067736965, 354.6240984556369, 355.839872057574, 6277.740013595102, 6304.211973503312, 6430.228372595289, 6470.870582588345, 6476.0, 6314.305426403103, 6361.395667411589, 6363.71363288652, 6380.0, 6408.26304974928, 4810.422749270093, 4824.614030877521, 4826.227803551433, 4828.927566086511, 4829.299751536025, 4822.951770482286, 4823.107725070856, 4823.975880120612, 4824.059308434857, 4824.565789078983, 4687.507811679776, 4787.138315103298, 4793.952060479385, 4796.232602783555, 4811.30236115763, 4732.0, 4748.335233067339, 4755.667103302771, 4765.404324459442, 4780.09178256132, 4121.835126594962, 4123.958760412387, 4139.627433530966, 4153.522344930341, 4162.458880345566, 6018.127371531104, 6023.698815059273, 6026.2165918430765, 6028.698565071729, 6048.092786082079, 5480.616356855022, 5617.775288988436, 5617.960677274717, 5618.831435056954, 5641.210230567724, 6698.732050717966, 6714.362135597111, 6744.190697116328, 6745.898811517831, 6751.864962700768, 4583.2666773316105, 4612.630989520831, 4618.35343051973, 4629.398178236807, 4631.907361852778, 6805.353491418307, 6958.582485050913, 7003.474739394565, 7067.9293207067785, 7070.434365250768, 4669.976650116728, 4737.170995075848, 4742.881427964328, 4761.309610106515, 4764.8332308369045, 4813.350197723333, 4824.734639594786, 4827.806887724451, 4828.637852161102, 4833.589144922721, 5556.555475561945, 5570.888582228333, 5576.33084029919, 5578.41426650204, 5592.3009623797025, 6540.869182616321, 6751.156105486814, 6768.458523318122, 6786.558873673195, 6788.490863185182, 1647.8022637283602, 1674.5646132005766, 1689.3918189451788, 1690.5773556610848, 1691.687037897993, 1092.4810714910514, 1115.9721006974892, 1123.1688550472754, 1124.746931940307, 1136.8806275341135, 6202.72087756052, 6210.813675589649, 6240.687965601702, 6285.685715714196, 6303.212098487689, 6741.59550426976, 6813.454923606099, 6815.488838337144, 6822.351876571718, 6826.044353790473, 6135.478484328882, 6235.469985051231, 6236.563440559208, 6242.750289988349, 6268.310485846553, 3695.0762309422644, 3709.5177626908867, 3716.717732382324, 3719.962800372016, 3721.348763966295, 7072.8939065914055, 7074.151101867706, 7125.857482850314, 7133.500654954103, 7148.428125749928, 6992.6853291602, 6993.720251189896, 7001.089858318386, 7003.719851205997, 7007.0, 7354.411647068328, 7357.889631655529, 7359.337659610661, 7359.558426494427, 7365.373943214887, 6962.0, 6999.055127557918, 7017.05269788572, 7019.649017549, 7025.192102908231, 6807.353301436356, 6931.653417329214, 6933.826654333682, 6938.098047253825, 6953.33943275388, 7315.158756743042, 7330.486865919334, 7339.605474959741, 7340.2292759261645, 7357.926420735724, 4731.574158325767, 4763.333133361401, 4777.928331074967, 4778.187708089564, 4782.187028205283, 6866.279040700854, 6910.343517365842, 7029.156501219886, 7047.330503602149, 7058.788236352918, 6811.557248778813, 6824.146981627297, 6846.452283817183, 6855.280195579392, 6871.759488417882, 6781.0, 6797.116374871235, 6810.353016463428, 6822.215445223665, 6835.14560679915, 6562.671866406565, 6673.366030227121, 6698.22970358415, 6705.262421133574, 6722.226943901514, 6832.419244364285, 6888.380045795902, 6894.793156205322, 6896.0, 6898.827529311808, 6593.406593406617, 6665.233498147775, 6675.833104172434, 6677.632730199885, 6711.966440167963], "unit": "score", "name": "prototype.html", "value": 5060.030441301973}, {"lowerIsBetter": false, "replicates": [797.984040319194, 803.7421435453515, 817.4049865662557, 820.0282665041922, 824.3981893217953, 13158.473661053558, 13282.402291896864, 13397.464101435955, 13429.597112086629, 13470.326483675814, 12573.622791316275, 12816.807747883766, 12838.614841554769, 12848.421821018053, 13495.865041349609, 806.435495153392, 807.9353651707879, 809.158475185809, 809.8582748019103, 810.9594520273993, 800.7237503061434, 802.0415603353995, 805.8227190018187, 807.4549678966704, 808.4260175275562, 839.0686338164633, 843.2158092973532, 843.5866425451546, 844.2823599940064, 844.2950136635916, 839.7858546070773, 841.4278290762279, 841.9284360829306, 842.8819965204876, 843.8734189871507, 614.8032629558543, 616.5622408090261, 616.5899676714979, 618.6442795392667, 620.764109638339, 12430.192037517623, 12479.126461147724, 12480.687982800411, 12515.812262816065, 12516.624501264885, 11333.886661133365, 11352.375619340934, 11384.601538946097, 11543.191976561644, 11632.825507617308, 9538.904610953941, 9709.271804614611, 9840.852387214198, 9868.0, 9896.851547226725, 3519.577650681909, 3522.788632682047, 3606.098475381155, 3622.7464077514583, 3675.6140605236333, 45775.31337029914, 46003.30995035077, 48182.51817481816, 54651.72674136644, 55500.722496387665, 10572.682819515427, 10670.62652807148, 10774.4074075925, 10846.078083363003, 11257.887421125848, 18754.24983000692, 18778.248870045318, 18829.152688129067, 18851.0, 18877.33929312495, 7363.9631801841715, 8156.469829461066, 8158.755237342771, 8308.833823323499, 8351.540665263468, 4267.679924005712, 4310.353446982977, 4375.7155784873885, 4386.934195987063, 4426.291793313055, 3120.968790312113, 3146.1819926818735, 3164.651888292286, 3166.683331666815, 3167.319026409333, 581.5870731780399, 587.1808826686748, 587.9265091863517, 596.7672607683007, 606.771288141517, 536.1368197202501, 543.7906406033705, 572.5562688916124, 589.6108568344872, 656.1044174701498, 8170.550619715854, 8190.918090819135, 8368.217458449417, 8436.746897593082, 8490.490570565786, 511.72878374461595, 528.1707718881396, 529.7007190937109, 533.5198321510594, 642.4828013449124, 3858.305505009125, 3906.4726261954843, 4021.0, 4066.755994640331, 4106.240345536085, 56037.439625604035, 61480.69259653763, 61501.69249153815, 61508.384916150266, 61556.69221653863, 51027.48972510227, 51802.0, 54909.0, 55802.88394232093, 57421.71289143527, 47684.0, 50079.15699053597, 54004.18993715097, 54306.56934306538, 55261.89476210453, 8560.743177704679, 8683.609237584198, 8763.474191548528, 8804.383693141675, 8995.145461181177, 35907.0, 35998.0, 36573.45139822958, 37158.44262336013, 37433.43849842309, 43985.0, 46544.301835473176, 47002.29496557486, 47777.0, 47782.0, 11196.552137914392, 11249.156313276373, 11318.717032074264, 11319.434028298718, 11406.82889756671, 10690.037896589345, 10820.729481763019, 11889.167758257185, 11948.820767688318, 12613.0, 10795.298305610424, 10980.725481863017, 11097.611583594535, 11315.773684526428, 11329.660110196708, 10823.945880270863, 10871.474480528756, 11216.607418740305, 11224.66326010221, 11604.496170297558, 10211.948940255548, 10581.418022008864, 10602.734931626772, 10627.93720627931, 10632.627858025242, 9044.773880653036, 9213.355065145644, 9281.953590232006, 9293.814123717622, 9440.291978101806, 7757.573333466714, 8636.524991125549, 9641.517924103908, 9671.758206044624, 9944.651937182163], "unit": "score", "name": "yui.html", "value": 6278.581413317714}], "name": "dromaeo_css", "value": 6940.296396748313}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 107.0, 113.0, 113.0, 111.0, 122.0, 114.0, 110.0, 111.0, 113.0], "unit": "score", "name": "ai-astar", "value": 112.6}, {"lowerIsBetter": true, "replicates": [154.0, 131.0, 150.0, 166.0, 128.0, 150.0, 156.0, 129.0, 168.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 146.1}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 162.0, 163.0, 162.0, 161.0, 162.0, 163.0, 169.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.7}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 72.0, 73.0, 71.0, 74.0, 162.0, 75.0, 74.0, 74.0], "unit": "score", "name": "audio-fft", "value": 82.2}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 149.0, 95.0, 98.0, 96.0, 137.0, 96.0, 96.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 109.7}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 97.0, 96.0, 96.0, 96.0, 97.0, 95.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 58.0, 57.0, 61.0, 59.0, 59.0, 59.0, 55.0, 61.0], "unit": "score", "name": "json-parse-financial", "value": 58.7}, {"lowerIsBetter": true, "replicates": [67.0, 71.0, 69.0, 67.0, 67.0, 70.0, 68.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [80.0, 89.0, 82.0, 82.0, 84.0, 83.0, 83.0, 83.0, 84.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.2}, {"lowerIsBetter": true, "replicates": [115.0, 124.0, 122.0, 135.0, 128.0, 117.0, 118.0, 116.0, 121.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.7}, {"lowerIsBetter": true, "replicates": [138.0, 145.0, 139.0, 149.0, 142.0, 136.0, 142.0, 147.0, 155.0, 152.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.5}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 69.0, 68.0, 67.0, 68.0, 67.0, 67.0, 69.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.0}], "name": "kraken", "value": 1510.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.01075268817203], "unit": "score", "name": "Richards", "value": 210.11750400000008}, {"lowerIsBetter": false, "replicates": [191.05846388995033], "unit": "score", "name": "DeltaBlue", "value": 346.061612}, {"lowerIsBetter": false, "replicates": [278.9400278940028], "unit": "score", "name": "Encrypt", "value": 954.2588850000001}, {"lowerIsBetter": false, "replicates": [5213.541666666667], "unit": "score", "name": "Decrypt", "value": 51.05569630369634}, {"lowerIsBetter": false, "replicates": [1071.8113612004288], "unit": "score", "name": "RayTrace", "value": 690.4097369999998}, {"lowerIsBetter": false, "replicates": [711.7437722419929], "unit": "score", "name": "Earley", "value": 936.3805150000001}, {"lowerIsBetter": false, "replicates": [12231.707317073171], "unit": "score", "name": "Boyer", "value": 54.4865064805583}, {"lowerIsBetter": false, "replicates": [40940.0], "unit": "score", "name": "RegExp", "value": 22.251709819247683}, {"lowerIsBetter": false, "replicates": [572.737686139748], "unit": "score", "name": "Splay", "value": 142.28328599999995}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 20457.081626492305}]} 02:13:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20457.08"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1510.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6940.30"}}} 02:13:35 INFO - Return code: 0 02:13:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 02:13:35 INFO - # TBPL SUCCESS # 02:13:35 INFO - Running post-action listener: _resource_record_post_action 02:13:35 INFO - Running post-run listener: _resource_record_post_run 02:13:36 INFO - Total resource usage - Wall time: 1238s; CPU: 13.0%; Read bytes: 10272768; Write bytes: 452681728; Read time: 3320; Write time: 819348 02:13:36 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 4960256; Read time: 0; Write time: 372 02:13:36 INFO - run-tests - Wall time: 1222s; CPU: 13.0%; Read bytes: 8511488; Write bytes: 439123968; Read time: 3232; Write time: 802012 02:13:36 INFO - Running post-run listener: _upload_blobber_files 02:13:36 INFO - Blob upload gear active. 02:13:36 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 02:13: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 02:13: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'] 02:13: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 02:13:37 INFO - (blobuploader) - INFO - Open directory for files ... 02:13:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:13:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:13:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:13:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:13:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:13:38 INFO - (blobuploader) - INFO - Done attempting. 02:13:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:13:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:13:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:13:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:13:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:13:38 INFO - (blobuploader) - INFO - Done attempting. 02:13:38 INFO - (blobuploader) - INFO - Iteration through files over. 02:13:39 INFO - Return code: 0 02:13:39 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 02:13:39 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 02:13:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/156c22ce19f88974f7c9bf3a43e2fce0d6fb1b39b5193833b91878a65abe1afcfed9868ed0de35065d8ad9b5a3088d6601a9d2d53af906ad8899825778915bfd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/31878ed7ee1bad81ff113ee07b8ddbf6c706ade5cc006a946556c57e61541fa600f841b67b3e0c2cb94afb1d672987c290e28405ca389ca4b23bf0a495af6ce4"} 02:13:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 02:13:39 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 02:13:39 INFO - Contents: 02:13:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/156c22ce19f88974f7c9bf3a43e2fce0d6fb1b39b5193833b91878a65abe1afcfed9868ed0de35065d8ad9b5a3088d6601a9d2d53af906ad8899825778915bfd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/31878ed7ee1bad81ff113ee07b8ddbf6c706ade5cc006a946556c57e61541fa600f841b67b3e0c2cb94afb1d672987c290e28405ca389ca4b23bf0a495af6ce4"} 02:13:39 INFO - Copying logs to upload dir... 02:13:39 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1297.252859 ========= master_lag: 0.23 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2016-01-15 02:13:39.112244) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 02:13:39.116142) ========= 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=5cf47e208febbcd81da23b2e0000026f-1452850945.378970-1360290163 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/156c22ce19f88974f7c9bf3a43e2fce0d6fb1b39b5193833b91878a65abe1afcfed9868ed0de35065d8ad9b5a3088d6601a9d2d53af906ad8899825778915bfd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/31878ed7ee1bad81ff113ee07b8ddbf6c706ade5cc006a946556c57e61541fa600f841b67b3e0c2cb94afb1d672987c290e28405ca389ca4b23bf0a495af6ce4"} build_url:https://queue.taskcluster.net/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011544 build_url: 'https://queue.taskcluster.net/v1/task/cR4c-qbLQKOPyHGqji0-WA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/156c22ce19f88974f7c9bf3a43e2fce0d6fb1b39b5193833b91878a65abe1afcfed9868ed0de35065d8ad9b5a3088d6601a9d2d53af906ad8899825778915bfd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/31878ed7ee1bad81ff113ee07b8ddbf6c706ade5cc006a946556c57e61541fa600f841b67b3e0c2cb94afb1d672987c290e28405ca389ca4b23bf0a495af6ce4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 02:13:39.141350) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 02:13:39.141697) ========= 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=5cf47e208febbcd81da23b2e0000026f-1452850945.378970-1360290163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 02:13:39.232874) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 02:13:39.233230) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 02:13:39.233554) ========= ========= Total master_lag: 0.49 =========