builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-001 starttime: 1452398364.58 results: success (0) buildid: 20160109173002 builduid: 70416134c16547eaae36721601f01b90 revision: c06ff2c95163d8c4eabdf80643b08b93c1b16718 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:24.581047) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:24.581611) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:24.581995) ========= 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=8887e36bb8e381bfd44124ac000001a8-1452395812.596394-511361455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006449 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:24.648404) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:24.648736) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:24.783681) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:24.783978) ========= 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=8887e36bb8e381bfd44124ac000001a8-1452395812.596394-511361455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004585 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:24.843582) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:24.843909) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:24.844284) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:24.844592) ========= 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=8887e36bb8e381bfd44124ac000001a8-1452395812.596394-511361455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-09 19:59:25-- 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% 60.0M=0s 2016-01-09 19:59:26 (60.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.180194 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:25.045744) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:25.046097) ========= 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=8887e36bb8e381bfd44124ac000001a8-1452395812.596394-511361455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016703 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:25.096043) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:25.096552) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c06ff2c95163d8c4eabdf80643b08b93c1b16718 --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 c06ff2c95163d8c4eabdf80643b08b93c1b16718 --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=8887e36bb8e381bfd44124ac000001a8-1452395812.596394-511361455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-09 19:59:26,218 truncating revision to first 12 chars 2016-01-09 19:59:26,218 Setting DEBUG logging. 2016-01-09 19:59:26,218 attempt 1/10 2016-01-09 19:59:26,218 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c06ff2c95163?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-09 19:59:26,663 unpacking tar archive at: fx-team-c06ff2c95163/testing/mozharness/ program finished with exit code 0 elapsedTime=0.708501 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:25.819042) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:25.819390) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:25.827335) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:25.827621) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-09 19:59:25.828092) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-09 19:59:25.828429) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1452395812.596394-511361455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:59:27 INFO - MultiFileLogger online at 20160109 19:59:27 in /builds/slave/test-pgo 19:59:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:59:27 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:59:27 INFO - {'append_to_log': False, 19:59:27 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:59:27 INFO - 'blob_upload_branch': 'Fx-Team', 19:59:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:59:27 INFO - 'branch': 'Fx-Team', 19:59:27 INFO - 'buildbot_json_path': 'buildprops.json', 19:59:27 INFO - 'config_files': ('talos/linux_config.py',), 19:59:27 INFO - 'default_actions': ('clobber', 19:59:27 INFO - 'read-buildbot-config', 19:59:27 INFO - 'download-and-extract', 19:59:27 INFO - 'populate-webroot', 19:59:27 INFO - 'create-virtualenv', 19:59:27 INFO - 'install', 19:59:27 INFO - 'run-tests'), 19:59:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:59:27 INFO - 'download_minidump_stackwalk': True, 19:59:27 INFO - 'download_symbols': 'ondemand', 19:59:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:59:27 INFO - 'tooltool.py': '/tools/tooltool.py', 19:59:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:59:27 INFO - '/tools/misc-python/virtualenv.py')}, 19:59:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:59:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:59:27 INFO - 'installer_path': 'installer.exe', 19:59:27 INFO - 'log_level': 'info', 19:59:27 INFO - 'log_name': 'talos', 19:59:27 INFO - 'log_to_console': True, 19:59:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:59:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:59:27 INFO - 'opt_config_files': (), 19:59:27 INFO - 'pip_index': False, 19:59:27 INFO - 'sps_profile': False, 19:59:27 INFO - 'sps_profile_interval': 0, 19:59:27 INFO - 'suite': 'dromaeojs', 19:59:27 INFO - 'system_bits': '32', 19:59:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:59:27 INFO - 'title': 'talos-linux64-ix-001', 19:59:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:59:27 INFO - 'use_talos_json': True, 19:59:27 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:59:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:59:27 INFO - 'work_dir': 'build'} 19:59:27 INFO - ##### 19:59:27 INFO - ##### Running clobber step. 19:59:27 INFO - ##### 19:59:27 INFO - Running pre-action listener: _resource_record_pre_action 19:59:27 INFO - Running main action method: clobber 19:59:27 INFO - rmtree: /builds/slave/test-pgo/build 19:59:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:59:28 INFO - Running post-action listener: _resource_record_post_action 19:59:28 INFO - ##### 19:59:28 INFO - ##### Running read-buildbot-config step. 19:59:28 INFO - ##### 19:59:28 INFO - Running pre-action listener: _resource_record_pre_action 19:59:28 INFO - Running main action method: read_buildbot_config 19:59:28 INFO - Using buildbot properties: 19:59:28 INFO - { 19:59:28 INFO - "project": "", 19:59:28 INFO - "product": "firefox", 19:59:28 INFO - "script_repo_revision": "production", 19:59:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:59:28 INFO - "repository": "", 19:59:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 19:59:28 INFO - "buildid": "20160109173002", 19:59:28 INFO - "pgo_build": "True", 19:59:28 INFO - "basedir": "/builds/slave/test-pgo", 19:59:28 INFO - "buildnumber": 886, 19:59:28 INFO - "slavename": "talos-linux64-ix-001", 19:59:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:59:28 INFO - "platform": "ubuntu64_hw", 19:59:28 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:59:28 INFO - "branch": "fx-team", 19:59:28 INFO - "repo_path": "integration/fx-team", 19:59:28 INFO - "revision": "c06ff2c95163d8c4eabdf80643b08b93c1b16718", 19:59:28 INFO - "stage_platform": "linux64-pgo", 19:59:28 INFO - "builduid": "70416134c16547eaae36721601f01b90", 19:59:28 INFO - "slavebuilddir": "test" 19:59:28 INFO - } 19:59:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:59:28 INFO - Running post-action listener: _resource_record_post_action 19:59:28 INFO - ##### 19:59:28 INFO - ##### Running download-and-extract step. 19:59:28 INFO - ##### 19:59:28 INFO - Running pre-action listener: _resource_record_pre_action 19:59:28 INFO - Running main action method: download_and_extract 19:59:28 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:59: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')]} 19:59:28 INFO - https://queue.taskcluster.net/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:59:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/test_packages.json 19:59:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/test_packages.json 19:59:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:59:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:59:33 INFO - Downloaded 1302 bytes. 19:59:33 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:59:33 INFO - Using the following test package requirements: 19:59:33 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:59:33 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:59:33 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:33 INFO - u'jsshell-linux-x86_64.zip'], 19:59:33 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:59:33 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:59:33 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:59:33 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:59:33 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:59:33 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:59:33 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:59:33 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:33 INFO - https://queue.taskcluster.net/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:59:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:59:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:59:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:59:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:59:36 INFO - Downloaded 24028339 bytes. 19:59:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 19:59:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:59:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 19:59:37 INFO - Return code: 0 19:59:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:37 INFO - https://queue.taskcluster.net/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:59:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:59:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:59:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:59:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:59:39 INFO - Downloaded 24028339 bytes. 19:59:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 19:59:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:59:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 19:59:41 INFO - Return code: 0 19:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:41 INFO - https://queue.taskcluster.net/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:59:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:59:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:59:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:59:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:59:42 INFO - Downloaded 11132285 bytes. 19:59:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 19:59:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:59:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 19:59:42 INFO - Return code: 0 19:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:42 INFO - https://queue.taskcluster.net/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:59:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:59:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:59:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:59:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:59:43 INFO - Downloaded 55924901 bytes. 19:59:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:59:43 INFO - mkdir: /builds/slave/test-pgo/properties 19:59:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:59:43 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:59:43 INFO - Contents: 19:59:43 INFO - build_url:https://queue.taskcluster.net/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:59:43 INFO - Running post-action listener: _resource_record_post_action 19:59:43 INFO - Running post-action listener: set_extra_try_arguments 19:59:43 INFO - ##### 19:59:43 INFO - ##### Running populate-webroot step. 19:59:43 INFO - ##### 19:59:43 INFO - Running pre-action listener: _resource_record_pre_action 19:59:43 INFO - Running main action method: populate_webroot 19:59:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:59:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:59:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:59:43 INFO - '--tppagecycles', 19:59:43 INFO - '7'], 19:59:43 INFO - 'tests': ['tsvgm']}}, 19:59:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:59:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:59:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:59:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:59:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:59:43 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:59:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:59:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:43 INFO - 'talos_options': ['--e10s'], 19:59:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:59:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:43 INFO - 'tests': ['damp', 'tps']}, 19:59:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:43 INFO - 'talos_options': ['--e10s'], 19:59:43 INFO - 'tests': ['damp', 'tps']}, 19:59:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:59:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:59:43 INFO - 'other': {'tests': ['a11yr', 19:59:43 INFO - 'ts_paint', 19:59:43 INFO - 'tpaint', 19:59:43 INFO - 'sessionrestore', 19:59:43 INFO - 'sessionrestore_no_auto_restore']}, 19:59:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:59:43 INFO - 'tests': ['a11yr', 19:59:43 INFO - 'ts_paint', 19:59:43 INFO - 'tpaint', 19:59:43 INFO - 'sessionrestore', 19:59:43 INFO - 'sessionrestore_no_auto_restore']}, 19:59:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:59:43 INFO - 'tests': ['a11yr', 19:59:43 INFO - 'ts_paint', 19:59:43 INFO - 'tpaint', 19:59:43 INFO - 'sessionrestore', 19:59:43 INFO - 'sessionrestore_no_auto_restore']}, 19:59:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:59:43 INFO - 'tests': ['a11yr', 19:59:43 INFO - 'ts_paint', 19:59:43 INFO - 'tpaint', 19:59:43 INFO - 'sessionrestore', 19:59:43 INFO - 'sessionrestore_no_auto_restore']}, 19:59:43 INFO - 'other_l64': {'tests': ['a11yr', 19:59:43 INFO - 'ts_paint', 19:59:43 INFO - 'tpaint', 19:59:43 INFO - 'sessionrestore', 19:59:43 INFO - 'sessionrestore_no_auto_restore']}, 19:59:43 INFO - 'other_nol64': {'tests': ['a11yr', 19:59:43 INFO - 'ts_paint', 19:59:43 INFO - 'tpaint', 19:59:43 INFO - 'sessionrestore', 19:59:43 INFO - 'sessionrestore_no_auto_restore']}, 19:59:43 INFO - 'svgr': {'tests': ['tsvgx', 19:59:43 INFO - 'tsvgr_opacity', 19:59:43 INFO - 'tart', 19:59:43 INFO - 'tscrollx', 19:59:43 INFO - 'cart']}, 19:59:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:59:43 INFO - 'tests': ['tsvgx', 19:59:43 INFO - 'tsvgr_opacity', 19:59:43 INFO - 'tart', 19:59:43 INFO - 'tscrollx', 19:59:43 INFO - 'cart']}, 19:59:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:43 INFO - 'tests': ['tp5o']}, 19:59:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:43 INFO - 'talos_options': ['--e10s'], 19:59:43 INFO - 'tests': ['tp5o']}, 19:59:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:43 INFO - 'talos_options': ['--xperf_path', 19:59:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:59:43 INFO - 'tests': ['tp5n']}, 19:59:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:43 INFO - 'talos_options': ['--e10s', 19:59:43 INFO - '--xperf_path', 19:59:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:59:43 INFO - 'tests': ['tp5n']}}, 19:59:43 INFO - 'talos.zip': {'path': '', 19:59:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:59:43 INFO - Running post-action listener: _resource_record_post_action 19:59:43 INFO - ##### 19:59:43 INFO - ##### Running create-virtualenv step. 19:59:43 INFO - ##### 19:59:43 INFO - Running pre-action listener: _resource_record_pre_action 19:59:43 INFO - Running main action method: create_virtualenv 19:59:43 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:59:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 19:59:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:59:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:59:43 INFO - Using real prefix '/usr' 19:59:43 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:59:44 INFO - Installing distribute.............................................................................................................................................................................................done. 19:59:46 INFO - Installing pip.................done. 19:59:46 INFO - Return code: 0 19:59:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:59:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:46 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 0x7f2bbf57ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf80630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011840>, '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 0xf7e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf7eb60>, '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': '8887e36bb8e381bfd44124ac000001a8-1452395812.596394-511361455', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:59:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 19:59:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:59:46 INFO - Using env: {'DISPLAY': ':0', 19:59:46 INFO - 'HOME': '/home/cltbld', 19:59:46 INFO - 'LANG': 'en_US.UTF-8', 19:59:46 INFO - 'LANGUAGE': 'en_US:en', 19:59:46 INFO - 'LOGNAME': 'cltbld', 19:59:46 INFO - 'MAIL': '/var/mail/cltbld', 19:59:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:46 INFO - 'MOZ_NO_REMOTE': '1', 19:59:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:46 INFO - 'NO_EM_RESTART': '1', 19:59:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:46 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:46 INFO - 'SHELL': '/bin/bash', 19:59:46 INFO - 'SHLVL': '1', 19:59:46 INFO - 'TERM': 'linux', 19:59:46 INFO - 'TMOUT': '86400', 19:59:46 INFO - 'USER': 'cltbld', 19:59:46 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1452395812.596394-511361455', 19:59:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:46 INFO - '_': '/tools/buildbot/bin/python'} 19:59:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:59:46 INFO - Cleaning up... 19:59:46 INFO - Return code: 0 19:59:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:59:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:46 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 0x7f2bbf57ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf80630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011840>, '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 0xf7e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf7eb60>, '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': '8887e36bb8e381bfd44124ac000001a8-1452395812.596394-511361455', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:59:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 19:59:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:59:46 INFO - Using env: {'DISPLAY': ':0', 19:59:46 INFO - 'HOME': '/home/cltbld', 19:59:46 INFO - 'LANG': 'en_US.UTF-8', 19:59:46 INFO - 'LANGUAGE': 'en_US:en', 19:59:46 INFO - 'LOGNAME': 'cltbld', 19:59:46 INFO - 'MAIL': '/var/mail/cltbld', 19:59:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:46 INFO - 'MOZ_NO_REMOTE': '1', 19:59:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:46 INFO - 'NO_EM_RESTART': '1', 19:59:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:46 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:46 INFO - 'SHELL': '/bin/bash', 19:59:46 INFO - 'SHLVL': '1', 19:59:46 INFO - 'TERM': 'linux', 19:59:46 INFO - 'TMOUT': '86400', 19:59:46 INFO - 'USER': 'cltbld', 19:59:46 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1452395812.596394-511361455', 19:59:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:46 INFO - '_': '/tools/buildbot/bin/python'} 19:59:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:46 INFO - Downloading/unpacking psutil>=0.7.1 19:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:48 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:59:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:59:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:59:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:59:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:59:48 INFO - Installing collected packages: psutil 19:59:48 INFO - Running setup.py install for psutil 19:59:48 INFO - building 'psutil._psutil_linux' extension 19:59:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:59:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:59:48 INFO - building 'psutil._psutil_posix' extension 19:59:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:59:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:59:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:59:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:59:49 INFO - Successfully installed psutil 19:59:49 INFO - Cleaning up... 19:59:49 INFO - Return code: 0 19:59:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2bbf57ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf80630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011840>, '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 0xf7e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf7eb60>, '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': '8887e36bb8e381bfd44124ac000001a8-1452395812.596394-511361455', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:59:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 19:59:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:59:49 INFO - Using env: {'DISPLAY': ':0', 19:59:49 INFO - 'HOME': '/home/cltbld', 19:59:49 INFO - 'LANG': 'en_US.UTF-8', 19:59:49 INFO - 'LANGUAGE': 'en_US:en', 19:59:49 INFO - 'LOGNAME': 'cltbld', 19:59:49 INFO - 'MAIL': '/var/mail/cltbld', 19:59:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:49 INFO - 'MOZ_NO_REMOTE': '1', 19:59:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:49 INFO - 'NO_EM_RESTART': '1', 19:59:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:49 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:49 INFO - 'SHELL': '/bin/bash', 19:59:49 INFO - 'SHLVL': '1', 19:59:49 INFO - 'TERM': 'linux', 19:59:49 INFO - 'TMOUT': '86400', 19:59:49 INFO - 'USER': 'cltbld', 19:59:49 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1452395812.596394-511361455', 19:59:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:49 INFO - '_': '/tools/buildbot/bin/python'} 19:59:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:59:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:59:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:59:51 INFO - Installing collected packages: mozsystemmonitor 19:59:51 INFO - Running setup.py install for mozsystemmonitor 19:59:51 INFO - Successfully installed mozsystemmonitor 19:59:51 INFO - Cleaning up... 19:59:51 INFO - Return code: 0 19:59:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:59: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')]} 19:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59: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')]} 19:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59: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', '--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 0x7f2bbf57ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf80630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011840>, '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 0xf7e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf7eb60>, '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': '8887e36bb8e381bfd44124ac000001a8-1452395812.596394-511361455', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:59:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 19:59:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:59:51 INFO - Using env: {'DISPLAY': ':0', 19:59:51 INFO - 'HOME': '/home/cltbld', 19:59:51 INFO - 'LANG': 'en_US.UTF-8', 19:59:51 INFO - 'LANGUAGE': 'en_US:en', 19:59:51 INFO - 'LOGNAME': 'cltbld', 19:59:51 INFO - 'MAIL': '/var/mail/cltbld', 19:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:51 INFO - 'MOZ_NO_REMOTE': '1', 19:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:51 INFO - 'NO_EM_RESTART': '1', 19:59:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:51 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:51 INFO - 'SHELL': '/bin/bash', 19:59:51 INFO - 'SHLVL': '1', 19:59:51 INFO - 'TERM': 'linux', 19:59:51 INFO - 'TMOUT': '86400', 19:59:51 INFO - 'USER': 'cltbld', 19:59:51 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1452395812.596394-511361455', 19:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:51 INFO - '_': '/tools/buildbot/bin/python'} 19:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:51 INFO - Downloading/unpacking blobuploader==1.2.4 19:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:53 INFO - Downloading blobuploader-1.2.4.tar.gz 19:59:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:59:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:59:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:59:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:59:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:53 INFO - Downloading docopt-0.6.1.tar.gz 19:59:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:59:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:59:53 INFO - Installing collected packages: blobuploader, requests, docopt 19:59:53 INFO - Running setup.py install for blobuploader 19:59:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:59:53 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:59:53 INFO - Running setup.py install for requests 19:59:54 INFO - Running setup.py install for docopt 19:59:54 INFO - Successfully installed blobuploader requests docopt 19:59:54 INFO - Cleaning up... 19:59:54 INFO - Return code: 0 19:59:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:59: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')]} 19:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59: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')]} 19:59:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:54 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 0x7f2bbf57ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf80630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011840>, '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 0xf7e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf7eb60>, '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': '8887e36bb8e381bfd44124ac000001a8-1452395812.596394-511361455', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:59:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 19:59:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:59:54 INFO - Using env: {'DISPLAY': ':0', 19:59:54 INFO - 'HOME': '/home/cltbld', 19:59:54 INFO - 'LANG': 'en_US.UTF-8', 19:59:54 INFO - 'LANGUAGE': 'en_US:en', 19:59:54 INFO - 'LOGNAME': 'cltbld', 19:59:54 INFO - 'MAIL': '/var/mail/cltbld', 19:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:54 INFO - 'MOZ_NO_REMOTE': '1', 19:59:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:54 INFO - 'NO_EM_RESTART': '1', 19:59:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:54 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:54 INFO - 'SHELL': '/bin/bash', 19:59:54 INFO - 'SHLVL': '1', 19:59:54 INFO - 'TERM': 'linux', 19:59:54 INFO - 'TMOUT': '86400', 19:59:54 INFO - 'USER': 'cltbld', 19:59:54 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1452395812.596394-511361455', 19:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:54 INFO - '_': '/tools/buildbot/bin/python'} 19:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:59:54 INFO - Running setup.py (path:/tmp/pip-OVtGsm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:59:54 INFO - Running setup.py (path:/tmp/pip-vZnzq9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:59:54 INFO - Running setup.py (path:/tmp/pip-wV9X_2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:59:54 INFO - Running setup.py (path:/tmp/pip-XprmtI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:59:54 INFO - Running setup.py (path:/tmp/pip-Bljm85-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:59:55 INFO - Running setup.py (path:/tmp/pip-8cXj9I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:59:55 INFO - Running setup.py (path:/tmp/pip-dhlVbz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:59:55 INFO - Running setup.py (path:/tmp/pip-HAJDhY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:59:55 INFO - Running setup.py (path:/tmp/pip-TrVOjV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:59:55 INFO - Running setup.py (path:/tmp/pip-rNl9cZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:59:55 INFO - Running setup.py (path:/tmp/pip-LRbxyL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:59:55 INFO - Running setup.py (path:/tmp/pip-_Uz98r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:59:55 INFO - Running setup.py (path:/tmp/pip-RngRQk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:59:55 INFO - Running setup.py (path:/tmp/pip-eubcv3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:59:55 INFO - Running setup.py (path:/tmp/pip-SHml2q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:59:55 INFO - Running setup.py (path:/tmp/pip-Y8DTN3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:59:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:59:55 INFO - Running setup.py (path:/tmp/pip-SyfAIa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:59:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:59:55 INFO - Running setup.py install for manifestparser 19:59:55 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:59:55 INFO - Running setup.py install for mozcrash 19:59:56 INFO - Running setup.py install for mozdebug 19:59:56 INFO - Running setup.py install for mozdevice 19:59:56 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:59:56 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:59:56 INFO - Running setup.py install for mozfile 19:59:56 INFO - Running setup.py install for mozhttpd 19:59:56 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:59:56 INFO - Running setup.py install for mozinfo 19:59:56 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:59:56 INFO - Running setup.py install for mozInstall 19:59:56 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:59:56 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:59:56 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:59:56 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:59:56 INFO - Running setup.py install for mozleak 19:59:56 INFO - Running setup.py install for mozlog 19:59:56 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:59:56 INFO - Running setup.py install for moznetwork 19:59:56 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:59:56 INFO - Running setup.py install for mozprocess 19:59:57 INFO - Running setup.py install for mozprofile 19:59:57 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:59:57 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:59:57 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:59:57 INFO - Running setup.py install for mozrunner 19:59:57 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:59:57 INFO - Running setup.py install for mozscreenshot 19:59:57 INFO - Running setup.py install for moztest 19:59:57 INFO - Running setup.py install for mozversion 19:59:57 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:59:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:59:57 INFO - Cleaning up... 19:59:57 INFO - Return code: 0 19:59:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:57 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 0x7f2bbf57ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf80630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011840>, '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 0xf7e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf7eb60>, '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': '8887e36bb8e381bfd44124ac000001a8-1452395812.596394-511361455', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:59:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 19:59:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:59:57 INFO - Using env: {'DISPLAY': ':0', 19:59:57 INFO - 'HOME': '/home/cltbld', 19:59:57 INFO - 'LANG': 'en_US.UTF-8', 19:59:57 INFO - 'LANGUAGE': 'en_US:en', 19:59:57 INFO - 'LOGNAME': 'cltbld', 19:59:57 INFO - 'MAIL': '/var/mail/cltbld', 19:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:57 INFO - 'MOZ_NO_REMOTE': '1', 19:59:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:57 INFO - 'NO_EM_RESTART': '1', 19:59:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:59:57 INFO - 'PWD': '/builds/slave/test-pgo', 19:59:57 INFO - 'SHELL': '/bin/bash', 19:59:57 INFO - 'SHLVL': '1', 19:59:57 INFO - 'TERM': 'linux', 19:59:57 INFO - 'TMOUT': '86400', 19:59:57 INFO - 'USER': 'cltbld', 19:59:57 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1452395812.596394-511361455', 19:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:57 INFO - '_': '/tools/buildbot/bin/python'} 19:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:59:57 INFO - Running setup.py (path:/tmp/pip-UjoFjJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:59:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 19:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:59:57 INFO - Running setup.py (path:/tmp/pip-L2vW5B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:59:58 INFO - Running setup.py (path:/tmp/pip-ptBPIk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 19:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:59:58 INFO - Running setup.py (path:/tmp/pip-p3W6dA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:59:58 INFO - Running setup.py (path:/tmp/pip-Z9s36w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 19:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:59:58 INFO - Running setup.py (path:/tmp/pip-hKb2Co-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 19:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:59:58 INFO - Running setup.py (path:/tmp/pip-Oi6nWl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 19:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:59:58 INFO - Running setup.py (path:/tmp/pip-c2fEyR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 19:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:59:58 INFO - Running setup.py (path:/tmp/pip-jFfaPx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 19:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:59:58 INFO - Running setup.py (path:/tmp/pip-vVQ2SA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:59:58 INFO - Running setup.py (path:/tmp/pip-DbDege-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 19:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:59:58 INFO - Running setup.py (path:/tmp/pip-uwXyeI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 19:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:59:58 INFO - Running setup.py (path:/tmp/pip-OEO2qh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 19:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:59:58 INFO - Running setup.py (path:/tmp/pip-umSaZa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 19:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:59:58 INFO - Running setup.py (path:/tmp/pip-pNdVaI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 19:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:59:58 INFO - Running setup.py (path:/tmp/pip-Iuffw_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 19:59:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:59:59 INFO - Running setup.py (path:/tmp/pip-FBH8i4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 19:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 19:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:59:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:00 INFO - Downloading blessings-1.5.1.tar.gz 20:00:00 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 20:00:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 20:00:00 INFO - Installing collected packages: blessings 20:00:00 INFO - Running setup.py install for blessings 20:00:01 INFO - Successfully installed blessings 20:00:01 INFO - Cleaning up... 20:00:01 INFO - Return code: 0 20:00:01 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 20:00:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:00:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:00:01 INFO - Reading from file tmpfile_stdout 20:00:01 INFO - Current package versions: 20:00:01 INFO - argparse == 1.2.1 20:00:01 INFO - blessings == 1.5.1 20:00:01 INFO - blobuploader == 1.2.4 20:00:01 INFO - docopt == 0.6.1 20:00:01 INFO - manifestparser == 1.1 20:00:01 INFO - mozInstall == 1.12 20:00:01 INFO - mozcrash == 0.16 20:00:01 INFO - mozdebug == 0.1 20:00:01 INFO - mozdevice == 0.47 20:00:01 INFO - mozfile == 1.2 20:00:01 INFO - mozhttpd == 0.7 20:00:01 INFO - mozinfo == 0.9 20:00:01 INFO - mozleak == 0.1 20:00:01 INFO - mozlog == 3.1 20:00:01 INFO - moznetwork == 0.27 20:00:01 INFO - mozprocess == 0.22 20:00:01 INFO - mozprofile == 0.28 20:00:01 INFO - mozrunner == 6.11 20:00:01 INFO - mozscreenshot == 0.1 20:00:01 INFO - mozsystemmonitor == 0.0 20:00:01 INFO - moztest == 0.7 20:00:01 INFO - mozversion == 1.4 20:00:01 INFO - psutil == 3.1.1 20:00:01 INFO - requests == 1.2.3 20:00:01 INFO - wsgiref == 0.1.2 20:00:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:01 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 0x7f2bbf57ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf80630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011840>, '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 0xf7e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf7eb60>, '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': '8887e36bb8e381bfd44124ac000001a8-1452395812.596394-511361455', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:00:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 20:00:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:00:01 INFO - Using env: {'DISPLAY': ':0', 20:00:01 INFO - 'HOME': '/home/cltbld', 20:00:01 INFO - 'LANG': 'en_US.UTF-8', 20:00:01 INFO - 'LANGUAGE': 'en_US:en', 20:00:01 INFO - 'LOGNAME': 'cltbld', 20:00:01 INFO - 'MAIL': '/var/mail/cltbld', 20:00:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:01 INFO - 'MOZ_NO_REMOTE': '1', 20:00:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:01 INFO - 'NO_EM_RESTART': '1', 20:00:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:00:01 INFO - 'PWD': '/builds/slave/test-pgo', 20:00:01 INFO - 'SHELL': '/bin/bash', 20:00:01 INFO - 'SHLVL': '1', 20:00:01 INFO - 'TERM': 'linux', 20:00:01 INFO - 'TMOUT': '86400', 20:00:01 INFO - 'USER': 'cltbld', 20:00:01 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1452395812.596394-511361455', 20:00:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:01 INFO - '_': '/tools/buildbot/bin/python'} 20:00:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 20:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 20:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 20:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 20:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 20:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 20:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 20:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 20:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 20:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 20:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 20:00:01 INFO - Cleaning up... 20:00:01 INFO - Return code: 0 20:00:01 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 20:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:01 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 0x7f2bbf57ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf80630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011840>, '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 0xf7e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf7eb60>, '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': '8887e36bb8e381bfd44124ac000001a8-1452395812.596394-511361455', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:00:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 20:00:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:00:01 INFO - Using env: {'DISPLAY': ':0', 20:00:01 INFO - 'HOME': '/home/cltbld', 20:00:01 INFO - 'LANG': 'en_US.UTF-8', 20:00:01 INFO - 'LANGUAGE': 'en_US:en', 20:00:01 INFO - 'LOGNAME': 'cltbld', 20:00:01 INFO - 'MAIL': '/var/mail/cltbld', 20:00:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:01 INFO - 'MOZ_NO_REMOTE': '1', 20:00:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:01 INFO - 'NO_EM_RESTART': '1', 20:00:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:00:01 INFO - 'PWD': '/builds/slave/test-pgo', 20:00:01 INFO - 'SHELL': '/bin/bash', 20:00:01 INFO - 'SHLVL': '1', 20:00:01 INFO - 'TERM': 'linux', 20:00:01 INFO - 'TMOUT': '86400', 20:00:01 INFO - 'USER': 'cltbld', 20:00:01 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1452395812.596394-511361455', 20:00:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:01 INFO - '_': '/tools/buildbot/bin/python'} 20:00:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:01 INFO - Downloading/unpacking jsonschema 20:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:00:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 20:00:03 INFO - Downloading/unpacking functools32 (from jsonschema) 20:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:03 INFO - Downloading functools32-3.2.3-2.tar.gz 20:00:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 20:00:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 20:00:03 INFO - warning: no files found matching '*.txt' 20:00:03 INFO - no previously-included directories found matching 'build' 20:00:03 INFO - no previously-included directories found matching 'dist' 20:00:03 INFO - no previously-included directories found matching '.git*' 20:00:03 INFO - Installing collected packages: jsonschema, functools32 20:00:03 INFO - Running setup.py install for functools32 20:00:03 INFO - warning: no files found matching '*.txt' 20:00:03 INFO - no previously-included directories found matching 'build' 20:00:03 INFO - no previously-included directories found matching 'dist' 20:00:03 INFO - no previously-included directories found matching '.git*' 20:00:03 INFO - Successfully installed jsonschema functools32 20:00:03 INFO - Cleaning up... 20:00:03 INFO - Return code: 0 20:00:03 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 20:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:03 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 0x7f2bbf57ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf80630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011840>, '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 0xf7e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf7eb60>, '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': '8887e36bb8e381bfd44124ac000001a8-1452395812.596394-511361455', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:00:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 20:00:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 20:00:03 INFO - Using env: {'DISPLAY': ':0', 20:00:03 INFO - 'HOME': '/home/cltbld', 20:00:03 INFO - 'LANG': 'en_US.UTF-8', 20:00:03 INFO - 'LANGUAGE': 'en_US:en', 20:00:03 INFO - 'LOGNAME': 'cltbld', 20:00:03 INFO - 'MAIL': '/var/mail/cltbld', 20:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:03 INFO - 'MOZ_NO_REMOTE': '1', 20:00:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:03 INFO - 'NO_EM_RESTART': '1', 20:00:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:00:03 INFO - 'PWD': '/builds/slave/test-pgo', 20:00:03 INFO - 'SHELL': '/bin/bash', 20:00:03 INFO - 'SHLVL': '1', 20:00:03 INFO - 'TERM': 'linux', 20:00:03 INFO - 'TMOUT': '86400', 20:00:03 INFO - 'USER': 'cltbld', 20:00:03 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1452395812.596394-511361455', 20:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:03 INFO - '_': '/tools/buildbot/bin/python'} 20:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:04 INFO - Downloading/unpacking flake8 20:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:00:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 20:00:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:00:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 20:00:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 20:00:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 20:00:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 20:00:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:00:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:00:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:00:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:00:06 INFO - no previously-included directories found matching 'docs/_build' 20:00:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:00:06 INFO - Running setup.py install for pep8 20:00:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:00:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:00:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:00:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:00:06 INFO - no previously-included directories found matching 'docs/_build' 20:00:06 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 20:00:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:00:06 INFO - Cleaning up... 20:00:06 INFO - Return code: 0 20:00:06 INFO - Running post-action listener: _resource_record_post_action 20:00:06 INFO - Running post-action listener: _start_resource_monitoring 20:00:06 INFO - Starting resource monitoring. 20:00:06 INFO - ##### 20:00:06 INFO - ##### Running install step. 20:00:06 INFO - ##### 20:00:06 INFO - Running pre-action listener: _resource_record_pre_action 20:00:06 INFO - Running main action method: install 20:00:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:00:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:00:07 INFO - Reading from file tmpfile_stdout 20:00:07 INFO - Detecting whether we're running mozinstall >=1.0... 20:00:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 20:00:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 20:00:07 INFO - Reading from file tmpfile_stdout 20:00:07 INFO - Output received: 20:00:07 INFO - Usage: mozinstall [options] installer 20:00:07 INFO - Options: 20:00:07 INFO - -h, --help show this help message and exit 20:00:07 INFO - -d DEST, --destination=DEST 20:00:07 INFO - Directory to install application into. [default: 20:00:07 INFO - "/builds/slave/test-pgo"] 20:00:07 INFO - --app=APP Application being installed. [default: firefox] 20:00:07 INFO - mkdir: /builds/slave/test-pgo/build/application 20:00:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 20:00:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 20:00:23 INFO - Reading from file tmpfile_stdout 20:00:23 INFO - Output received: 20:00:23 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 20:00:23 INFO - Running post-action listener: _resource_record_post_action 20:00:23 INFO - ##### 20:00:23 INFO - ##### Running run-tests step. 20:00:23 INFO - ##### 20:00:23 INFO - Running pre-action listener: _resource_record_pre_action 20:00:23 INFO - Running main action method: run_tests 20:00:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 20:00:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 20:00:23 INFO - Python 2.7.3 20:00:23 INFO - Return code: 0 20:00:23 INFO - grabbing minidump binary from tooltool 20:00:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:23 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011840>, '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 0xf7e6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf7eb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 20:00:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 20:00:23 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 20:00:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:00:23 INFO - Return code: 0 20:00:23 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 20:00:23 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 20:00:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 20:00:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 20:00:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 20:00:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 20:00:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 20:00:24 INFO - Return code: 0 20:00:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 20:00:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 20:00:24 INFO - Using env: {'DISPLAY': ':0', 20:00:24 INFO - 'HOME': '/home/cltbld', 20:00:24 INFO - 'LANG': 'en_US.UTF-8', 20:00:24 INFO - 'LANGUAGE': 'en_US:en', 20:00:24 INFO - 'LOGNAME': 'cltbld', 20:00:24 INFO - 'MAIL': '/var/mail/cltbld', 20:00:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:00:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 20:00:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:24 INFO - 'MOZ_NO_REMOTE': '1', 20:00:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:00:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:24 INFO - 'NO_EM_RESTART': '1', 20:00:24 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:00:24 INFO - 'PWD': '/builds/slave/test-pgo', 20:00:24 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 20:00:24 INFO - 'SHELL': '/bin/bash', 20:00:24 INFO - 'SHLVL': '1', 20:00:24 INFO - 'TERM': 'linux', 20:00:24 INFO - 'TMOUT': '86400', 20:00:24 INFO - 'USER': 'cltbld', 20:00:24 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1452395812.596394-511361455', 20:00:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:24 INFO - '_': '/tools/buildbot/bin/python'} 20:00:24 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:00:24 INFO - mozversion application_buildid: 20160109173002 20:00:24 INFO - mozversion application_changeset: c06ff2c95163d8c4eabdf80643b08b93c1b16718 20:00:24 INFO - mozversion application_display_name: Nightly 20:00:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:00:24 INFO - mozversion application_name: Firefox 20:00:24 INFO - mozversion application_remotingname: firefox 20:00:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:00:24 INFO - mozversion application_vendor: Mozilla 20:00:24 INFO - mozversion application_version: 46.0a1 20:00:24 INFO - mozversion platform_buildid: 20160109173002 20:00:24 INFO - mozversion platform_changeset: c06ff2c95163d8c4eabdf80643b08b93c1b16718 20:00:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:00:24 INFO - mozversion platform_version: 46.0a1 20:00:24 INFO - using testdate: 1452398424 20:00:24 INFO - actual date: 1452398424 20:00:24 INFO - starting webserver on 'localhost:51464' 20:00:24 INFO - SUITE-START | Running 3 tests 20:00:24 INFO - TEST-START | dromaeo_css 20:00:24 INFO - operating with platform_type : linux_ 20:00:24 INFO - Initialising browser for dromaeo_css test... 20:00:24 INFO - TEST-INFO | started process 27643 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4Ygusz/profile http://localhost:51464/getInfo.html) 20:00:28 INFO - PROCESS | 27643 | __metrics Screen width/height:1600/1200 20:00:28 INFO - PROCESS | 27643 | colorDepth:24 20:00:28 INFO - PROCESS | 27643 | Browser inner width/height: 1024/697 20:00:28 INFO - PROCESS | 27643 | __metrics 20:00:28 INFO - PROCESS | 27643 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:00:28 INFO - PROCESS | 27643 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:00:29 INFO - TEST-INFO | 27643: exit 0 20:00:29 INFO - Browser initialized. 20:00:29 INFO - Running cycle 1/1 for dromaeo_css test... 20:00:29 INFO - TEST-INFO | started process 27734 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4Ygusz/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:00:41 INFO - PROCESS | 27734 | RSS: Main: 148692992 20:00:41 INFO - PROCESS | 27734 | 20:01:33 INFO - PROCESS | 27734 | 1452398493332 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 20:03:41 INFO - PROCESS | 27734 | Cycle 1(1): loaded http://localhost:51464/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51464/tests/dromaeo/cssquery-ext.html) 20:03:42 INFO - PROCESS | 27734 | RSS: Main: 237879296 20:03:42 INFO - PROCESS | 27734 | 20:06:45 INFO - PROCESS | 27734 | Cycle 1(1): loaded http://localhost:51464/tests/dromaeo/cssquery-ext.html (next: http://localhost:51464/tests/dromaeo/cssquery-jquery.html) 20:06:45 INFO - PROCESS | 27734 | RSS: Main: 237314048 20:06:45 INFO - PROCESS | 27734 | 20:09:47 INFO - PROCESS | 27734 | Cycle 1(1): loaded http://localhost:51464/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51464/tests/dromaeo/cssquery-mootools.html) 20:09:48 INFO - PROCESS | 27734 | RSS: Main: 234217472 20:09:48 INFO - PROCESS | 27734 | 20:12:50 INFO - PROCESS | 27734 | Cycle 1(1): loaded http://localhost:51464/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51464/tests/dromaeo/cssquery-prototype.html) 20:12:50 INFO - PROCESS | 27734 | RSS: Main: 218669056 20:12:50 INFO - PROCESS | 27734 | 20:15:53 INFO - PROCESS | 27734 | Cycle 1(1): loaded http://localhost:51464/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51464/tests/dromaeo/cssquery-yui.html) 20:15:53 INFO - PROCESS | 27734 | RSS: Main: 218791936 20:15:53 INFO - PROCESS | 27734 | 20:18:56 INFO - PROCESS | 27734 | Cycle 1(1): loaded http://localhost:51464/tests/dromaeo/cssquery-yui.html (next: http://localhost:51464/tests/dromaeo/cssquery-dojo.html) 20:18:56 INFO - PROCESS | 27734 | RSS: Main: 270721024 20:18:56 INFO - PROCESS | 27734 | 20:18:56 INFO - PROCESS | 27734 | __start_tp_report 20:18:56 INFO - PROCESS | 27734 | _x_x_mozilla_page_load 20:18:56 INFO - PROCESS | 27734 | _x_x_mozilla_page_load_details 20:18:56 INFO - PROCESS | 27734 | |i|pagename|runs| 20:18:56 INFO - PROCESS | 27734 | |0;dojo.html;3091.8608662610186;3170.4768713162302;3197.280611862331;3207.390595786802;3222.9033129006125;5060.6963582185;5182.637215394914;5186.948130518694;5230.398504172022;5268.552173065289;5095.8216462423825;5172.508611681884;5221.503957124077;5254.553362964152;5267.762950667219;4721.291806229067;4732.645051621143;4762.190427627312;4767.475577686451;4785.186518291881;4877.658563900528;4878.853634390974;4891.241857512091;4907.190313598252;4914.164592019365;4620.283856002291;4653.6044436222965;4717.858464246044;4768.690035147704;4819.180739274332;4744.715317080986;4754.144254034272;4777.713337199779;4781.904361912742;4838.346823178897;4712.198926182557;4719.362886010379;4719.905601887977;4728.4798672146035;4729.219678753002;4895.559399654048;5013.724245166514;5054.898902021939;5089.592832573385;5173.068847607429;5475.808346707846;5478.150886612581;5487.588430867661;5494.835154945358;5495.835124946258;5514.117741161435;5526.226328314039;5534;5538.335399752015;5539.169124631298;5025;5119.897602047976;5134.332536770234;5161.870953226199;5267.894642107213;5641.633293835969;5643.548516118701;5647.209390685307;5648.774049037993;5697.230873832063;5443.618946673774;5450.781968721207;5452.454754524595;5455.972720136453;5464.836054918359;5425.159100339453;5489.1217405214975;5517.806876759374;5529.834104976777;5584.91622625661;5605.607607467438;5609.411011843697;5611.719414029364;5614.354349249807;5640.210370548127;5546.084895992116;5591.440855914458;5593.972030139823;5605.915911261334;5613.242212301287;4171.186618609342;4258.488981322261;4261.957380426218;4372.431583894074;4406.449193850769;3812.8284227209288;3874.806259687061;3885.106425522089;3896.201278737852;3906.0820707133803;5058.418281897555;5083.288339632454;5084.8220312288895;5085.237214417867;5131.692098474104;5451.64564303319;5455.8363249102595;5456.317960254968;5459.071957767189;5507.118860982224;4963.8014479421145;5010.448850626428;5040.899182016339;5048.899022019539;5063.822766203165;4752.263399173134;4785;4788.688735232199;4817.349657796152;4830.6135509159885;5679.574031947621;5703;5729.1119876419225;5729.512991395694;5778.930897783839;5341.65279256847;5459.481349271813;5459.808906688247;5528.115501519737;5535.640183388067;5649.943500564942;5654.095344744821;5681.715914204356;5687.715614219355;5757.769689212385;5428.56571474289;5429.918551221655;5441.5102640762525;5449.264349312792;5465.508104270635;5423.810166644149;5473.425290344457;5526.585506086979;5532.695701736443;5574.191742197439;5400.162974738922;5423.864403389947;5436.836894893159;5487.4238204987905;5514.944850551604;5380.70406127651;5406.7837286509675;5430.782768689208;5432.864178395572;5433.782648694008;5151.995360904588;5312.574994000393;5352.5450336721815;5359.892802144013;5410.918836217381;5364.678119312854;5389.75746091419;5425.782968681367;5472.50747432733;5527.668339899619;5325.414204437431;5330.200469929387;5331.920021199763;5336.039512887717;5376.784928602812 20:18:56 INFO - PROCESS | 27734 | |1;ext.html;532.9706866122362;536.5064140990291;538.7764077907668;554.9556035517159;558.8938101760667;27434.17697469074;28183.57724634132;35756.284874302495;35815.64184358159;35945.46081808775;38753.8062309688;39340.606593934055;39385.40921886174;39452.80273598635;39471.21057578854;7273.7090516379285;7393.03890494235;8228.753137405873;8414.747557573282;8440.493570385766;9889.06053924876;10076.294659373847;10150.949245253763;10157;10160.136388406994;9899.604015839357;9942.403455792639;9995.100440960312;9997.450140242283;10003.59985600575;7403.962980185119;7621.628106940749;7630.542167469969;7637.579933103677;9811.264155188353;9804.90195098047;10111.747206319827;10117.494125293779;10122.696319110439;10123.341982771097;35772.642273577454;35873.46189807155;36105.277894442224;36215.64598301102;36217.09457263589;3188.4260833050043;3352.8491217895007;3393.0499460151195;3462.480627905809;3971.5631280559114;27479.587806182924;27515.58726619102;27644.447111057867;30981.380372392425;31078.756849725985;3653.2328211075705;3686.686631636314;3723.94414083789;3743.2326373093724;3836.808159592037;267087;268344;268835.999999998;269067;269345;49814.50185498171;50243.24635130476;56018.719906400205;56627;57677.134842977386;51216.74391628018;51429;51631.48368516342;51703.48296516987;51704.48295517072;14194.148351098967;14213.289335533182;14262.3581938813;14322.355494002795;14336.856631433553;11446.427678616035;11544.826827597424;11546.884531154581;11557.826632600518;11680.182387232982;18717;18993.62012759737;18999.62000759977;19014.71477927832;19036.33372831944;7031.332023457763;7294.307040831112;7353.911357229977;7377.4098072155175;7450.2061726852435;918.912703293186;921.3596550397409;923.6905636611676;1014.031599822168;1056.730533713898;27902.86048569785;28652.283692907426;28989;29054.418911621648;29187.7081229185;1004.6232662751469;1043.139409986764;1043.5617040842865;1125.4918409331535;1148;12763.872851151342;13014;13340.533081342106;13432.865671343357;13578.93210533941;319297;320453;321914;322294;323642;49896.50103498918;50043;50142;50188.498115019116;50252;1175.9941200293945;1324.6953200763878;1344.946202151903;1348.92580908051;1359.3746876436753;19343;25741.742582573934;26477.33806654772;26500.337491562095;26571;43622.12755744804;44127.558724412345;44243;44245;44250;226327;227757;227764;290480;293822;29984.102066731186;30065.091538099907;30243.395132097674;30431.391372172875;30613.08160755181;34402.48396274008;35397.64602354047;35469.29061418809;35795.284094318486;35818;30208.5468717965;30941.226469338446;31306.217344565655;31683.52474712927;31793.841030795622;32642.673573263964;32723.401291503775;33036.834815825765;33512.32975340431;33549.832250839565;31994.840025799724;32526.512102318957;32782.34435311233;32817;32824.671753282164;29093.85453072721;29665.11004669863;30117.548236776027;30315;30488.390232195674;24106.63840042436;24781.50436991214;24853.130140445;24904.75095249024;25085.122020729188 20:18:56 INFO - PROCESS | 27734 | |2;jquery.html;348.9808060556669;351.9384107781138;352.04595546070146;352.30419920656703;353.30928035690226;13349.866501334984;13908;15859;16020.59948501288;16989.999999999985;15197.848021519781;15275.923620381882;15846.524604261862;15899.761503577427;15902.363905443797;5022.623303252261;5123.948760512384;5298.867528311804;5324.54741346986;5329.467053294678;3707.1658876752786;3891.0855948851995;5203.68777873327;5320.920186197211;5519.116941289394;5473.945260547403;5493.176023596453;5499.395066542677;5530.004599172147;5530.032244357241;5885.176075349433;5913.645181289094;5917;5923.881522369572;5927.110933360009;5104.540591346759;5278.894422111536;5349.679019258818;5354.973225133888;5360.785568577252;12533.122681412306;12824.422900969479;12898.161619494704;12993.350332483433;13027.218366898016;2045.1103769860158;2100.7479102507646;2215.4793623498463;2303.2974942642486;2437.244454219198;9162.221211197057;9608.95195524018;9630.18143457807;11202.159838012181;12436;1780.9643807123784;1857.3963461874944;1881.2380985700813;1898.2596787252983;1922.2503223742751;49243;49456.25815612769;53016.73491632517;54876;56011.15983260254;9349.439033657865;9594.376365536218;9746;9760.511974401394;9852;12579.245245285128;12595.559155429515;12635.494580216871;12635.557755478514;12687.555935542212;7051.048108505389;7130.928690713026;7136.357727804522;7160.498765086498;7207.747728829466;6849.897251541231;6849.931500685029;6857.211420686585;6910.2053263874295;6910.412614927787;4336.522982471925;4380.518143004267;4390.714603550759;4417.2269852775635;4419.558044195554;1732.2464727843428;1770.2653398839338;1796.5059608607737;1844.6771814932333;1845.455590600776;449.4112712346836;450.8106595230011;865.7922098696267;973.250597040275;1007.2093406675724;9320.229156460251;10356.533955972;10821;10974.835377469344;11489.253198542068;476.86030387374205;890.9866352004725;948.2982592881356;957.6696039866374;995.5370752600076;8683.2185103341;8906.332025098143;8997.505137217517;9075.50084745332;9620.95189524048;469323;504462;539182;557125;557531;42626.14747705028;42765.14469710588;52694.94610107853;66564;69451;1170.5434880396651;1179.180469573638;1179.2629606495768;1202.6211743300832;1212.4301578258205;13819.447222111003;14464.421423143378;14897.404103835725;14980.1011939284;15284.541463756104;29018;29146.854265728536;29390;29850;30027.849860750557;38419.615803842724;38940.610593893696;39362.2127557453;39442.40836387399;39536.209275813744;3016.909492715222;6987.790366289019;7198.7840364789145;7198.820029499305;7238.782836514913;10526.473676316;10890.29213101146;10996;11076.889231107585;11462.312261264351;8728.956355218183;9370.625174992923;9736.513174341397;9771.169450596779;9786.41281523111;9123.452592844451;9386.624535018524;9525.333226674065;9528.904710952802;9723.222142228464;8722.607482663423;9211.447313161232;9726.221902247662;9932.900670993198;10052.748681283027;7171.533850299714;7174.1032370953635;7275.890861636974;7350.926490735024;7363.41092712571;7441.0010083597945;7806.960965195365;9814.901850981685;9850.636945827357;10082.899171008195 20:18:56 INFO - PROCESS | 27734 | |3;mootools.html;1331.926744029078;1444.7905053767204;1448.6450819549211;1611.1541440743608;1796.2994432171456;7154.534955227907;7669.309762121415;7825.256600622946;7826.804329891748;7858.253465920729;7732.497387669811;7906.130325664187;7919.208079192093;7925.445218834684;7933.246341597539;2071.0369678099682;2115.048228297265;2283.7602051784575;2358.7641235876445;2383.5471260460545;2288.5079707862806;2295.2196253273883;2298.8505747126383;2305.262316058862;2307.9884600577057;2269.920552780653;2330.627099664054;2334.5914464968646;2334.871582062986;2336.8013718833836;2305.8501197422115;2338.333574931145;2359.1153317505937;2359.7758212969825;2360.5042940982416;2307.5154217614154;2318.2929206591984;2351.823613229015;2354.9175778847657;2372.905083796646;7948.642311095957;8000.959995199987;8018.879716804253;8019.558924259163;8024.799380015488;4665.580097791181;4792.472827988919;4793.424789025305;4804.25534042224;4809.951900480985;3245.675432456759;3259.837008149607;3321.8173000484962;3407.5910890693026;3425.246445781924;1046.7540128069897;1056.646023582101;1062.7343164208949;1088.390501319256;1089.580511503077;11320.377379244139;11349.602763903224;11389.373584452851;11393.08855291583;11399.202055856093;4523.864284071483;4548.840790572314;4576.565226303496;4588.26587745959;4604.838830640979;9586.185174260127;9609.135177834029;9631.614735410645;9642;9655.275854310954;5088.847334579968;5091.2363145527725;5097.311862898461;5099.133147364957;5099.87250318745;4558.9772051139535;4637.397138372057;4644.465886423104;4648.558386953234;4650.534946505322;3559.430491121408;3612.3497770401054;3619.1494998675817;3622.6558476944647;3805.391137418055;1142.3431526871916;1201.1051766434064;1218.975620487603;1238.3003602964297;1243.104964425612;996.9800603988025;1012.3166862367872;1012.8126296635146;1122.7754449110212;1330.255057167989;7232.710691572383;7259.637018149071;7297.306755858185;7300.96349518249;7310.086239220098;1107.7839821234943;1123.4944275076248;1131.4569006876582;1145.68493664243;1149.4712432281244;5769.826905192851;5833.241678581757;5835.591508594358;5838.241028666246;5847.8245652630485;9251.259899208047;9400.341976061747;9413.905860941302;9532.142107210384;9573.090556397132;9312.906870931203;9386.296027797942;9418.529073546433;9441.952790236142;9447.905520944703;7274.381677557467;7478.476506644592;7481.364084052808;7560.810979725551;7562.432817538706;7089.929100708927;7091.326323999212;7152.892706609301;7172.462065345225;7172.605506697182;8155.388345873965;8247.0928197897;8463.830723385374;8469.153084691729;8476.06763256029;8512.40413171072;8525.573721314033;8570.442921210102;8613.69852055175;8621.224089831945;7286.48994570375;7413.221611730906;7420.5547667140145;7429.8142546436775;7431.442641801778;7402.777916662509;7763.961180194289;7842.372610191285;7849.803754906173;7856.84286314259;7087.5747455150795;7225.24134965821;7266.818329541804;7307.159676637255;7392.704291828267;7084.964575177091;7121.572705637678;7140.6786694599905;7261.891071634035;7377.631118443949;7128.358447739728;7179.066721326194;7184.137903451619;7184.640767961686;7186.784396468114;6424.839379015562;6613.107230523818;6639.734410623521;6669.666516674244;6713.395794378529;6532.183477065367;6555.2133743951035;6563.310852360624;6564.081028656087;6564.409203171546 20:18:56 INFO - PROCESS | 27734 | |4;prototype.html;342.79432340595645;345.95329630499873;346.7676656640051;351.71335361680246;355.95550556180496;5774.451427114417;5832.62087964282;5888.263967004124;5889.528837692985;5938.792142275021;5707.77168913244;5781.19063331134;5817.360090390064;5834.037383831674;5843.79546715865;4508.954910450902;4509.932351014738;4511.639068874482;4514.18744625968;4521.5930566249035;4373.234683930315;4448.310511870665;4472.619827314682;4510.413646225986;4576.473705523874;4530.365748795171;4534.231649656636;4535.569120933523;4551.749653769041;4558.475775285851;4511.909761804762;4529.8641040768825;4531.184386810372;4541;4545.5908968193025;4015.0163210013443;4020.537638171589;4022.1955608878047;4030.4558884550797;4039.1315867088715;5419.268398766156;5574.247476590689;5592.552595792326;5644.5484361251;5654.180143879114;5336.946630533684;5343.412224655285;5350.143976963667;5350.411454739976;5353.678779273256;5977.193078934331;6265.185525881606;6283.937160628381;6290.811275661737;6294.244690637152;4341.978290108561;4364.541723119059;4410.360497727812;4447.911041779146;4476.127155204704;6423.42189202974;6465.579737317059;6506.674666266667;6507.381798729113;6536;4590.67865249436;4592.334111553806;4601.654875884322;4603.769811509411;4604.30935359692;4567.36056952027;4639.072185562901;4659.068186362741;4665.0903073900945;4680.765961701902;5247.790088396421;5256.842294731164;5273.1035723927025;5285.550728188147;5312.5218730314455;6276.46650034743;6286.591371560834;6288.245410550763;6290.308066112724;6291.433770960635;1633.1997321312472;1636.6808472347777;1649.1094808803352;1653.9338426463048;1654.2390500369725;1126.4030064065894;1131.3155540897803;1139.0318229504855;1148.9425528723698;1161.1871689817162;5886.676232807236;5902.940970590325;5903.498202652822;5905.46850783423;5909.674967876808;6425.132607098076;6427.357264273535;6439.61362318253;6440.645764482999;6444.806655800334;5827.825165245049;5896.793612223637;5938.376470470625;5975.25309336333;5976.432238937294;3463.41122009259;3481.547398838135;3484.285721427101;3484.790912545255;3486.825658717054;6684.16447944007;6703.798886033427;6704.094947182166;6705.463562914955;6711.161104861892;6558.081868538408;6559.8360040998405;6560.540762146604;6564.4420224281475;6568.310327415648;6511.413972742381;6696.5647232929705;6696.5647232929705;6701.5308928375525;6704.061431399608;6227.813165605039;6332.240131184103;6390.808275751735;6411.871762564816;6415.422611964946;6260.248770147611;6285.842853928689;6355.841103972438;6356.555041147075;6366.586171898812;6654.83362915931;6665.200175978914;6676.9666151668935;6685.364890335411;6686.966565167143;4320.93518597215;4547.52251013652;4555.589996900295;4557.954420455753;4558.407407037064;6444.130042444398;6452.419282264619;6456.063870738622;6475.061116138228;6477.77327793525;6298.905516417349;6301.495880329471;6302.621842689453;6304.18045654062;6307.495400368051;6176.8764624706355;6209.192804935329;6285.120083188266;6291.685415729286;6296.33888441707;6095.512359011357;6104.17593624855;6105.389461053859;6107.175531303217;6138.907916381348;6293.811185664437;6294.118823364641;6301.8109456716375;6307.432331090224;6319.96840015797;6062.666553339609;6157.907631385443;6161.199044124235;6171.043488259147;6171.259448866164 20:18:56 INFO - PROCESS | 27734 | |5;yui.html;832.8922533031069;846.4286606540584;851.3274513134623;861.6940985949988;865.1002956924799;13272.668183295411;13445.394957226923;13463.528776492825;13466.394012269458;13486;12174.756504869898;12648.810267845967;12705.555305564307;12709.936450317758;12721.745565088693;663.7510933399975;673.1820837682216;816.8121332093607;831.6465502161587;832;673.7507122364732;793.1434051224693;823.217942954193;823.320760372695;823.7446391618618;843.0894633795486;848.2281124177;848.516345682961;852.4373913217278;854.0946596607616;853.8761879527495;854.4574195385943;854.4659587757651;855.5636625321068;856.9185927336893;515.6519349439151;521.5879455230402;624.3132554190399;632.4718859752113;636.6975686548899;12659.810102848465;12661.30362830044;12671.556495522706;12679.619611411672;12709.809352859715;12173.695657608541;12715.237085774883;12858.871411285954;13165.670858228525;13398.464061437531;10632.946835265851;10726.463676816205;10731.248812583122;10741.677749667522;10787.406692631903;3514.3849826280552;3566.4115420955513;3590.8204589770407;3654.6162652921594;3656.213914008501;43487.78256108699;43599.56400435987;43688.78155609233;44074.23703051874;44208.115837683064;9901.078867935788;9978.850317245102;10181.643642472478;10453.275209590485;10563.894361056291;18533.721994170097;18562.350317738816;18585.44243672665;18596.535086622942;18612.255509779727;7570.129435115033;7662.195469475625;7662.233776622405;7685;7839.6472158752995;4170;4325.199838029975;4364.061726728769;4425.690201685916;4427.977860110679;3122.2818751686787;3141.937161256762;3148.275896543762;3152.4798408262836;3153.7003984621424;564.9096144616842;571.7512881896388;574.2219292858117;582.5281521967136;596.2487266044815;515.3583788183736;642.4667525953447;647.2200997797643;659.3406593406594;692.5221597097986;8304.128066553047;8318.542480163649;8348.15440409362;8551.871721924175;8619.267362274277;623.4918541388754;646.2051676437914;654.4469922915129;672.2840175213382;678.2911857109234;3831.8275677594575;3924.5682974872743;3973.5430425501436;4002.239574480839;4320.373545835899;50290.497095029314;50531;58114.4188558109;59520.70239648774;59752.701236493536;45740;46646.5335346649;46648.300275495894;49880.50119498831;50917.49082509201;43290.13419731588;46084.308735369;46282;46345.53654463479;47128.5287147131;8343.2908202801;8538.060813310407;8693.695720649746;8736.650533978569;8925.866112008196;32309;33473.33053338871;33926.66073339235;34375;35662.465063024596;39257;41239;41567.376489353286;45185.32222016738;45400.54599454095;10800.351978881292;11008.449577521253;11017.504212310305;11064.834027489433;11219.831702524305;12225.327606981346;12257.938710306391;12329.568465103679;12338.568150114703;12467.064970127096;11266.7746645065;11324.886751132382;11367;11580.768384632092;11980;11434.885651143715;11595;11654.359010254517;12022.75954480888;12023.519059237533;11072.612458563912;11158.776824463628;11284.717882053013;11685.123615728684;11834.881651183723;9360.251179905727;9609.951950240204;9618;10002.299839011199;10056.54745536438;9318.207952324128;9833.901660983298;9842;9862;9868.407895526292 20:18:56 INFO - PROCESS | 27734 | __end_tp_report 20:18:56 INFO - PROCESS | 27734 | __start_cc_report 20:18:56 INFO - PROCESS | 27734 | _x_x_mozilla_cycle_collect,915 20:18:56 INFO - PROCESS | 27734 | __end_cc_report 20:18:56 INFO - PROCESS | 27734 | __startTimestamp1452399536889__endTimestamp 20:18:56 INFO - PROCESS | 27734 | 20:18:56 INFO - PROCESS | 27734 | ------- Summary: start ------- 20:18:56 INFO - PROCESS | 27734 | Number of tests: 6 20:18:56 INFO - PROCESS | 27734 | 20:18:56 INFO - PROCESS | 27734 | [#0] dojo.html Cycles:165 Average:5145.20 Median:5352.55 stddev:543.65 (10.2%) stddev-sans-first:520.91 20:18:56 INFO - PROCESS | 27734 | Values: 3091.9 3170.5 3197.3 3207.4 3222.9 5060.7 5182.6 5186.9 5230.4 5268.6 5095.8 5172.5 5221.5 5254.6 5267.8 4721.3 4732.6 4762.2 4767.5 4785.2 4877.7 4878.9 4891.2 4907.2 4914.2 4620.3 4653.6 4717.9 4768.7 4819.2 4744.7 4754.1 4777.7 4781.9 4838.3 4712.2 4719.4 4719.9 4728.5 4729.2 4895.6 5013.7 5054.9 5089.6 5173.1 5475.8 5478.2 5487.6 5494.8 5495.8 5514.1 5526.2 5534.0 5538.3 5539.2 5025.0 5119.9 5134.3 5161.9 5267.9 5641.6 5643.5 5647.2 5648.8 5697.2 5443.6 5450.8 5452.5 5456.0 5464.8 5425.2 5489.1 5517.8 5529.8 5584.9 5605.6 5609.4 5611.7 5614.4 5640.2 5546.1 5591.4 5594.0 5605.9 5613.2 4171.2 4258.5 4262.0 4372.4 4406.4 3812.8 3874.8 3885.1 3896.2 3906.1 5058.4 5083.3 5084.8 5085.2 5131.7 5451.6 5455.8 5456.3 5459.1 5507.1 4963.8 5010.4 5040.9 5048.9 5063.8 4752.3 4785.0 4788.7 4817.3 4830.6 5679.6 5703.0 5729.1 5729.5 5778.9 5341.7 5459.5 5459.8 5528.1 5535.6 5649.9 5654.1 5681.7 5687.7 5757.8 5428.6 5429.9 5441.5 5449.3 5465.5 5423.8 5473.4 5526.6 5532.7 5574.2 5400.2 5423.9 5436.8 5487.4 5514.9 5380.7 5406.8 5430.8 5432.9 5433.8 5152.0 5312.6 5352.5 5359.9 5410.9 5364.7 5389.8 5425.8 5472.5 5527.7 5325.4 5330.2 5331.9 5336.0 5376.8 20:18:56 INFO - PROCESS | 27734 | 20:18:56 INFO - PROCESS | 27734 | [#1] ext.html Cycles:180 Average:43704.00 Median:176223.92 stddev:74053.23 (42.0%) stddev-sans-first:74190.02 20:18:56 INFO - PROCESS | 27734 | Values: 533.0 536.5 538.8 555.0 558.9 27434.2 28183.6 35756.3 35815.6 35945.5 38753.8 39340.6 39385.4 39452.8 39471.2 7273.7 7393.0 8228.8 8414.7 8440.5 9889.1 10076.3 10150.9 10157.0 10160.1 9899.6 9942.4 9995.1 9997.5 10003.6 7404.0 7621.6 7630.5 7637.6 9811.3 9804.9 10111.7 10117.5 10122.7 10123.3 35772.6 35873.5 36105.3 36215.6 36217.1 3188.4 3352.8 3393.0 3462.5 3971.6 27479.6 27515.6 27644.4 30981.4 31078.8 3653.2 3686.7 3723.9 3743.2 3836.8 267087.0 268344.0 268836.0 269067.0 269345.0 49814.5 50243.2 56018.7 56627.0 57677.1 51216.7 51429.0 51631.5 51703.5 51704.5 14194.1 14213.3 14262.4 14322.4 14336.9 11446.4 11544.8 11546.9 11557.8 11680.2 18717.0 18993.6 18999.6 19014.7 19036.3 7031.3 7294.3 7353.9 7377.4 7450.2 918.9 921.4 923.7 1014.0 1056.7 27902.9 28652.3 28989.0 29054.4 29187.7 1004.6 1043.1 1043.6 1125.5 1148.0 12763.9 13014.0 13340.5 13432.9 13578.9 319297.0 320453.0 321914.0 322294.0 323642.0 49896.5 50043.0 50142.0 50188.5 50252.0 1176.0 1324.7 1344.9 1348.9 1359.4 19343.0 25741.7 26477.3 26500.3 26571.0 43622.1 44127.6 44243.0 44245.0 44250.0 226327.0 227757.0 227764.0 290480.0 293822.0 29984.1 30065.1 30243.4 30431.4 30613.1 34402.5 35397.6 35469.3 35795.3 35818.0 30208.5 30941.2 31306.2 31683.5 31793.8 32642.7 32723.4 33036.8 33512.3 33549.8 31994.8 32526.5 32782.3 32817.0 32824.7 29093.9 29665.1 30117.5 30315.0 30488.4 24106.6 24781.5 24853.1 24904.8 25085.1 20:18:56 INFO - PROCESS | 27734 | 20:18:56 INFO - PROCESS | 27734 | [#2] jquery.html Cycles:180 Average:25788.05 Median:254742.31 stddev:85867.63 (33.7%) stddev-sans-first:86087.26 20:18:56 INFO - PROCESS | 27734 | Values: 349.0 351.9 352.0 352.3 353.3 13349.9 13908.0 15859.0 16020.6 16990.0 15197.8 15275.9 15846.5 15899.8 15902.4 5022.6 5123.9 5298.9 5324.5 5329.5 3707.2 3891.1 5203.7 5320.9 5519.1 5473.9 5493.2 5499.4 5530.0 5530.0 5885.2 5913.6 5917.0 5923.9 5927.1 5104.5 5278.9 5349.7 5355.0 5360.8 12533.1 12824.4 12898.2 12993.4 13027.2 2045.1 2100.7 2215.5 2303.3 2437.2 9162.2 9609.0 9630.2 11202.2 12436.0 1781.0 1857.4 1881.2 1898.3 1922.3 49243.0 49456.3 53016.7 54876.0 56011.2 9349.4 9594.4 9746.0 9760.5 9852.0 12579.2 12595.6 12635.5 12635.6 12687.6 7051.0 7130.9 7136.4 7160.5 7207.7 6849.9 6849.9 6857.2 6910.2 6910.4 4336.5 4380.5 4390.7 4417.2 4419.6 1732.2 1770.3 1796.5 1844.7 1845.5 449.4 450.8 865.8 973.3 1007.2 9320.2 10356.5 10821.0 10974.8 11489.3 476.9 891.0 948.3 957.7 995.5 8683.2 8906.3 8997.5 9075.5 9621.0 469323.0 504462.0 539182.0 557125.0 557531.0 42626.1 42765.1 52694.9 66564.0 69451.0 1170.5 1179.2 1179.3 1202.6 1212.4 13819.4 14464.4 14897.4 14980.1 15284.5 29018.0 29146.9 29390.0 29850.0 30027.8 38419.6 38940.6 39362.2 39442.4 39536.2 3016.9 6987.8 7198.8 7198.8 7238.8 10526.5 10890.3 10996.0 11076.9 11462.3 8729.0 9370.6 9736.5 9771.2 9786.4 9123.5 9386.6 9525.3 9528.9 9723.2 8722.6 9211.4 9726.2 9932.9 10052.7 7171.5 7174.1 7275.9 7350.9 7363.4 7441.0 7807.0 9814.9 9850.6 10082.9 20:18:56 INFO - PROCESS | 27734 | 20:18:56 INFO - PROCESS | 27734 | [#3] mootools.html Cycles:180 Average:5599.46 Median:6543.70 stddev:2892.89 (44.2%) stddev-sans-first:2883.21 20:18:56 INFO - PROCESS | 27734 | Values: 1331.9 1444.8 1448.6 1611.2 1796.3 7154.5 7669.3 7825.3 7826.8 7858.3 7732.5 7906.1 7919.2 7925.4 7933.2 2071.0 2115.0 2283.8 2358.8 2383.5 2288.5 2295.2 2298.9 2305.3 2308.0 2269.9 2330.6 2334.6 2334.9 2336.8 2305.9 2338.3 2359.1 2359.8 2360.5 2307.5 2318.3 2351.8 2354.9 2372.9 7948.6 8001.0 8018.9 8019.6 8024.8 4665.6 4792.5 4793.4 4804.3 4810.0 3245.7 3259.8 3321.8 3407.6 3425.2 1046.8 1056.6 1062.7 1088.4 1089.6 11320.4 11349.6 11389.4 11393.1 11399.2 4523.9 4548.8 4576.6 4588.3 4604.8 9586.2 9609.1 9631.6 9642.0 9655.3 5088.8 5091.2 5097.3 5099.1 5099.9 4559.0 4637.4 4644.5 4648.6 4650.5 3559.4 3612.3 3619.1 3622.7 3805.4 1142.3 1201.1 1219.0 1238.3 1243.1 997.0 1012.3 1012.8 1122.8 1330.3 7232.7 7259.6 7297.3 7301.0 7310.1 1107.8 1123.5 1131.5 1145.7 1149.5 5769.8 5833.2 5835.6 5838.2 5847.8 9251.3 9400.3 9413.9 9532.1 9573.1 9312.9 9386.3 9418.5 9442.0 9447.9 7274.4 7478.5 7481.4 7560.8 7562.4 7089.9 7091.3 7152.9 7172.5 7172.6 8155.4 8247.1 8463.8 8469.2 8476.1 8512.4 8525.6 8570.4 8613.7 8621.2 7286.5 7413.2 7420.6 7429.8 7431.4 7402.8 7764.0 7842.4 7849.8 7856.8 7087.6 7225.2 7266.8 7307.2 7392.7 7085.0 7121.6 7140.7 7261.9 7377.6 7128.4 7179.1 7184.1 7184.6 7186.8 6424.8 6613.1 6639.7 6669.7 6713.4 6532.2 6555.2 6563.3 6564.1 6564.4 20:18:56 INFO - PROCESS | 27734 | 20:18:56 INFO - PROCESS | 27734 | [#4] prototype.html Cycles:180 Average:5245.39 Median:5893.16 stddev:1548.97 (26.3%) stddev-sans-first:1508.97 20:18:56 INFO - PROCESS | 27734 | Values: 342.8 346.0 346.8 351.7 356.0 5774.5 5832.6 5888.3 5889.5 5938.8 5707.8 5781.2 5817.4 5834.0 5843.8 4509.0 4509.9 4511.6 4514.2 4521.6 4373.2 4448.3 4472.6 4510.4 4576.5 4530.4 4534.2 4535.6 4551.7 4558.5 4511.9 4529.9 4531.2 4541.0 4545.6 4015.0 4020.5 4022.2 4030.5 4039.1 5419.3 5574.2 5592.6 5644.5 5654.2 5336.9 5343.4 5350.1 5350.4 5353.7 5977.2 6265.2 6283.9 6290.8 6294.2 4342.0 4364.5 4410.4 4447.9 4476.1 6423.4 6465.6 6506.7 6507.4 6536.0 4590.7 4592.3 4601.7 4603.8 4604.3 4567.4 4639.1 4659.1 4665.1 4680.8 5247.8 5256.8 5273.1 5285.6 5312.5 6276.5 6286.6 6288.2 6290.3 6291.4 1633.2 1636.7 1649.1 1653.9 1654.2 1126.4 1131.3 1139.0 1148.9 1161.2 5886.7 5902.9 5903.5 5905.5 5909.7 6425.1 6427.4 6439.6 6440.6 6444.8 5827.8 5896.8 5938.4 5975.3 5976.4 3463.4 3481.5 3484.3 3484.8 3486.8 6684.2 6703.8 6704.1 6705.5 6711.2 6558.1 6559.8 6560.5 6564.4 6568.3 6511.4 6696.6 6696.6 6701.5 6704.1 6227.8 6332.2 6390.8 6411.9 6415.4 6260.2 6285.8 6355.8 6356.6 6366.6 6654.8 6665.2 6677.0 6685.4 6687.0 4320.9 4547.5 4555.6 4558.0 4558.4 6444.1 6452.4 6456.1 6475.1 6477.8 6298.9 6301.5 6302.6 6304.2 6307.5 6176.9 6209.2 6285.1 6291.7 6296.3 6095.5 6104.2 6105.4 6107.2 6138.9 6293.8 6294.1 6301.8 6307.4 6320.0 6062.7 6157.9 6161.2 6171.0 6171.3 20:18:56 INFO - PROCESS | 27734 | 20:18:56 INFO - PROCESS | 27734 | [#5] yui.html Cycles:180 Average:13463.57 Median:44141.18 stddev:15175.56 (34.4%) stddev-sans-first:15188.48 20:18:56 INFO - PROCESS | 27734 | Values: 832.9 846.4 851.3 861.7 865.1 13272.7 13445.4 13463.5 13466.4 13486.0 12174.8 12648.8 12705.6 12709.9 12721.7 663.8 673.2 816.8 831.6 832.0 673.8 793.1 823.2 823.3 823.7 843.1 848.2 848.5 852.4 854.1 853.9 854.5 854.5 855.6 856.9 515.7 521.6 624.3 632.5 636.7 12659.8 12661.3 12671.6 12679.6 12709.8 12173.7 12715.2 12858.9 13165.7 13398.5 10632.9 10726.5 10731.2 10741.7 10787.4 3514.4 3566.4 3590.8 3654.6 3656.2 43487.8 43599.6 43688.8 44074.2 44208.1 9901.1 9978.9 10181.6 10453.3 10563.9 18533.7 18562.4 18585.4 18596.5 18612.3 7570.1 7662.2 7662.2 7685.0 7839.6 4170.0 4325.2 4364.1 4425.7 4428.0 3122.3 3141.9 3148.3 3152.5 3153.7 564.9 571.8 574.2 582.5 596.2 515.4 642.5 647.2 659.3 692.5 8304.1 8318.5 8348.2 8551.9 8619.3 623.5 646.2 654.4 672.3 678.3 3831.8 3924.6 3973.5 4002.2 4320.4 50290.5 50531.0 58114.4 59520.7 59752.7 45740.0 46646.5 46648.3 49880.5 50917.5 43290.1 46084.3 46282.0 46345.5 47128.5 8343.3 8538.1 8693.7 8736.7 8925.9 32309.0 33473.3 33926.7 34375.0 35662.5 39257.0 41239.0 41567.4 45185.3 45400.5 10800.4 11008.4 11017.5 11064.8 11219.8 12225.3 12257.9 12329.6 12338.6 12467.1 11266.8 11324.9 11367.0 11580.8 11980.0 11434.9 11595.0 11654.4 12022.8 12023.5 11072.6 11158.8 11284.7 11685.1 11834.9 9360.3 9610.0 9618.0 10002.3 10056.5 9318.2 9833.9 9842.0 9862.0 9868.4 20:18:56 INFO - PROCESS | 27734 | -------- Summary: end -------- 20:18:56 INFO - PROCESS | 27734 | 20:18:57 INFO - TEST-INFO | 27734: exit 0 20:18:57 INFO - TEST-OK | dromaeo_css | took 1112987ms 20:18:57 INFO - TEST-START | kraken 20:18:57 INFO - operating with platform_type : linux_ 20:18:57 INFO - Initialising browser for kraken test... 20:18:57 INFO - TEST-INFO | started process 27921 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgwT20S/profile http://localhost:51464/getInfo.html) 20:19:01 INFO - PROCESS | 27921 | __metrics Screen width/height:1600/1200 20:19:01 INFO - PROCESS | 27921 | colorDepth:24 20:19:01 INFO - PROCESS | 27921 | Browser inner width/height: 1024/697 20:19:01 INFO - PROCESS | 27921 | __metrics 20:19:01 INFO - PROCESS | 27921 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:19:01 INFO - PROCESS | 27921 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:19:02 INFO - TEST-INFO | 27921: exit 0 20:19:02 INFO - Browser initialized. 20:19:02 INFO - Running cycle 1/1 for kraken test... 20:19:02 INFO - TEST-INFO | started process 28005 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgwT20S/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:19:14 INFO - PROCESS | 28005 | RSS: Main: 149299200 20:19:14 INFO - PROCESS | 28005 | 20:19:17 INFO - PROCESS | 28005 | Cycle 1(1): loaded http://localhost:51464/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51464/tests/kraken/driver.html?testName=audio-beat-detection) 20:19:17 INFO - PROCESS | 28005 | RSS: Main: 185634816 20:19:17 INFO - PROCESS | 28005 | 20:19:20 INFO - PROCESS | 28005 | Cycle 1(1): loaded http://localhost:51464/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51464/tests/kraken/driver.html?testName=audio-dft) 20:19:20 INFO - PROCESS | 28005 | RSS: Main: 175665152 20:19:20 INFO - PROCESS | 28005 | 20:19:23 INFO - PROCESS | 28005 | Cycle 1(1): loaded http://localhost:51464/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51464/tests/kraken/driver.html?testName=audio-fft) 20:19:24 INFO - PROCESS | 28005 | RSS: Main: 160854016 20:19:24 INFO - PROCESS | 28005 | 20:19:26 INFO - PROCESS | 28005 | Cycle 1(1): loaded http://localhost:51464/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51464/tests/kraken/driver.html?testName=audio-oscillator) 20:19:26 INFO - PROCESS | 28005 | RSS: Main: 162676736 20:19:26 INFO - PROCESS | 28005 | 20:19:29 INFO - PROCESS | 28005 | Cycle 1(1): loaded http://localhost:51464/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51464/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:19:29 INFO - PROCESS | 28005 | RSS: Main: 164069376 20:19:29 INFO - PROCESS | 28005 | 20:19:32 INFO - PROCESS | 28005 | Cycle 1(1): loaded http://localhost:51464/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51464/tests/kraken/driver.html?testName=imaging-darkroom) 20:19:33 INFO - PROCESS | 28005 | RSS: Main: 165658624 20:19:33 INFO - PROCESS | 28005 | 20:19:36 INFO - PROCESS | 28005 | Cycle 1(1): loaded http://localhost:51464/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51464/tests/kraken/driver.html?testName=imaging-desaturate) 20:19:37 INFO - PROCESS | 28005 | RSS: Main: 166195200 20:19:37 INFO - PROCESS | 28005 | 20:19:39 INFO - PROCESS | 28005 | Cycle 1(1): loaded http://localhost:51464/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51464/tests/kraken/driver.html?testName=json-parse-financial) 20:19:40 INFO - PROCESS | 28005 | RSS: Main: 166998016 20:19:40 INFO - PROCESS | 28005 | 20:19:42 INFO - PROCESS | 28005 | Cycle 1(1): loaded http://localhost:51464/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51464/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:19:42 INFO - PROCESS | 28005 | RSS: Main: 176164864 20:19:42 INFO - PROCESS | 28005 | 20:19:44 INFO - PROCESS | 28005 | Cycle 1(1): loaded http://localhost:51464/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51464/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:19:44 INFO - PROCESS | 28005 | RSS: Main: 174833664 20:19:44 INFO - PROCESS | 28005 | 20:19:47 INFO - PROCESS | 28005 | Cycle 1(1): loaded http://localhost:51464/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51464/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:19:47 INFO - PROCESS | 28005 | RSS: Main: 188145664 20:19:47 INFO - PROCESS | 28005 | 20:19:49 INFO - PROCESS | 28005 | Cycle 1(1): loaded http://localhost:51464/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51464/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:19:50 INFO - PROCESS | 28005 | RSS: Main: 192188416 20:19:50 INFO - PROCESS | 28005 | 20:19:53 INFO - PROCESS | 28005 | Cycle 1(1): loaded http://localhost:51464/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51464/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:19:53 INFO - PROCESS | 28005 | RSS: Main: 190828544 20:19:53 INFO - PROCESS | 28005 | 20:19:55 INFO - PROCESS | 28005 | Cycle 1(1): loaded http://localhost:51464/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51464/tests/kraken/driver.html?testName=ai-astar) 20:19:55 INFO - PROCESS | 28005 | RSS: Main: 248950784 20:19:55 INFO - PROCESS | 28005 | 20:19:55 INFO - PROCESS | 28005 | __start_tp_report 20:19:55 INFO - PROCESS | 28005 | _x_x_mozilla_page_load 20:19:55 INFO - PROCESS | 28005 | _x_x_mozilla_page_load_details 20:19:55 INFO - PROCESS | 28005 | |i|pagename|runs| 20:19:55 INFO - PROCESS | 28005 | |0;ai-astar;110;110;106;110;111;111;99;112;111;110 20:19:55 INFO - PROCESS | 28005 | |1;audio-beat-detection;149;125;152;165;127;152;158;129;165;124 20:19:55 INFO - PROCESS | 28005 | |2;audio-dft;162;162;161;163;161;161;160;163;163;162 20:19:55 INFO - PROCESS | 28005 | |3;audio-fft;76;73;83;92;73;75;72;115;103;74 20:19:55 INFO - PROCESS | 28005 | |4;audio-oscillator;97;96;145;95;96;96;143;96;96;138 20:19:55 INFO - PROCESS | 28005 | |5;imaging-gaussian-blur;109;110;109;109;110;110;110;109;109;109 20:19:55 INFO - PROCESS | 28005 | |6;imaging-darkroom;149;148;148;147;148;148;149;149;148;146 20:19:55 INFO - PROCESS | 28005 | |7;imaging-desaturate;96;96;96;97;96;96;96;96;96;96 20:19:55 INFO - PROCESS | 28005 | |8;json-parse-financial;57;55;55;55;55;55;56;64;53;52 20:19:55 INFO - PROCESS | 28005 | |9;json-stringify-tinderbox;67;67;67;67;67;68;68;67;67;67 20:19:55 INFO - PROCESS | 28005 | |10;stanford-crypto-aes;85;86;86;85;86;86;86;88;86;86 20:19:55 INFO - PROCESS | 28005 | |11;stanford-crypto-ccm;122;119;116;114;115;118;123;117;115;123 20:19:55 INFO - PROCESS | 28005 | |12;stanford-crypto-pbkdf2;144;145;154;159;151;140;151;153;152;142 20:19:55 INFO - PROCESS | 28005 | |13;stanford-crypto-sha256-iterative;71;72;69;70;68;67;67;68;69;68 20:19:55 INFO - PROCESS | 28005 | __end_tp_report 20:19:55 INFO - PROCESS | 28005 | __start_cc_report 20:19:55 INFO - PROCESS | 28005 | _x_x_mozilla_cycle_collect,950 20:19:55 INFO - PROCESS | 28005 | __end_cc_report 20:19:55 INFO - PROCESS | 28005 | __startTimestamp1452399595681__endTimestamp 20:19:55 INFO - PROCESS | 28005 | 20:19:55 INFO - PROCESS | 28005 | ------- Summary: start ------- 20:19:55 INFO - PROCESS | 28005 | Number of tests: 14 20:19:55 INFO - PROCESS | 28005 | 20:19:55 INFO - PROCESS | 28005 | [#0] ai-astar Cycles:10 Average:109.00 Median:111.00 stddev:3.86 (3.5%) stddev-sans-first:4.08 20:19:55 INFO - PROCESS | 28005 | Values: 110.0 110.0 106.0 110.0 111.0 111.0 99.0 112.0 111.0 110.0 20:19:55 INFO - PROCESS | 28005 | 20:19:55 INFO - PROCESS | 28005 | [#1] audio-beat-detection Cycles:10 Average:144.60 Median:152.00 stddev:16.67 (11.0%) stddev-sans-first:17.61 20:19:55 INFO - PROCESS | 28005 | Values: 149.0 125.0 152.0 165.0 127.0 152.0 158.0 129.0 165.0 124.0 20:19:55 INFO - PROCESS | 28005 | 20:19:55 INFO - PROCESS | 28005 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.03 (0.6%) stddev-sans-first:1.09 20:19:55 INFO - PROCESS | 28005 | Values: 162.0 162.0 161.0 163.0 161.0 161.0 160.0 163.0 163.0 162.0 20:19:55 INFO - PROCESS | 28005 | 20:19:55 INFO - PROCESS | 28005 | [#3] audio-fft Cycles:10 Average:83.60 Median:74.50 stddev:14.97 (20.1%) stddev-sans-first:15.62 20:19:55 INFO - PROCESS | 28005 | Values: 76.0 73.0 83.0 92.0 73.0 75.0 72.0 115.0 103.0 74.0 20:19:55 INFO - PROCESS | 28005 | 20:19:55 INFO - PROCESS | 28005 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:96.00 stddev:22.29 (23.2%) stddev-sans-first:23.16 20:19:55 INFO - PROCESS | 28005 | Values: 97.0 96.0 145.0 95.0 96.0 96.0 143.0 96.0 96.0 138.0 20:19:55 INFO - PROCESS | 28005 | 20:19:55 INFO - PROCESS | 28005 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 20:19:55 INFO - PROCESS | 28005 | Values: 109.0 110.0 109.0 109.0 110.0 110.0 110.0 109.0 109.0 109.0 20:19:55 INFO - PROCESS | 28005 | 20:19:55 INFO - PROCESS | 28005 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 20:19:55 INFO - PROCESS | 28005 | Values: 149.0 148.0 148.0 147.0 148.0 148.0 149.0 149.0 148.0 146.0 20:19:55 INFO - PROCESS | 28005 | 20:19:55 INFO - PROCESS | 28005 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 20:19:55 INFO - PROCESS | 28005 | Values: 96.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 20:19:55 INFO - PROCESS | 28005 | 20:19:55 INFO - PROCESS | 28005 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:55.00 stddev:3.23 (5.9%) stddev-sans-first:3.40 20:19:55 INFO - PROCESS | 28005 | Values: 57.0 55.0 55.0 55.0 55.0 55.0 56.0 64.0 53.0 52.0 20:19:55 INFO - PROCESS | 28005 | 20:19:55 INFO - PROCESS | 28005 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 20:19:55 INFO - PROCESS | 28005 | Values: 67.0 67.0 67.0 67.0 67.0 68.0 68.0 67.0 67.0 67.0 20:19:55 INFO - PROCESS | 28005 | 20:19:55 INFO - PROCESS | 28005 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:86.00 stddev:0.82 (0.9%) stddev-sans-first:0.78 20:19:55 INFO - PROCESS | 28005 | Values: 85.0 86.0 86.0 85.0 86.0 86.0 86.0 88.0 86.0 86.0 20:19:55 INFO - PROCESS | 28005 | 20:19:55 INFO - PROCESS | 28005 | [#11] stanford-crypto-ccm Cycles:10 Average:118.20 Median:118.50 stddev:3.43 (2.9%) stddev-sans-first:3.35 20:19:55 INFO - PROCESS | 28005 | Values: 122.0 119.0 116.0 114.0 115.0 118.0 123.0 117.0 115.0 123.0 20:19:55 INFO - PROCESS | 28005 | 20:19:55 INFO - PROCESS | 28005 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.10 Median:151.50 stddev:6.05 (4.0%) stddev-sans-first:6.12 20:19:55 INFO - PROCESS | 28005 | Values: 144.0 145.0 154.0 159.0 151.0 140.0 151.0 153.0 152.0 142.0 20:19:55 INFO - PROCESS | 28005 | 20:19:55 INFO - PROCESS | 28005 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:1.66 (2.4%) stddev-sans-first:1.58 20:19:55 INFO - PROCESS | 28005 | Values: 71.0 72.0 69.0 70.0 68.0 67.0 67.0 68.0 69.0 68.0 20:19:55 INFO - PROCESS | 28005 | -------- Summary: end -------- 20:19:55 INFO - PROCESS | 28005 | 20:19:56 INFO - TEST-INFO | 28005: exit 0 20:19:56 INFO - TEST-OK | kraken | took 58978ms 20:19:56 INFO - TEST-START | v8_7 20:19:56 INFO - operating with platform_type : linux_ 20:19:56 INFO - Initialising browser for v8_7 test... 20:19:56 INFO - TEST-INFO | started process 28253 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmps9T3HF/profile http://localhost:51464/getInfo.html) 20:20:00 INFO - PROCESS | 28253 | __metrics Screen width/height:1600/1200 20:20:00 INFO - PROCESS | 28253 | colorDepth:24 20:20:00 INFO - PROCESS | 28253 | Browser inner width/height: 1024/697 20:20:00 INFO - PROCESS | 28253 | __metrics 20:20:00 INFO - PROCESS | 28253 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:20:00 INFO - PROCESS | 28253 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:20:01 INFO - TEST-INFO | 28253: exit 0 20:20:01 INFO - Browser initialized. 20:20:01 INFO - Running cycle 1/1 for v8_7 test... 20:20:01 INFO - TEST-INFO | started process 28338 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmps9T3HF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:20:13 INFO - PROCESS | 28338 | RSS: Main: 149180416 20:20:13 INFO - PROCESS | 28338 | 20:20:35 INFO - PROCESS | 28338 | Cycle 1(1): loaded http://localhost:51464/tests/v8_7/run.html (next: http://localhost:51464/tests/v8_7/run.html) 20:20:36 INFO - PROCESS | 28338 | RSS: Main: 570097664 20:20:36 INFO - PROCESS | 28338 | 20:20:36 INFO - PROCESS | 28338 | __start_tp_report 20:20:36 INFO - PROCESS | 28338 | _x_x_mozilla_page_load 20:20:36 INFO - PROCESS | 28338 | _x_x_mozilla_page_load_details 20:20:36 INFO - PROCESS | 28338 | |i|pagename|runs| 20:20:36 INFO - PROCESS | 28338 | |0;Richards;168.0672268907563 20:20:36 INFO - PROCESS | 28338 | |1;DeltaBlue;192.93845263360987 20:20:36 INFO - PROCESS | 28338 | |2;Encrypt;284.57598178713715 20:20:36 INFO - PROCESS | 28338 | |3;Decrypt;5170.103092783505 20:20:36 INFO - PROCESS | 28338 | |4;RayTrace;1930.635838150289 20:20:36 INFO - PROCESS | 28338 | |5;Earley;797.4481658692185 20:20:36 INFO - PROCESS | 28338 | |6;Boyer;12060.240963855422 20:20:36 INFO - PROCESS | 28338 | |7;RegExp;42916.666666666664 20:20:36 INFO - PROCESS | 28338 | |8;Splay;594.4345766725874 20:20:36 INFO - PROCESS | 28338 | |9;NavierStokes;4835.748792270531 20:20:36 INFO - PROCESS | 28338 | __end_tp_report 20:20:36 INFO - PROCESS | 28338 | __startTimestamp1452399636248__endTimestamp 20:20:36 INFO - PROCESS | 28338 | 20:20:36 INFO - PROCESS | 28338 | ------- Summary: start ------- 20:20:36 INFO - PROCESS | 28338 | Number of tests: 10 20:20:36 INFO - PROCESS | 28338 | 20:20:36 INFO - PROCESS | 28338 | [#0] Richards Cycles:1 Average:168.07 Median:168.07 stddev:0.00 (0.0%) 20:20:36 INFO - PROCESS | 28338 | Values: 168.1 20:20:36 INFO - PROCESS | 28338 | 20:20:36 INFO - PROCESS | 28338 | [#1] DeltaBlue Cycles:1 Average:192.94 Median:192.94 stddev:0.00 (0.0%) 20:20:36 INFO - PROCESS | 28338 | Values: 192.9 20:20:36 INFO - PROCESS | 28338 | 20:20:36 INFO - PROCESS | 28338 | [#2] Encrypt Cycles:1 Average:284.58 Median:284.58 stddev:0.00 (0.0%) 20:20:36 INFO - PROCESS | 28338 | Values: 284.6 20:20:36 INFO - PROCESS | 28338 | 20:20:36 INFO - PROCESS | 28338 | [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 20:20:36 INFO - PROCESS | 28338 | Values: 5170.1 20:20:36 INFO - PROCESS | 28338 | 20:20:36 INFO - PROCESS | 28338 | [#4] RayTrace Cycles:1 Average:1930.64 Median:1930.64 stddev:0.00 (0.0%) 20:20:36 INFO - PROCESS | 28338 | Values: 1930.6 20:20:36 INFO - PROCESS | 28338 | 20:20:36 INFO - PROCESS | 28338 | [#5] Earley Cycles:1 Average:797.45 Median:797.45 stddev:0.00 (0.0%) 20:20:36 INFO - PROCESS | 28338 | Values: 797.4 20:20:36 INFO - PROCESS | 28338 | 20:20:36 INFO - PROCESS | 28338 | [#6] Boyer Cycles:1 Average:12060.24 Median:12060.24 stddev:0.00 (0.0%) 20:20:36 INFO - PROCESS | 28338 | Values: 12060.2 20:20:36 INFO - PROCESS | 28338 | 20:20:36 INFO - PROCESS | 28338 | [#7] RegExp Cycles:1 Average:42916.67 Median:42916.67 stddev:0.00 (0.0%) 20:20:36 INFO - PROCESS | 28338 | Values: 42916.7 20:20:36 INFO - PROCESS | 28338 | 20:20:36 INFO - PROCESS | 28338 | [#8] Splay Cycles:1 Average:594.43 Median:594.43 stddev:0.00 (0.0%) 20:20:36 INFO - PROCESS | 28338 | Values: 594.4 20:20:36 INFO - PROCESS | 28338 | 20:20:36 INFO - PROCESS | 28338 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 20:20:36 INFO - PROCESS | 28338 | Values: 4835.7 20:20:36 INFO - PROCESS | 28338 | -------- Summary: end -------- 20:20:36 INFO - PROCESS | 28338 | 20:20:37 INFO - TEST-INFO | 28338: exit 0 20:20:37 INFO - TEST-OK | v8_7 | took 40534ms 20:20:37 INFO - SUITE-END | took 1212s 20:20:37 INFO - Completed test suite (00:20:12) 20:20:37 INFO - Working with test: dromaeo_css 20:20:37 INFO - Generating results file: dromaeo_css 20:20:37 INFO - Working with test: kraken 20:20:37 INFO - Generating results file: kraken 20:20:37 INFO - javascript benchmark 20:20:37 INFO - Working with test: v8_7 20:20:37 INFO - Generating results file: v8_7 20:20:37 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:20:37 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 20:20:37 INFO - process_Request line: dromaeo_css 6746.02 graph.html#tests=[[72,64,35]] 20:20:37 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:20:37 INFO - process_Request line: kraken 1507.40 graph.html#tests=[[232,64,35]] 20:20:37 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:20:37 INFO - process_Request line: v8_7 18888.48 graph.html#tests=[[230,64,35]] 20:20:37 INFO - RETURN: dromaeo_css: 6746.02 20:20:37 INFO - RETURN: kraken: 1507.40 20:20:37 INFO - RETURN: v8_7: 18888.48 20:20:37 INFO - javascript benchmark 20:20:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3091.8608662610186, 3170.4768713162302, 3197.280611862331, 3207.390595786802, 3222.9033129006125, 5060.6963582185, 5182.637215394914, 5186.948130518694, 5230.398504172022, 5268.552173065289, 5095.8216462423825, 5172.508611681884, 5221.503957124077, 5254.553362964152, 5267.762950667219, 4721.291806229067, 4732.645051621143, 4762.190427627312, 4767.475577686451, 4785.186518291881, 4877.658563900528, 4878.853634390974, 4891.241857512091, 4907.190313598252, 4914.164592019365, 4620.283856002291, 4653.6044436222965, 4717.858464246044, 4768.690035147704, 4819.180739274332, 4744.715317080986, 4754.144254034272, 4777.713337199779, 4781.904361912742, 4838.346823178897, 4712.198926182557, 4719.362886010379, 4719.905601887977, 4728.4798672146035, 4729.219678753002, 4895.559399654048, 5013.724245166514, 5054.898902021939, 5089.592832573385, 5173.068847607429, 5475.808346707846, 5478.150886612581, 5487.588430867661, 5494.835154945358, 5495.835124946258, 5514.117741161435, 5526.226328314039, 5534.0, 5538.335399752015, 5539.169124631298, 5025.0, 5119.897602047976, 5134.332536770234, 5161.870953226199, 5267.894642107213, 5641.633293835969, 5643.548516118701, 5647.209390685307, 5648.774049037993, 5697.230873832063, 5443.618946673774, 5450.781968721207, 5452.454754524595, 5455.972720136453, 5464.836054918359, 5425.159100339453, 5489.1217405214975, 5517.806876759374, 5529.834104976777, 5584.91622625661, 5605.607607467438, 5609.411011843697, 5611.719414029364, 5614.354349249807, 5640.210370548127, 5546.084895992116, 5591.440855914458, 5593.972030139823, 5605.915911261334, 5613.242212301287, 4171.186618609342, 4258.488981322261, 4261.957380426218, 4372.431583894074, 4406.449193850769, 3812.8284227209288, 3874.806259687061, 3885.106425522089, 3896.201278737852, 3906.0820707133803, 5058.418281897555, 5083.288339632454, 5084.8220312288895, 5085.237214417867, 5131.692098474104, 5451.64564303319, 5455.8363249102595, 5456.317960254968, 5459.071957767189, 5507.118860982224, 4963.8014479421145, 5010.448850626428, 5040.899182016339, 5048.899022019539, 5063.822766203165, 4752.263399173134, 4785.0, 4788.688735232199, 4817.349657796152, 4830.6135509159885, 5679.574031947621, 5703.0, 5729.1119876419225, 5729.512991395694, 5778.930897783839, 5341.65279256847, 5459.481349271813, 5459.808906688247, 5528.115501519737, 5535.640183388067, 5649.943500564942, 5654.095344744821, 5681.715914204356, 5687.715614219355, 5757.769689212385, 5428.56571474289, 5429.918551221655, 5441.5102640762525, 5449.264349312792, 5465.508104270635, 5423.810166644149, 5473.425290344457, 5526.585506086979, 5532.695701736443, 5574.191742197439, 5400.162974738922, 5423.864403389947, 5436.836894893159, 5487.4238204987905, 5514.944850551604, 5380.70406127651, 5406.7837286509675, 5430.782768689208, 5432.864178395572, 5433.782648694008, 5151.995360904588, 5312.574994000393, 5352.5450336721815, 5359.892802144013, 5410.918836217381, 5364.678119312854, 5389.75746091419, 5425.782968681367, 5472.50747432733, 5527.668339899619, 5325.414204437431, 5330.200469929387, 5331.920021199763, 5336.039512887717, 5376.784928602812], "unit": "score", "name": "dojo.html", "value": 5111.89404538184}, {"lowerIsBetter": false, "replicates": [532.9706866122362, 536.5064140990291, 538.7764077907668, 554.9556035517159, 558.8938101760667, 27434.17697469074, 28183.57724634132, 35756.284874302495, 35815.64184358159, 35945.46081808775, 38753.8062309688, 39340.606593934055, 39385.40921886174, 39452.80273598635, 39471.21057578854, 7273.7090516379285, 7393.03890494235, 8228.753137405873, 8414.747557573282, 8440.493570385766, 9889.06053924876, 10076.294659373847, 10150.949245253763, 10157.0, 10160.136388406994, 9899.604015839357, 9942.403455792639, 9995.100440960312, 9997.450140242283, 10003.59985600575, 7403.962980185119, 7621.628106940749, 7630.542167469969, 7637.579933103677, 9811.264155188353, 9804.90195098047, 10111.747206319827, 10117.494125293779, 10122.696319110439, 10123.341982771097, 35772.642273577454, 35873.46189807155, 36105.277894442224, 36215.64598301102, 36217.09457263589, 3188.4260833050043, 3352.8491217895007, 3393.0499460151195, 3462.480627905809, 3971.5631280559114, 27479.587806182924, 27515.58726619102, 27644.447111057867, 30981.380372392425, 31078.756849725985, 3653.2328211075705, 3686.686631636314, 3723.94414083789, 3743.2326373093724, 3836.808159592037, 267087.0, 268344.0, 268835.999999998, 269067.0, 269345.0, 49814.50185498171, 50243.24635130476, 56018.719906400205, 56627.0, 57677.134842977386, 51216.74391628018, 51429.0, 51631.48368516342, 51703.48296516987, 51704.48295517072, 14194.148351098967, 14213.289335533182, 14262.3581938813, 14322.355494002795, 14336.856631433553, 11446.427678616035, 11544.826827597424, 11546.884531154581, 11557.826632600518, 11680.182387232982, 18717.0, 18993.62012759737, 18999.62000759977, 19014.71477927832, 19036.33372831944, 7031.332023457763, 7294.307040831112, 7353.911357229977, 7377.4098072155175, 7450.2061726852435, 918.912703293186, 921.3596550397409, 923.6905636611676, 1014.031599822168, 1056.730533713898, 27902.86048569785, 28652.283692907426, 28989.0, 29054.418911621648, 29187.7081229185, 1004.6232662751469, 1043.139409986764, 1043.5617040842865, 1125.4918409331535, 1148.0, 12763.872851151342, 13014.0, 13340.533081342106, 13432.865671343357, 13578.93210533941, 319297.0, 320453.0, 321914.0, 322294.0, 323642.0, 49896.50103498918, 50043.0, 50142.0, 50188.498115019116, 50252.0, 1175.9941200293945, 1324.6953200763878, 1344.946202151903, 1348.92580908051, 1359.3746876436753, 19343.0, 25741.742582573934, 26477.33806654772, 26500.337491562095, 26571.0, 43622.12755744804, 44127.558724412345, 44243.0, 44245.0, 44250.0, 226327.0, 227757.0, 227764.0, 290480.0, 293822.0, 29984.102066731186, 30065.091538099907, 30243.395132097674, 30431.391372172875, 30613.08160755181, 34402.48396274008, 35397.64602354047, 35469.29061418809, 35795.284094318486, 35818.0, 30208.5468717965, 30941.226469338446, 31306.217344565655, 31683.52474712927, 31793.841030795622, 32642.673573263964, 32723.401291503775, 33036.834815825765, 33512.32975340431, 33549.832250839565, 31994.840025799724, 32526.512102318957, 32782.34435311233, 32817.0, 32824.671753282164, 29093.85453072721, 29665.11004669863, 30117.548236776027, 30315.0, 30488.390232195674, 24106.63840042436, 24781.50436991214, 24853.130140445, 24904.75095249024, 25085.122020729188], "unit": "score", "name": "ext.html", "value": 17567.38502066332}, {"lowerIsBetter": false, "replicates": [348.9808060556669, 351.9384107781138, 352.04595546070146, 352.30419920656703, 353.30928035690226, 13349.866501334984, 13908.0, 15859.0, 16020.59948501288, 16989.999999999985, 15197.848021519781, 15275.923620381882, 15846.524604261862, 15899.761503577427, 15902.363905443797, 5022.623303252261, 5123.948760512384, 5298.867528311804, 5324.54741346986, 5329.467053294678, 3707.1658876752786, 3891.0855948851995, 5203.68777873327, 5320.920186197211, 5519.116941289394, 5473.945260547403, 5493.176023596453, 5499.395066542677, 5530.004599172147, 5530.032244357241, 5885.176075349433, 5913.645181289094, 5917.0, 5923.881522369572, 5927.110933360009, 5104.540591346759, 5278.894422111536, 5349.679019258818, 5354.973225133888, 5360.785568577252, 12533.122681412306, 12824.422900969479, 12898.161619494704, 12993.350332483433, 13027.218366898016, 2045.1103769860158, 2100.7479102507646, 2215.4793623498463, 2303.2974942642486, 2437.244454219198, 9162.221211197057, 9608.95195524018, 9630.18143457807, 11202.159838012181, 12436.0, 1780.9643807123784, 1857.3963461874944, 1881.2380985700813, 1898.2596787252983, 1922.2503223742751, 49243.0, 49456.25815612769, 53016.73491632517, 54876.0, 56011.15983260254, 9349.439033657865, 9594.376365536218, 9746.0, 9760.511974401394, 9852.0, 12579.245245285128, 12595.559155429515, 12635.494580216871, 12635.557755478514, 12687.555935542212, 7051.048108505389, 7130.928690713026, 7136.357727804522, 7160.498765086498, 7207.747728829466, 6849.897251541231, 6849.931500685029, 6857.211420686585, 6910.2053263874295, 6910.412614927787, 4336.522982471925, 4380.518143004267, 4390.714603550759, 4417.2269852775635, 4419.558044195554, 1732.2464727843428, 1770.2653398839338, 1796.5059608607737, 1844.6771814932333, 1845.455590600776, 449.4112712346836, 450.8106595230011, 865.7922098696267, 973.250597040275, 1007.2093406675724, 9320.229156460251, 10356.533955972, 10821.0, 10974.835377469344, 11489.253198542068, 476.86030387374205, 890.9866352004725, 948.2982592881356, 957.6696039866374, 995.5370752600076, 8683.2185103341, 8906.332025098143, 8997.505137217517, 9075.50084745332, 9620.95189524048, 469323.0, 504462.0, 539182.0, 557125.0, 557531.0, 42626.14747705028, 42765.14469710588, 52694.94610107853, 66564.0, 69451.0, 1170.5434880396651, 1179.180469573638, 1179.2629606495768, 1202.6211743300832, 1212.4301578258205, 13819.447222111003, 14464.421423143378, 14897.404103835725, 14980.1011939284, 15284.541463756104, 29018.0, 29146.854265728536, 29390.0, 29850.0, 30027.849860750557, 38419.615803842724, 38940.610593893696, 39362.2127557453, 39442.40836387399, 39536.209275813744, 3016.909492715222, 6987.790366289019, 7198.7840364789145, 7198.820029499305, 7238.782836514913, 10526.473676316, 10890.29213101146, 10996.0, 11076.889231107585, 11462.312261264351, 8728.956355218183, 9370.625174992923, 9736.513174341397, 9771.169450596779, 9786.41281523111, 9123.452592844451, 9386.624535018524, 9525.333226674065, 9528.904710952802, 9723.222142228464, 8722.607482663423, 9211.447313161232, 9726.221902247662, 9932.900670993198, 10052.748681283027, 7171.533850299714, 7174.1032370953635, 7275.890861636974, 7350.926490735024, 7363.41092712571, 7441.0010083597945, 7806.960965195365, 9814.901850981685, 9850.636945827357, 10082.899171008195], "unit": "score", "name": "jquery.html", "value": 7660.783754904349}, {"lowerIsBetter": false, "replicates": [1331.926744029078, 1444.7905053767204, 1448.6450819549211, 1611.1541440743608, 1796.2994432171456, 7154.534955227907, 7669.309762121415, 7825.256600622946, 7826.804329891748, 7858.253465920729, 7732.497387669811, 7906.130325664187, 7919.208079192093, 7925.445218834684, 7933.246341597539, 2071.0369678099682, 2115.048228297265, 2283.7602051784575, 2358.7641235876445, 2383.5471260460545, 2288.5079707862806, 2295.2196253273883, 2298.8505747126383, 2305.262316058862, 2307.9884600577057, 2269.920552780653, 2330.627099664054, 2334.5914464968646, 2334.871582062986, 2336.8013718833836, 2305.8501197422115, 2338.333574931145, 2359.1153317505937, 2359.7758212969825, 2360.5042940982416, 2307.5154217614154, 2318.2929206591984, 2351.823613229015, 2354.9175778847657, 2372.905083796646, 7948.642311095957, 8000.959995199987, 8018.879716804253, 8019.558924259163, 8024.799380015488, 4665.580097791181, 4792.472827988919, 4793.424789025305, 4804.25534042224, 4809.951900480985, 3245.675432456759, 3259.837008149607, 3321.8173000484962, 3407.5910890693026, 3425.246445781924, 1046.7540128069897, 1056.646023582101, 1062.7343164208949, 1088.390501319256, 1089.580511503077, 11320.377379244139, 11349.602763903224, 11389.373584452851, 11393.08855291583, 11399.202055856093, 4523.864284071483, 4548.840790572314, 4576.565226303496, 4588.26587745959, 4604.838830640979, 9586.185174260127, 9609.135177834029, 9631.614735410645, 9642.0, 9655.275854310954, 5088.847334579968, 5091.2363145527725, 5097.311862898461, 5099.133147364957, 5099.87250318745, 4558.9772051139535, 4637.397138372057, 4644.465886423104, 4648.558386953234, 4650.534946505322, 3559.430491121408, 3612.3497770401054, 3619.1494998675817, 3622.6558476944647, 3805.391137418055, 1142.3431526871916, 1201.1051766434064, 1218.975620487603, 1238.3003602964297, 1243.104964425612, 996.9800603988025, 1012.3166862367872, 1012.8126296635146, 1122.7754449110212, 1330.255057167989, 7232.710691572383, 7259.637018149071, 7297.306755858185, 7300.96349518249, 7310.086239220098, 1107.7839821234943, 1123.4944275076248, 1131.4569006876582, 1145.68493664243, 1149.4712432281244, 5769.826905192851, 5833.241678581757, 5835.591508594358, 5838.241028666246, 5847.8245652630485, 9251.259899208047, 9400.341976061747, 9413.905860941302, 9532.142107210384, 9573.090556397132, 9312.906870931203, 9386.296027797942, 9418.529073546433, 9441.952790236142, 9447.905520944703, 7274.381677557467, 7478.476506644592, 7481.364084052808, 7560.810979725551, 7562.432817538706, 7089.929100708927, 7091.326323999212, 7152.892706609301, 7172.462065345225, 7172.605506697182, 8155.388345873965, 8247.0928197897, 8463.830723385374, 8469.153084691729, 8476.06763256029, 8512.40413171072, 8525.573721314033, 8570.442921210102, 8613.69852055175, 8621.224089831945, 7286.48994570375, 7413.221611730906, 7420.5547667140145, 7429.8142546436775, 7431.442641801778, 7402.777916662509, 7763.961180194289, 7842.372610191285, 7849.803754906173, 7856.84286314259, 7087.5747455150795, 7225.24134965821, 7266.818329541804, 7307.159676637255, 7392.704291828267, 7084.964575177091, 7121.572705637678, 7140.6786694599905, 7261.891071634035, 7377.631118443949, 7128.358447739728, 7179.066721326194, 7184.137903451619, 7184.640767961686, 7186.784396468114, 6424.839379015562, 6613.107230523818, 6639.734410623521, 6669.666516674244, 6713.395794378529, 6532.183477065367, 6555.2133743951035, 6563.310852360624, 6564.081028656087, 6564.409203171546], "unit": "score", "name": "mootools.html", "value": 4597.772418255247}, {"lowerIsBetter": false, "replicates": [342.79432340595645, 345.95329630499873, 346.7676656640051, 351.71335361680246, 355.95550556180496, 5774.451427114417, 5832.62087964282, 5888.263967004124, 5889.528837692985, 5938.792142275021, 5707.77168913244, 5781.19063331134, 5817.360090390064, 5834.037383831674, 5843.79546715865, 4508.954910450902, 4509.932351014738, 4511.639068874482, 4514.18744625968, 4521.5930566249035, 4373.234683930315, 4448.310511870665, 4472.619827314682, 4510.413646225986, 4576.473705523874, 4530.365748795171, 4534.231649656636, 4535.569120933523, 4551.749653769041, 4558.475775285851, 4511.909761804762, 4529.8641040768825, 4531.184386810372, 4541.0, 4545.5908968193025, 4015.0163210013443, 4020.537638171589, 4022.1955608878047, 4030.4558884550797, 4039.1315867088715, 5419.268398766156, 5574.247476590689, 5592.552595792326, 5644.5484361251, 5654.180143879114, 5336.946630533684, 5343.412224655285, 5350.143976963667, 5350.411454739976, 5353.678779273256, 5977.193078934331, 6265.185525881606, 6283.937160628381, 6290.811275661737, 6294.244690637152, 4341.978290108561, 4364.541723119059, 4410.360497727812, 4447.911041779146, 4476.127155204704, 6423.42189202974, 6465.579737317059, 6506.674666266667, 6507.381798729113, 6536.0, 4590.67865249436, 4592.334111553806, 4601.654875884322, 4603.769811509411, 4604.30935359692, 4567.36056952027, 4639.072185562901, 4659.068186362741, 4665.0903073900945, 4680.765961701902, 5247.790088396421, 5256.842294731164, 5273.1035723927025, 5285.550728188147, 5312.5218730314455, 6276.46650034743, 6286.591371560834, 6288.245410550763, 6290.308066112724, 6291.433770960635, 1633.1997321312472, 1636.6808472347777, 1649.1094808803352, 1653.9338426463048, 1654.2390500369725, 1126.4030064065894, 1131.3155540897803, 1139.0318229504855, 1148.9425528723698, 1161.1871689817162, 5886.676232807236, 5902.940970590325, 5903.498202652822, 5905.46850783423, 5909.674967876808, 6425.132607098076, 6427.357264273535, 6439.61362318253, 6440.645764482999, 6444.806655800334, 5827.825165245049, 5896.793612223637, 5938.376470470625, 5975.25309336333, 5976.432238937294, 3463.41122009259, 3481.547398838135, 3484.285721427101, 3484.790912545255, 3486.825658717054, 6684.16447944007, 6703.798886033427, 6704.094947182166, 6705.463562914955, 6711.161104861892, 6558.081868538408, 6559.8360040998405, 6560.540762146604, 6564.4420224281475, 6568.310327415648, 6511.413972742381, 6696.5647232929705, 6696.5647232929705, 6701.5308928375525, 6704.061431399608, 6227.813165605039, 6332.240131184103, 6390.808275751735, 6411.871762564816, 6415.422611964946, 6260.248770147611, 6285.842853928689, 6355.841103972438, 6356.555041147075, 6366.586171898812, 6654.83362915931, 6665.200175978914, 6676.9666151668935, 6685.364890335411, 6686.966565167143, 4320.93518597215, 4547.52251013652, 4555.589996900295, 4557.954420455753, 4558.407407037064, 6444.130042444398, 6452.419282264619, 6456.063870738622, 6475.061116138228, 6477.77327793525, 6298.905516417349, 6301.495880329471, 6302.621842689453, 6304.18045654062, 6307.495400368051, 6176.8764624706355, 6209.192804935329, 6285.120083188266, 6291.685415729286, 6296.33888441707, 6095.512359011357, 6104.17593624855, 6105.389461053859, 6107.175531303217, 6138.907916381348, 6293.811185664437, 6294.118823364641, 6301.8109456716375, 6307.432331090224, 6319.96840015797, 6062.666553339609, 6157.907631385443, 6161.199044124235, 6171.043488259147, 6171.259448866164], "unit": "score", "name": "prototype.html", "value": 4752.87803118293}, {"lowerIsBetter": false, "replicates": [832.8922533031069, 846.4286606540584, 851.3274513134623, 861.6940985949988, 865.1002956924799, 13272.668183295411, 13445.394957226923, 13463.528776492825, 13466.394012269458, 13486.0, 12174.756504869898, 12648.810267845967, 12705.555305564307, 12709.936450317758, 12721.745565088693, 663.7510933399975, 673.1820837682216, 816.8121332093607, 831.6465502161587, 832.0, 673.7507122364732, 793.1434051224693, 823.217942954193, 823.320760372695, 823.7446391618618, 843.0894633795486, 848.2281124177, 848.516345682961, 852.4373913217278, 854.0946596607616, 853.8761879527495, 854.4574195385943, 854.4659587757651, 855.5636625321068, 856.9185927336893, 515.6519349439151, 521.5879455230402, 624.3132554190399, 632.4718859752113, 636.6975686548899, 12659.810102848465, 12661.30362830044, 12671.556495522706, 12679.619611411672, 12709.809352859715, 12173.695657608541, 12715.237085774883, 12858.871411285954, 13165.670858228525, 13398.464061437531, 10632.946835265851, 10726.463676816205, 10731.248812583122, 10741.677749667522, 10787.406692631903, 3514.3849826280552, 3566.4115420955513, 3590.8204589770407, 3654.6162652921594, 3656.213914008501, 43487.78256108699, 43599.56400435987, 43688.78155609233, 44074.23703051874, 44208.115837683064, 9901.078867935788, 9978.850317245102, 10181.643642472478, 10453.275209590485, 10563.894361056291, 18533.721994170097, 18562.350317738816, 18585.44243672665, 18596.535086622942, 18612.255509779727, 7570.129435115033, 7662.195469475625, 7662.233776622405, 7685.0, 7839.6472158752995, 4170.0, 4325.199838029975, 4364.061726728769, 4425.690201685916, 4427.977860110679, 3122.2818751686787, 3141.937161256762, 3148.275896543762, 3152.4798408262836, 3153.7003984621424, 564.9096144616842, 571.7512881896388, 574.2219292858117, 582.5281521967136, 596.2487266044815, 515.3583788183736, 642.4667525953447, 647.2200997797643, 659.3406593406594, 692.5221597097986, 8304.128066553047, 8318.542480163649, 8348.15440409362, 8551.871721924175, 8619.267362274277, 623.4918541388754, 646.2051676437914, 654.4469922915129, 672.2840175213382, 678.2911857109234, 3831.8275677594575, 3924.5682974872743, 3973.5430425501436, 4002.239574480839, 4320.373545835899, 50290.497095029314, 50531.0, 58114.4188558109, 59520.70239648774, 59752.701236493536, 45740.0, 46646.5335346649, 46648.300275495894, 49880.50119498831, 50917.49082509201, 43290.13419731588, 46084.308735369, 46282.0, 46345.53654463479, 47128.5287147131, 8343.2908202801, 8538.060813310407, 8693.695720649746, 8736.650533978569, 8925.866112008196, 32309.0, 33473.33053338871, 33926.66073339235, 34375.0, 35662.465063024596, 39257.0, 41239.0, 41567.376489353286, 45185.32222016738, 45400.54599454095, 10800.351978881292, 11008.449577521253, 11017.504212310305, 11064.834027489433, 11219.831702524305, 12225.327606981346, 12257.938710306391, 12329.568465103679, 12338.568150114703, 12467.064970127096, 11266.7746645065, 11324.886751132382, 11367.0, 11580.768384632092, 11980.0, 11434.885651143715, 11595.0, 11654.359010254517, 12022.75954480888, 12023.519059237533, 11072.612458563912, 11158.776824463628, 11284.717882053013, 11685.123615728684, 11834.881651183723, 9360.251179905727, 9609.951950240204, 9618.0, 10002.299839011199, 10056.54745536438, 9318.207952324128, 9833.901660983298, 9842.0, 9862.0, 9868.407895526292], "unit": "score", "name": "yui.html", "value": 6268.812628907212}], "name": "dromaeo_css", "value": 6746.022729161769}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 106.0, 110.0, 111.0, 111.0, 99.0, 112.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [149.0, 125.0, 152.0, 165.0, 127.0, 152.0, 158.0, 129.0, 165.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 144.6}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 163.0, 161.0, 161.0, 160.0, 163.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [76.0, 73.0, 83.0, 92.0, 73.0, 75.0, 72.0, 115.0, 103.0, 74.0], "unit": "score", "name": "audio-fft", "value": 83.6}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 145.0, 95.0, 96.0, 96.0, 143.0, 96.0, 96.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 109.8}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [149.0, 148.0, 148.0, 147.0, 148.0, 148.0, 149.0, 149.0, 148.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 148.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 55.0, 55.0, 55.0, 55.0, 56.0, 64.0, 53.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.7}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 68.0, 68.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 86.0, 85.0, 86.0, 86.0, 86.0, 88.0, 86.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.0}, {"lowerIsBetter": true, "replicates": [122.0, 119.0, 116.0, 114.0, 115.0, 118.0, 123.0, 117.0, 115.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.2}, {"lowerIsBetter": true, "replicates": [144.0, 145.0, 154.0, 159.0, 151.0, 140.0, 151.0, 153.0, 152.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.1}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 69.0, 70.0, 68.0, 67.0, 67.0, 68.0, 69.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1507.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.0672268907563], "unit": "score", "name": "Richards", "value": 210.04689999999997}, {"lowerIsBetter": false, "replicates": [192.93845263360987], "unit": "score", "name": "DeltaBlue", "value": 342.689594}, {"lowerIsBetter": false, "replicates": [284.57598178713715], "unit": "score", "name": "Encrypt", "value": 935.3600340000003}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [1930.635838150289], "unit": "score", "name": "RayTrace", "value": 383.2877155688624}, {"lowerIsBetter": false, "replicates": [797.4481658692185], "unit": "score", "name": "Earley", "value": 835.7446020000003}, {"lowerIsBetter": false, "replicates": [12060.240963855422], "unit": "score", "name": "Boyer", "value": 55.2611678321678}, {"lowerIsBetter": false, "replicates": [42916.666666666664], "unit": "score", "name": "RegExp", "value": 21.22683495145631}, {"lowerIsBetter": false, "replicates": [594.4345766725874], "unit": "score", "name": "Splay", "value": 137.08993924302786}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 18888.477750787613}]} 20:20:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "18888.48"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1507.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6746.02"}}} 20:20:37 INFO - Return code: 0 20:20:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:20:37 INFO - # TBPL SUCCESS # 20:20:37 INFO - Running post-action listener: _resource_record_post_action 20:20:37 INFO - Running post-run listener: _resource_record_post_run 20:20:38 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 8192; Write bytes: 551026688; Read time: 164; Write time: 394616 20:20:38 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 239394816; Read time: 116; Write time: 231320 20:20:38 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 4096; Write bytes: 311631872; Read time: 48; Write time: 163296 20:20:38 INFO - Running post-run listener: _upload_blobber_files 20:20:38 INFO - Blob upload gear active. 20:20:38 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:20:38 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:20:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 20:20:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 20:20:39 INFO - (blobuploader) - INFO - Open directory for files ... 20:20:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 20:20:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:20:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:20:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:20:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:20:40 INFO - (blobuploader) - INFO - Done attempting. 20:20:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:20:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:20:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:20:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:20:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:20:40 INFO - (blobuploader) - INFO - Done attempting. 20:20:40 INFO - (blobuploader) - INFO - Iteration through files over. 20:20:40 INFO - Return code: 0 20:20:40 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:20:40 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:20:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4dc183cfaae083af04da7275c83051bab0986769e6f3e96d4a1d76dfa19cf9fff858bd08086c46773481e2e680a90444fc99231a96d831c6a4a690b9680ecf54", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d47d1e4b0f52ac3f150b5cce4c5afabc04b70e747508b207438b52d80569736bcdc54f4eb886343effd82e0b997ef3ee0169d8f5070e4ecfef308e2f1927e7e9"} 20:20:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:20:40 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:20:40 INFO - Contents: 20:20:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4dc183cfaae083af04da7275c83051bab0986769e6f3e96d4a1d76dfa19cf9fff858bd08086c46773481e2e680a90444fc99231a96d831c6a4a690b9680ecf54", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d47d1e4b0f52ac3f150b5cce4c5afabc04b70e747508b207438b52d80569736bcdc54f4eb886343effd82e0b997ef3ee0169d8f5070e4ecfef308e2f1927e7e9"} 20:20:40 INFO - Copying logs to upload dir... 20:20:40 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1274.002134 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-09 20:20:39.853815) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-09 20:20:39.859186) ========= 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=8887e36bb8e381bfd44124ac000001a8-1452395812.596394-511361455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4dc183cfaae083af04da7275c83051bab0986769e6f3e96d4a1d76dfa19cf9fff858bd08086c46773481e2e680a90444fc99231a96d831c6a4a690b9680ecf54", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d47d1e4b0f52ac3f150b5cce4c5afabc04b70e747508b207438b52d80569736bcdc54f4eb886343effd82e0b997ef3ee0169d8f5070e4ecfef308e2f1927e7e9"} build_url:https://queue.taskcluster.net/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011155 build_url: 'https://queue.taskcluster.net/v1/task/bYYVcR7JTsmIf65ms8Rfyg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4dc183cfaae083af04da7275c83051bab0986769e6f3e96d4a1d76dfa19cf9fff858bd08086c46773481e2e680a90444fc99231a96d831c6a4a690b9680ecf54", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d47d1e4b0f52ac3f150b5cce4c5afabc04b70e747508b207438b52d80569736bcdc54f4eb886343effd82e0b997ef3ee0169d8f5070e4ecfef308e2f1927e7e9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-09 20:20:39.884137) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 20:20:39.884476) ========= 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=8887e36bb8e381bfd44124ac000001a8-1452395812.596394-511361455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004649 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 20:20:39.968552) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-09 20:20:39.968918) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-09 20:20:39.969235) ========= ========= Total master_lag: 0.30 =========