builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-024 starttime: 1451468784.62 results: success (0) buildid: 20151229233007 builduid: 71634069b1c4451bb59ddbef023033e6 revision: 77420c71e0d49620c056cbd4a74cb1e41a891ac5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 01:46:24.618729) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 01:46:24.619303) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 01:46:24.619618) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1451467931.220899-2012922020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006454 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 01:46:24.665655) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 01:46:24.665968) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 01:46:24.765786) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 01:46:24.766065) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1451467931.220899-2012922020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004678 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 01:46:24.816617) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 01:46:24.816921) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 01:46:24.817358) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 01:46:24.817666) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1451467931.220899-2012922020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-30 01:46: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.2M=0s 2015-12-30 01:46:25 (43.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.175377 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 01:46:25.005056) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 01:46:25.005386) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1451467931.220899-2012922020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020205 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 01:46:25.061387) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 01:46:25.061694) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 77420c71e0d49620c056cbd4a74cb1e41a891ac5 --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 77420c71e0d49620c056cbd4a74cb1e41a891ac5 --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=5400c60ebd4f8d7cf28c0934000001b8-1451467931.220899-2012922020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-30 01:46:25,480 truncating revision to first 12 chars 2015-12-30 01:46:25,480 Setting DEBUG logging. 2015-12-30 01:46:25,480 attempt 1/10 2015-12-30 01:46:25,480 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/77420c71e0d4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-30 01:46:25,814 unpacking tar archive at: fx-team-77420c71e0d4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.591655 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 01:46:25.666009) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 01:46:25.666308) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 01:46:25.679778) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 01:46:25.680050) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 01:46:25.680429) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2015-12-30 01:46:25.680700) ========= /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=5400c60ebd4f8d7cf28c0934000001b8-1451467931.220899-2012922020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:46:26 INFO - MultiFileLogger online at 20151230 01:46:26 in /builds/slave/test-pgo 01:46:26 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 01:46:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 01:46:26 INFO - {'append_to_log': False, 01:46:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 01:46:26 INFO - 'blob_upload_branch': 'Fx-Team', 01:46:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 01:46:26 INFO - 'branch': 'Fx-Team', 01:46:26 INFO - 'buildbot_json_path': 'buildprops.json', 01:46:26 INFO - 'config_files': ('talos/linux_config.py',), 01:46:26 INFO - 'default_actions': ('clobber', 01:46:26 INFO - 'read-buildbot-config', 01:46:26 INFO - 'download-and-extract', 01:46:26 INFO - 'populate-webroot', 01:46:26 INFO - 'create-virtualenv', 01:46:26 INFO - 'install', 01:46:26 INFO - 'run-tests'), 01:46:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:46:26 INFO - 'download_minidump_stackwalk': True, 01:46:26 INFO - 'download_symbols': 'ondemand', 01:46:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:46:26 INFO - 'tooltool.py': '/tools/tooltool.py', 01:46:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:46:26 INFO - '/tools/misc-python/virtualenv.py')}, 01:46:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:46:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:46:26 INFO - 'installer_path': 'installer.exe', 01:46:26 INFO - 'log_level': 'info', 01:46:26 INFO - 'log_name': 'talos', 01:46:26 INFO - 'log_to_console': True, 01:46:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:46:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:46:26 INFO - 'opt_config_files': (), 01:46:26 INFO - 'pip_index': False, 01:46:26 INFO - 'sps_profile': False, 01:46:26 INFO - 'sps_profile_interval': 0, 01:46:26 INFO - 'suite': 'dromaeojs', 01:46:26 INFO - 'system_bits': '32', 01:46:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:46:26 INFO - 'title': 'talos-linux64-ix-024', 01:46:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:46:26 INFO - 'use_talos_json': True, 01:46:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 01:46:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:46:26 INFO - 'work_dir': 'build'} 01:46:26 INFO - ##### 01:46:26 INFO - ##### Running clobber step. 01:46:26 INFO - ##### 01:46:26 INFO - Running pre-action listener: _resource_record_pre_action 01:46:26 INFO - Running main action method: clobber 01:46:26 INFO - rmtree: /builds/slave/test-pgo/build 01:46:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 01:46:26 INFO - Running post-action listener: _resource_record_post_action 01:46:26 INFO - ##### 01:46:26 INFO - ##### Running read-buildbot-config step. 01:46:26 INFO - ##### 01:46:26 INFO - Running pre-action listener: _resource_record_pre_action 01:46:26 INFO - Running main action method: read_buildbot_config 01:46:26 INFO - Using buildbot properties: 01:46:26 INFO - { 01:46:26 INFO - "project": "", 01:46:26 INFO - "product": "firefox", 01:46:26 INFO - "script_repo_revision": "production", 01:46:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:46:26 INFO - "repository": "", 01:46:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 01:46:26 INFO - "buildid": "20151229233007", 01:46:26 INFO - "pgo_build": "True", 01:46:26 INFO - "basedir": "/builds/slave/test-pgo", 01:46:26 INFO - "buildnumber": 859, 01:46:26 INFO - "slavename": "talos-linux64-ix-024", 01:46:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:46:26 INFO - "platform": "ubuntu64_hw", 01:46:26 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 01:46:26 INFO - "branch": "fx-team", 01:46:26 INFO - "repo_path": "integration/fx-team", 01:46:26 INFO - "revision": "77420c71e0d49620c056cbd4a74cb1e41a891ac5", 01:46:26 INFO - "stage_platform": "linux64-pgo", 01:46:26 INFO - "builduid": "71634069b1c4451bb59ddbef023033e6", 01:46:26 INFO - "slavebuilddir": "test" 01:46:26 INFO - } 01:46:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/a6SmKlwqTXCQM-iMHV0yxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 01:46:26 INFO - Running post-action listener: _resource_record_post_action 01:46:26 INFO - ##### 01:46:26 INFO - ##### Running download-and-extract step. 01:46:26 INFO - ##### 01:46:26 INFO - Running pre-action listener: _resource_record_pre_action 01:46:26 INFO - Running main action method: download_and_extract 01:46:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 01:46:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:26 INFO - https://queue.taskcluster.net/v1/task/a6SmKlwqTXCQM-iMHV0yxg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:46:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6SmKlwqTXCQM-iMHV0yxg/artifacts/public/build/test_packages.json 01:46:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6SmKlwqTXCQM-iMHV0yxg/artifacts/public/build/test_packages.json 01:46:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6SmKlwqTXCQM-iMHV0yxg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 01:46:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6SmKlwqTXCQM-iMHV0yxg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 01:46:34 INFO - Downloaded 1302 bytes. 01:46:34 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 01:46:34 INFO - Using the following test package requirements: 01:46:34 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:46:34 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:46:34 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:34 INFO - u'jsshell-linux-x86_64.zip'], 01:46:34 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:46:34 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:46:34 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:46:34 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:46:34 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:46:34 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:46:34 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:46:34 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:46:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:34 INFO - https://queue.taskcluster.net/v1/task/a6SmKlwqTXCQM-iMHV0yxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:46:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6SmKlwqTXCQM-iMHV0yxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:46:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6SmKlwqTXCQM-iMHV0yxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:46:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6SmKlwqTXCQM-iMHV0yxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:46:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6SmKlwqTXCQM-iMHV0yxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:46:41 INFO - Downloaded 23192231 bytes. 01:46:41 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 01:46:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:46:41 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 01:46:42 INFO - Return code: 0 01:46:42 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:46: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')]} 01:46:42 INFO - https://queue.taskcluster.net/v1/task/a6SmKlwqTXCQM-iMHV0yxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:46:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6SmKlwqTXCQM-iMHV0yxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:46:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6SmKlwqTXCQM-iMHV0yxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:46:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6SmKlwqTXCQM-iMHV0yxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:46:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6SmKlwqTXCQM-iMHV0yxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:46:46 INFO - Downloaded 23192231 bytes. 01:46:46 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 01:46:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:46:46 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 01:46:48 INFO - Return code: 0 01:46:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:48 INFO - https://queue.taskcluster.net/v1/task/a6SmKlwqTXCQM-iMHV0yxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:46:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6SmKlwqTXCQM-iMHV0yxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:46:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6SmKlwqTXCQM-iMHV0yxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:46:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6SmKlwqTXCQM-iMHV0yxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:46:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6SmKlwqTXCQM-iMHV0yxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:46:48 INFO - Downloaded 11132285 bytes. 01:46:48 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 01:46:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:46:48 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 01:46:49 INFO - Return code: 0 01:46: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')]} 01:46:49 INFO - https://queue.taskcluster.net/v1/task/a6SmKlwqTXCQM-iMHV0yxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:46:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6SmKlwqTXCQM-iMHV0yxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:46:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6SmKlwqTXCQM-iMHV0yxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:46:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6SmKlwqTXCQM-iMHV0yxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:46:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6SmKlwqTXCQM-iMHV0yxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:46:50 INFO - Downloaded 54887124 bytes. 01:46:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a6SmKlwqTXCQM-iMHV0yxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:46:50 INFO - mkdir: /builds/slave/test-pgo/properties 01:46:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 01:46:50 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 01:46:50 INFO - Contents: 01:46:50 INFO - build_url:https://queue.taskcluster.net/v1/task/a6SmKlwqTXCQM-iMHV0yxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:46:50 INFO - Running post-action listener: _resource_record_post_action 01:46:50 INFO - Running post-action listener: set_extra_try_arguments 01:46:50 INFO - ##### 01:46:50 INFO - ##### Running populate-webroot step. 01:46:50 INFO - ##### 01:46:50 INFO - Running pre-action listener: _resource_record_pre_action 01:46:50 INFO - Running main action method: populate_webroot 01:46:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:46:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:46:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:46:50 INFO - '--tppagecycles', 01:46:50 INFO - '7'], 01:46:50 INFO - 'tests': ['tsvgm']}}, 01:46:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:46:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:46:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:46:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:46:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:46:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:46:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:46:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:50 INFO - 'talos_options': ['--e10s'], 01:46:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:46:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:50 INFO - 'tests': ['damp', 'tps']}, 01:46:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:50 INFO - 'talos_options': ['--e10s'], 01:46:50 INFO - 'tests': ['damp', 'tps']}, 01:46:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:46:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:46:50 INFO - 'other': {'tests': ['a11yr', 01:46:50 INFO - 'ts_paint', 01:46:50 INFO - 'tpaint', 01:46:50 INFO - 'sessionrestore', 01:46:50 INFO - 'sessionrestore_no_auto_restore']}, 01:46:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:46:50 INFO - 'tests': ['a11yr', 01:46:50 INFO - 'ts_paint', 01:46:50 INFO - 'tpaint', 01:46:50 INFO - 'sessionrestore', 01:46:50 INFO - 'sessionrestore_no_auto_restore']}, 01:46:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:46:50 INFO - 'tests': ['a11yr', 01:46:50 INFO - 'ts_paint', 01:46:50 INFO - 'tpaint', 01:46:50 INFO - 'sessionrestore', 01:46:50 INFO - 'sessionrestore_no_auto_restore']}, 01:46:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:46:50 INFO - 'tests': ['a11yr', 01:46:50 INFO - 'ts_paint', 01:46:50 INFO - 'tpaint', 01:46:50 INFO - 'sessionrestore', 01:46:50 INFO - 'sessionrestore_no_auto_restore']}, 01:46:50 INFO - 'other_l64': {'tests': ['a11yr', 01:46:50 INFO - 'ts_paint', 01:46:50 INFO - 'tpaint', 01:46:50 INFO - 'sessionrestore', 01:46:50 INFO - 'sessionrestore_no_auto_restore']}, 01:46:50 INFO - 'other_nol64': {'tests': ['a11yr', 01:46:50 INFO - 'ts_paint', 01:46:50 INFO - 'tpaint', 01:46:50 INFO - 'sessionrestore', 01:46:50 INFO - 'sessionrestore_no_auto_restore']}, 01:46:50 INFO - 'svgr': {'tests': ['tsvgx', 01:46:50 INFO - 'tsvgr_opacity', 01:46:50 INFO - 'tart', 01:46:50 INFO - 'tscrollx', 01:46:50 INFO - 'cart']}, 01:46:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:46:50 INFO - 'tests': ['tsvgx', 01:46:50 INFO - 'tsvgr_opacity', 01:46:50 INFO - 'tart', 01:46:50 INFO - 'tscrollx', 01:46:50 INFO - 'cart']}, 01:46:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:50 INFO - 'tests': ['tp5o']}, 01:46:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:50 INFO - 'talos_options': ['--e10s'], 01:46:50 INFO - 'tests': ['tp5o']}, 01:46:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:50 INFO - 'talos_options': ['--xperf_path', 01:46:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:46:50 INFO - 'tests': ['tp5n']}, 01:46:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:50 INFO - 'talos_options': ['--e10s', 01:46:50 INFO - '--xperf_path', 01:46:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:46:50 INFO - 'tests': ['tp5n']}}, 01:46:50 INFO - 'talos.zip': {'path': '', 01:46:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:46:50 INFO - Running post-action listener: _resource_record_post_action 01:46:50 INFO - ##### 01:46:50 INFO - ##### Running create-virtualenv step. 01:46:50 INFO - ##### 01:46:50 INFO - Running pre-action listener: _resource_record_pre_action 01:46:50 INFO - Running main action method: create_virtualenv 01:46:50 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 01:46:50 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 01:46:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 01:46:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:46:50 INFO - Using real prefix '/usr' 01:46:50 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 01:46:51 INFO - Installing distribute.............................................................................................................................................................................................done. 01:46:53 INFO - Installing pip.................done. 01:46:53 INFO - Return code: 0 01:46:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 01:46:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:53 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 0x7fedd0fb6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fe630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238f840>, '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 0x22fc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fcb60>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1451467931.220899-2012922020', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:46:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 01:46:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:46:53 INFO - Using env: {'DISPLAY': ':0', 01:46:53 INFO - 'HOME': '/home/cltbld', 01:46:53 INFO - 'LANG': 'en_US.UTF-8', 01:46:53 INFO - 'LANGUAGE': 'en_US:en', 01:46:53 INFO - 'LOGNAME': 'cltbld', 01:46:53 INFO - 'MAIL': '/var/mail/cltbld', 01:46:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:53 INFO - 'MOZ_NO_REMOTE': '1', 01:46:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:53 INFO - 'NO_EM_RESTART': '1', 01:46:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:46:53 INFO - 'PWD': '/builds/slave/test-pgo', 01:46:53 INFO - 'SHELL': '/bin/bash', 01:46:53 INFO - 'SHLVL': '1', 01:46:53 INFO - 'TERM': 'linux', 01:46:53 INFO - 'TMOUT': '86400', 01:46:53 INFO - 'USER': 'cltbld', 01:46:53 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451467931.220899-2012922020', 01:46:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:53 INFO - '_': '/tools/buildbot/bin/python'} 01:46:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:46:53 INFO - Cleaning up... 01:46:53 INFO - Return code: 0 01:46:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 01:46:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:53 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 0x7fedd0fb6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fe630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238f840>, '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 0x22fc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fcb60>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1451467931.220899-2012922020', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:46:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 01:46:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:46:53 INFO - Using env: {'DISPLAY': ':0', 01:46:53 INFO - 'HOME': '/home/cltbld', 01:46:53 INFO - 'LANG': 'en_US.UTF-8', 01:46:53 INFO - 'LANGUAGE': 'en_US:en', 01:46:53 INFO - 'LOGNAME': 'cltbld', 01:46:53 INFO - 'MAIL': '/var/mail/cltbld', 01:46:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:53 INFO - 'MOZ_NO_REMOTE': '1', 01:46:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:53 INFO - 'NO_EM_RESTART': '1', 01:46:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:46:53 INFO - 'PWD': '/builds/slave/test-pgo', 01:46:53 INFO - 'SHELL': '/bin/bash', 01:46:53 INFO - 'SHLVL': '1', 01:46:53 INFO - 'TERM': 'linux', 01:46:53 INFO - 'TMOUT': '86400', 01:46:53 INFO - 'USER': 'cltbld', 01:46:53 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451467931.220899-2012922020', 01:46:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:53 INFO - '_': '/tools/buildbot/bin/python'} 01:46:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:53 INFO - Downloading/unpacking psutil>=0.7.1 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46:55 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 01:46:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 01:46:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 01:46:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:46:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:46:55 INFO - Installing collected packages: psutil 01:46:55 INFO - Running setup.py install for psutil 01:46:55 INFO - building 'psutil._psutil_linux' extension 01:46:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 01:46:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 01:46:55 INFO - building 'psutil._psutil_posix' extension 01:46:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 01:46:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 01:46:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:46:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:46:55 INFO - Successfully installed psutil 01:46:55 INFO - Cleaning up... 01:46:55 INFO - Return code: 0 01:46:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 01:46:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:55 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 0x7fedd0fb6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fe630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238f840>, '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 0x22fc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fcb60>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1451467931.220899-2012922020', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:46:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 01:46:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:46:55 INFO - Using env: {'DISPLAY': ':0', 01:46:55 INFO - 'HOME': '/home/cltbld', 01:46:55 INFO - 'LANG': 'en_US.UTF-8', 01:46:55 INFO - 'LANGUAGE': 'en_US:en', 01:46:55 INFO - 'LOGNAME': 'cltbld', 01:46:55 INFO - 'MAIL': '/var/mail/cltbld', 01:46:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:55 INFO - 'MOZ_NO_REMOTE': '1', 01:46:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:55 INFO - 'NO_EM_RESTART': '1', 01:46:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:46:55 INFO - 'PWD': '/builds/slave/test-pgo', 01:46:55 INFO - 'SHELL': '/bin/bash', 01:46:55 INFO - 'SHLVL': '1', 01:46:55 INFO - 'TERM': 'linux', 01:46:55 INFO - 'TMOUT': '86400', 01:46:55 INFO - 'USER': 'cltbld', 01:46:55 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451467931.220899-2012922020', 01:46:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:55 INFO - '_': '/tools/buildbot/bin/python'} 01:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:46:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 01:46:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:46:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:46:57 INFO - Installing collected packages: mozsystemmonitor 01:46:57 INFO - Running setup.py install for mozsystemmonitor 01:46:57 INFO - Successfully installed mozsystemmonitor 01:46:57 INFO - Cleaning up... 01:46:57 INFO - Return code: 0 01:46:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 01:46: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')]} 01:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46: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')]} 01:46:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46: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', '--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 0x7fedd0fb6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fe630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238f840>, '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 0x22fc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fcb60>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1451467931.220899-2012922020', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:46:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 01:46:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:46:57 INFO - Using env: {'DISPLAY': ':0', 01:46:57 INFO - 'HOME': '/home/cltbld', 01:46:57 INFO - 'LANG': 'en_US.UTF-8', 01:46:57 INFO - 'LANGUAGE': 'en_US:en', 01:46:57 INFO - 'LOGNAME': 'cltbld', 01:46:57 INFO - 'MAIL': '/var/mail/cltbld', 01:46:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:57 INFO - 'MOZ_NO_REMOTE': '1', 01:46:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:57 INFO - 'NO_EM_RESTART': '1', 01:46:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:46:57 INFO - 'PWD': '/builds/slave/test-pgo', 01:46:57 INFO - 'SHELL': '/bin/bash', 01:46:57 INFO - 'SHLVL': '1', 01:46:57 INFO - 'TERM': 'linux', 01:46:57 INFO - 'TMOUT': '86400', 01:46:57 INFO - 'USER': 'cltbld', 01:46:57 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451467931.220899-2012922020', 01:46:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:57 INFO - '_': '/tools/buildbot/bin/python'} 01:46:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:58 INFO - Downloading/unpacking blobuploader==1.2.4 01:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:59 INFO - Downloading blobuploader-1.2.4.tar.gz 01:46:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 01:46:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:46:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:47:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 01:47:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 01:47:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:00 INFO - Downloading docopt-0.6.1.tar.gz 01:47:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 01:47:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 01:47:00 INFO - Installing collected packages: blobuploader, requests, docopt 01:47:00 INFO - Running setup.py install for blobuploader 01:47:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:47:00 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 01:47:00 INFO - Running setup.py install for requests 01:47:00 INFO - Running setup.py install for docopt 01:47:01 INFO - Successfully installed blobuploader requests docopt 01:47:01 INFO - Cleaning up... 01:47:01 INFO - Return code: 0 01:47:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:47: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')]} 01:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47: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')]} 01:47:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:01 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 0x7fedd0fb6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fe630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238f840>, '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 0x22fc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fcb60>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1451467931.220899-2012922020', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:47:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 01:47:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:47:01 INFO - Using env: {'DISPLAY': ':0', 01:47:01 INFO - 'HOME': '/home/cltbld', 01:47:01 INFO - 'LANG': 'en_US.UTF-8', 01:47:01 INFO - 'LANGUAGE': 'en_US:en', 01:47:01 INFO - 'LOGNAME': 'cltbld', 01:47:01 INFO - 'MAIL': '/var/mail/cltbld', 01:47:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:01 INFO - 'MOZ_NO_REMOTE': '1', 01:47:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:01 INFO - 'NO_EM_RESTART': '1', 01:47:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:47:01 INFO - 'PWD': '/builds/slave/test-pgo', 01:47:01 INFO - 'SHELL': '/bin/bash', 01:47:01 INFO - 'SHLVL': '1', 01:47:01 INFO - 'TERM': 'linux', 01:47:01 INFO - 'TMOUT': '86400', 01:47:01 INFO - 'USER': 'cltbld', 01:47:01 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451467931.220899-2012922020', 01:47:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:01 INFO - '_': '/tools/buildbot/bin/python'} 01:47:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:47:01 INFO - Running setup.py (path:/tmp/pip-1rLA2g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:47:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:47:01 INFO - Running setup.py (path:/tmp/pip-P92koN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:47:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:47:01 INFO - Running setup.py (path:/tmp/pip-0FaJFC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:47:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:47:01 INFO - Running setup.py (path:/tmp/pip-qfhI6I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:47:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:47:01 INFO - Running setup.py (path:/tmp/pip-yH45nv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:47:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:47:01 INFO - Running setup.py (path:/tmp/pip-v54GSK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:47:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:47:01 INFO - Running setup.py (path:/tmp/pip-9wGoOI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:47:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:47:01 INFO - Running setup.py (path:/tmp/pip-OoZ2Ku-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:47:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:47:01 INFO - Running setup.py (path:/tmp/pip-VAv22M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:47:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:47:01 INFO - Running setup.py (path:/tmp/pip-sIky9a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:47:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:47:01 INFO - Running setup.py (path:/tmp/pip-T16aFk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:47:02 INFO - Running setup.py (path:/tmp/pip-98jjCS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:47:02 INFO - Running setup.py (path:/tmp/pip-X_C9Nj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:47:02 INFO - Running setup.py (path:/tmp/pip-KcEWXX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:47:02 INFO - Running setup.py (path:/tmp/pip-j9wMl5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:47:02 INFO - Running setup.py (path:/tmp/pip-ZSP1_o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:47:02 INFO - Running setup.py (path:/tmp/pip-CBQveA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:47:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:47:02 INFO - Running setup.py install for manifestparser 01:47:02 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 01:47:02 INFO - Running setup.py install for mozcrash 01:47:02 INFO - Running setup.py install for mozdebug 01:47:02 INFO - Running setup.py install for mozdevice 01:47:02 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 01:47:02 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 01:47:02 INFO - Running setup.py install for mozfile 01:47:03 INFO - Running setup.py install for mozhttpd 01:47:03 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 01:47:03 INFO - Running setup.py install for mozinfo 01:47:03 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 01:47:03 INFO - Running setup.py install for mozInstall 01:47:03 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 01:47:03 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 01:47:03 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 01:47:03 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 01:47:03 INFO - Running setup.py install for mozleak 01:47:03 INFO - Running setup.py install for mozlog 01:47:03 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 01:47:03 INFO - Running setup.py install for moznetwork 01:47:03 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 01:47:03 INFO - Running setup.py install for mozprocess 01:47:03 INFO - Running setup.py install for mozprofile 01:47:03 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 01:47:03 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 01:47:03 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 01:47:03 INFO - Running setup.py install for mozrunner 01:47:03 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 01:47:03 INFO - Running setup.py install for mozscreenshot 01:47:04 INFO - Running setup.py install for moztest 01:47:04 INFO - Running setup.py install for mozversion 01:47:04 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 01:47:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:47:04 INFO - Cleaning up... 01:47:04 INFO - Return code: 0 01:47:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fedd0fb6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fe630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238f840>, '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 0x22fc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fcb60>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1451467931.220899-2012922020', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:47:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 01:47:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:47:04 INFO - Using env: {'DISPLAY': ':0', 01:47:04 INFO - 'HOME': '/home/cltbld', 01:47:04 INFO - 'LANG': 'en_US.UTF-8', 01:47:04 INFO - 'LANGUAGE': 'en_US:en', 01:47:04 INFO - 'LOGNAME': 'cltbld', 01:47:04 INFO - 'MAIL': '/var/mail/cltbld', 01:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:04 INFO - 'MOZ_NO_REMOTE': '1', 01:47:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:04 INFO - 'NO_EM_RESTART': '1', 01:47:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:47:04 INFO - 'PWD': '/builds/slave/test-pgo', 01:47:04 INFO - 'SHELL': '/bin/bash', 01:47:04 INFO - 'SHLVL': '1', 01:47:04 INFO - 'TERM': 'linux', 01:47:04 INFO - 'TMOUT': '86400', 01:47:04 INFO - 'USER': 'cltbld', 01:47:04 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451467931.220899-2012922020', 01:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:04 INFO - '_': '/tools/buildbot/bin/python'} 01:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:47:04 INFO - Running setup.py (path:/tmp/pip-4pBg8E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 01:47:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:47:04 INFO - Running setup.py (path:/tmp/pip-Dswmqg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 01:47:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:47:04 INFO - Running setup.py (path:/tmp/pip-k6ZjyY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 01:47:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:47:04 INFO - Running setup.py (path:/tmp/pip-AXnHsx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:47:04 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)) 01:47:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:47:04 INFO - Running setup.py (path:/tmp/pip-NpagtO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 01:47:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:47:04 INFO - Running setup.py (path:/tmp/pip-FGpwyP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 01:47:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:47:04 INFO - Running setup.py (path:/tmp/pip-aGear2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 01:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:47:05 INFO - Running setup.py (path:/tmp/pip-xlf4vp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 01:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:47:05 INFO - Running setup.py (path:/tmp/pip-O0m97s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 01:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:47:05 INFO - Running setup.py (path:/tmp/pip-MDchdL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 01:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:47:05 INFO - Running setup.py (path:/tmp/pip-_nFn9M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 01:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:47:05 INFO - Running setup.py (path:/tmp/pip-0qYY2C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 01:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:47:05 INFO - Running setup.py (path:/tmp/pip-Wn2H4H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 01:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:47:05 INFO - Running setup.py (path:/tmp/pip-EzYEB_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 01:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:47:05 INFO - Running setup.py (path:/tmp/pip-psPSJJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 01:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:47:05 INFO - Running setup.py (path:/tmp/pip-0FLJr8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 01:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:47:05 INFO - Running setup.py (path:/tmp/pip-L2LW9F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 01:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 01:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 01:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 01:47:05 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)) 01:47:05 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)) 01:47:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 01:47: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 01:47: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 01:47: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 01:47: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 01:47: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 01:47: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 01:47:07 INFO - Downloading blessings-1.5.1.tar.gz 01:47:07 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 01:47:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 01:47:07 INFO - Installing collected packages: blessings 01:47:07 INFO - Running setup.py install for blessings 01:47:07 INFO - Successfully installed blessings 01:47:07 INFO - Cleaning up... 01:47:07 INFO - Return code: 0 01:47:07 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 01:47:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:47:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:47:07 INFO - Reading from file tmpfile_stdout 01:47:07 INFO - Current package versions: 01:47:07 INFO - argparse == 1.2.1 01:47:07 INFO - blessings == 1.5.1 01:47:07 INFO - blobuploader == 1.2.4 01:47:07 INFO - docopt == 0.6.1 01:47:07 INFO - manifestparser == 1.1 01:47:07 INFO - mozInstall == 1.12 01:47:07 INFO - mozcrash == 0.16 01:47:07 INFO - mozdebug == 0.1 01:47:07 INFO - mozdevice == 0.47 01:47:07 INFO - mozfile == 1.2 01:47:07 INFO - mozhttpd == 0.7 01:47:07 INFO - mozinfo == 0.9 01:47:07 INFO - mozleak == 0.1 01:47:07 INFO - mozlog == 3.1 01:47:07 INFO - moznetwork == 0.27 01:47:07 INFO - mozprocess == 0.22 01:47:07 INFO - mozprofile == 0.28 01:47:07 INFO - mozrunner == 6.11 01:47:07 INFO - mozscreenshot == 0.1 01:47:07 INFO - mozsystemmonitor == 0.0 01:47:07 INFO - moztest == 0.7 01:47:07 INFO - mozversion == 1.4 01:47:07 INFO - psutil == 3.1.1 01:47:07 INFO - requests == 1.2.3 01:47:07 INFO - wsgiref == 0.1.2 01:47:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:07 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 0x7fedd0fb6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fe630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238f840>, '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 0x22fc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fcb60>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1451467931.220899-2012922020', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:47:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 01:47:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:47:07 INFO - Using env: {'DISPLAY': ':0', 01:47:07 INFO - 'HOME': '/home/cltbld', 01:47:07 INFO - 'LANG': 'en_US.UTF-8', 01:47:07 INFO - 'LANGUAGE': 'en_US:en', 01:47:07 INFO - 'LOGNAME': 'cltbld', 01:47:07 INFO - 'MAIL': '/var/mail/cltbld', 01:47:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:07 INFO - 'MOZ_NO_REMOTE': '1', 01:47:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:07 INFO - 'NO_EM_RESTART': '1', 01:47:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:47:07 INFO - 'PWD': '/builds/slave/test-pgo', 01:47:07 INFO - 'SHELL': '/bin/bash', 01:47:07 INFO - 'SHLVL': '1', 01:47:07 INFO - 'TERM': 'linux', 01:47:07 INFO - 'TMOUT': '86400', 01:47:07 INFO - 'USER': 'cltbld', 01:47:07 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451467931.220899-2012922020', 01:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:07 INFO - '_': '/tools/buildbot/bin/python'} 01:47:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 01:47:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 01:47:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 01:47:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 01:47:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 01:47:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 01:47:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 01:47:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 01:47:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 01:47:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 01:47:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 01:47:08 INFO - Cleaning up... 01:47:08 INFO - Return code: 0 01:47:08 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 01:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:08 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 0x7fedd0fb6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fe630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238f840>, '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 0x22fc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fcb60>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1451467931.220899-2012922020', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:47:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 01:47:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:47:08 INFO - Using env: {'DISPLAY': ':0', 01:47:08 INFO - 'HOME': '/home/cltbld', 01:47:08 INFO - 'LANG': 'en_US.UTF-8', 01:47:08 INFO - 'LANGUAGE': 'en_US:en', 01:47:08 INFO - 'LOGNAME': 'cltbld', 01:47:08 INFO - 'MAIL': '/var/mail/cltbld', 01:47:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:08 INFO - 'MOZ_NO_REMOTE': '1', 01:47:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:08 INFO - 'NO_EM_RESTART': '1', 01:47:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:47:08 INFO - 'PWD': '/builds/slave/test-pgo', 01:47:08 INFO - 'SHELL': '/bin/bash', 01:47:08 INFO - 'SHLVL': '1', 01:47:08 INFO - 'TERM': 'linux', 01:47:08 INFO - 'TMOUT': '86400', 01:47:08 INFO - 'USER': 'cltbld', 01:47:08 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451467931.220899-2012922020', 01:47:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:08 INFO - '_': '/tools/buildbot/bin/python'} 01:47:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:08 INFO - Downloading/unpacking jsonschema 01:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:47:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 01:47:09 INFO - Downloading/unpacking functools32 (from jsonschema) 01:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:10 INFO - Downloading functools32-3.2.3-2.tar.gz 01:47:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 01:47:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 01:47:10 INFO - warning: no files found matching '*.txt' 01:47:10 INFO - no previously-included directories found matching 'build' 01:47:10 INFO - no previously-included directories found matching 'dist' 01:47:10 INFO - no previously-included directories found matching '.git*' 01:47:10 INFO - Installing collected packages: jsonschema, functools32 01:47:10 INFO - Running setup.py install for functools32 01:47:10 INFO - warning: no files found matching '*.txt' 01:47:10 INFO - no previously-included directories found matching 'build' 01:47:10 INFO - no previously-included directories found matching 'dist' 01:47:10 INFO - no previously-included directories found matching '.git*' 01:47:10 INFO - Successfully installed jsonschema functools32 01:47:10 INFO - Cleaning up... 01:47:10 INFO - Return code: 0 01:47:10 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 01:47:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:10 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 0x7fedd0fb6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fe630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238f840>, '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 0x22fc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fcb60>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1451467931.220899-2012922020', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:47:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 01:47:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:47:10 INFO - Using env: {'DISPLAY': ':0', 01:47:10 INFO - 'HOME': '/home/cltbld', 01:47:10 INFO - 'LANG': 'en_US.UTF-8', 01:47:10 INFO - 'LANGUAGE': 'en_US:en', 01:47:10 INFO - 'LOGNAME': 'cltbld', 01:47:10 INFO - 'MAIL': '/var/mail/cltbld', 01:47:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:10 INFO - 'MOZ_NO_REMOTE': '1', 01:47:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:10 INFO - 'NO_EM_RESTART': '1', 01:47:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:47:10 INFO - 'PWD': '/builds/slave/test-pgo', 01:47:10 INFO - 'SHELL': '/bin/bash', 01:47:10 INFO - 'SHLVL': '1', 01:47:10 INFO - 'TERM': 'linux', 01:47:10 INFO - 'TMOUT': '86400', 01:47:10 INFO - 'USER': 'cltbld', 01:47:10 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451467931.220899-2012922020', 01:47:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:10 INFO - '_': '/tools/buildbot/bin/python'} 01:47:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:10 INFO - Downloading/unpacking flake8 01:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:47:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 01:47:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:47:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 01:47:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 01:47:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 01:47:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 01:47:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:47:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:47:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:47:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:47:13 INFO - no previously-included directories found matching 'docs/_build' 01:47:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:47:13 INFO - Running setup.py install for pep8 01:47:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:47:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:47:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:47:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:47:13 INFO - no previously-included directories found matching 'docs/_build' 01:47:13 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 01:47:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:47:13 INFO - Cleaning up... 01:47:13 INFO - Return code: 0 01:47:13 INFO - Running post-action listener: _resource_record_post_action 01:47:13 INFO - Running post-action listener: _start_resource_monitoring 01:47:13 INFO - Starting resource monitoring. 01:47:13 INFO - ##### 01:47:13 INFO - ##### Running install step. 01:47:13 INFO - ##### 01:47:13 INFO - Running pre-action listener: _resource_record_pre_action 01:47:13 INFO - Running main action method: install 01:47:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:47:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:47:13 INFO - Reading from file tmpfile_stdout 01:47:13 INFO - Detecting whether we're running mozinstall >=1.0... 01:47:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 01:47:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 01:47:13 INFO - Reading from file tmpfile_stdout 01:47:13 INFO - Output received: 01:47:13 INFO - Usage: mozinstall [options] installer 01:47:13 INFO - Options: 01:47:13 INFO - -h, --help show this help message and exit 01:47:13 INFO - -d DEST, --destination=DEST 01:47:13 INFO - Directory to install application into. [default: 01:47:13 INFO - "/builds/slave/test-pgo"] 01:47:13 INFO - --app=APP Application being installed. [default: firefox] 01:47:13 INFO - mkdir: /builds/slave/test-pgo/build/application 01:47:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 01:47:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 01:47:29 INFO - Reading from file tmpfile_stdout 01:47:29 INFO - Output received: 01:47:29 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 01:47:29 INFO - Running post-action listener: _resource_record_post_action 01:47:29 INFO - ##### 01:47:29 INFO - ##### Running run-tests step. 01:47:29 INFO - ##### 01:47:29 INFO - Running pre-action listener: _resource_record_pre_action 01:47:29 INFO - Running main action method: run_tests 01:47:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 01:47:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 01:47:29 INFO - Python 2.7.3 01:47:29 INFO - Return code: 0 01:47:29 INFO - grabbing minidump binary from tooltool 01:47:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:29 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 0x238f840>, '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 0x22fc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fcb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 01:47:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 01:47:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 01:47:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:47:29 INFO - Return code: 0 01:47:29 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 01:47:29 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 01:47:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 01:47:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 01:47:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 01:47:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 01:47:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 01:47:30 INFO - Return code: 0 01:47:30 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/a6SmKlwqTXCQM-iMHV0yxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 01:47:30 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/a6SmKlwqTXCQM-iMHV0yxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --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 01:47:30 INFO - Using env: {'DISPLAY': ':0', 01:47:30 INFO - 'HOME': '/home/cltbld', 01:47:30 INFO - 'LANG': 'en_US.UTF-8', 01:47:30 INFO - 'LANGUAGE': 'en_US:en', 01:47:30 INFO - 'LOGNAME': 'cltbld', 01:47:30 INFO - 'MAIL': '/var/mail/cltbld', 01:47:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:47:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 01:47:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:30 INFO - 'MOZ_NO_REMOTE': '1', 01:47:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:47:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:30 INFO - 'NO_EM_RESTART': '1', 01:47:30 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:47:30 INFO - 'PWD': '/builds/slave/test-pgo', 01:47:30 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 01:47:30 INFO - 'SHELL': '/bin/bash', 01:47:30 INFO - 'SHLVL': '1', 01:47:30 INFO - 'TERM': 'linux', 01:47:30 INFO - 'TMOUT': '86400', 01:47:30 INFO - 'USER': 'cltbld', 01:47:30 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451467931.220899-2012922020', 01:47:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:30 INFO - '_': '/tools/buildbot/bin/python'} 01:47:30 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/a6SmKlwqTXCQM-iMHV0yxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 01:47:30 INFO - mozversion application_buildid: 20151229233007 01:47:30 INFO - mozversion application_changeset: 77420c71e0d49620c056cbd4a74cb1e41a891ac5 01:47:30 INFO - mozversion application_display_name: Nightly 01:47:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:47:30 INFO - mozversion application_name: Firefox 01:47:30 INFO - mozversion application_remotingname: firefox 01:47:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:47:30 INFO - mozversion application_vendor: Mozilla 01:47:30 INFO - mozversion application_version: 46.0a1 01:47:30 INFO - mozversion platform_buildid: 20151229233007 01:47:30 INFO - mozversion platform_changeset: 77420c71e0d49620c056cbd4a74cb1e41a891ac5 01:47:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:47:30 INFO - mozversion platform_version: 46.0a1 01:47:30 INFO - using testdate: 1451468850 01:47:30 INFO - actual date: 1451468850 01:47:30 INFO - starting webserver on 'localhost:44873' 01:47:30 INFO - SUITE-START | Running 3 tests 01:47:30 INFO - TEST-START | dromaeo_css 01:47:30 INFO - operating with platform_type : linux_ 01:47:30 INFO - Initialising browser for dromaeo_css test... 01:47:30 INFO - TEST-INFO | started process 14391 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzyIGLj/profile http://localhost:44873/getInfo.html) 01:47:34 INFO - PROCESS | 14391 | __metrics Screen width/height:1600/1200 01:47:34 INFO - PROCESS | 14391 | colorDepth:24 01:47:34 INFO - PROCESS | 14391 | Browser inner width/height: 1024/697 01:47:34 INFO - PROCESS | 14391 | __metrics 01:47:35 INFO - PROCESS | 14391 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 01:47:35 INFO - PROCESS | 14391 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:47:35 INFO - TEST-INFO | 14391: exit 0 01:47:35 INFO - Browser initialized. 01:47:35 INFO - Running cycle 1/1 for dromaeo_css test... 01:47:35 INFO - TEST-INFO | started process 14487 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzyIGLj/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:47:47 INFO - PROCESS | 14487 | RSS: Main: 150441984 01:47:47 INFO - PROCESS | 14487 | 01:48:39 INFO - PROCESS | 14487 | 1451468919058 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 01:50:47 INFO - PROCESS | 14487 | Cycle 1(1): loaded http://localhost:44873/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44873/tests/dromaeo/cssquery-ext.html) 01:50:48 INFO - PROCESS | 14487 | RSS: Main: 237879296 01:50:48 INFO - PROCESS | 14487 | 01:53:51 INFO - PROCESS | 14487 | Cycle 1(1): loaded http://localhost:44873/tests/dromaeo/cssquery-ext.html (next: http://localhost:44873/tests/dromaeo/cssquery-jquery.html) 01:53:51 INFO - PROCESS | 14487 | RSS: Main: 234553344 01:53:51 INFO - PROCESS | 14487 | 01:56:53 INFO - PROCESS | 14487 | Cycle 1(1): loaded http://localhost:44873/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44873/tests/dromaeo/cssquery-mootools.html) 01:56:54 INFO - PROCESS | 14487 | RSS: Main: 235036672 01:56:54 INFO - PROCESS | 14487 | 01:59:55 INFO - PROCESS | 14487 | Cycle 1(1): loaded http://localhost:44873/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44873/tests/dromaeo/cssquery-prototype.html) 01:59:56 INFO - PROCESS | 14487 | RSS: Main: 214806528 01:59:56 INFO - PROCESS | 14487 | 02:02:58 INFO - PROCESS | 14487 | Cycle 1(1): loaded http://localhost:44873/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44873/tests/dromaeo/cssquery-yui.html) 02:02:59 INFO - PROCESS | 14487 | RSS: Main: 219361280 02:02:59 INFO - PROCESS | 14487 | 02:06:02 INFO - PROCESS | 14487 | Cycle 1(1): loaded http://localhost:44873/tests/dromaeo/cssquery-yui.html (next: http://localhost:44873/tests/dromaeo/cssquery-dojo.html) 02:06:02 INFO - PROCESS | 14487 | RSS: Main: 295526400 02:06:02 INFO - PROCESS | 14487 | 02:06:02 INFO - PROCESS | 14487 | __start_tp_report 02:06:02 INFO - PROCESS | 14487 | _x_x_mozilla_page_load 02:06:02 INFO - PROCESS | 14487 | _x_x_mozilla_page_load_details 02:06:02 INFO - PROCESS | 14487 | |i|pagename|runs| 02:06:02 INFO - PROCESS | 14487 | |0;dojo.html;3141.638711548172;3187.6652951440115;3220.114468521158;3222.5327327537507;3253.2029652735077;5233.842984710464;5288.206768984654;5310.15037593985;5365.5975801814875;5366.517013468787;5187.559057480109;5237.764300606473;5281.313429254201;5291.735413229342;5295;4762.738049407281;4769.141554520185;4793.520647935214;4837.201861692834;4848.093404546019;4718.174319494092;4882.877928051792;4892.951070489303;4906.31311616374;4962.454130045692;4789.353437285957;4894.192458244385;4894.975525122351;4916.975415122937;4938.333325001133;4847.466778654345;4850.151223535867;4860.927086093711;4874.195757699975;4899.706017638953;4750.786214620351;4833.057553777015;4845.152098382804;4865.124277630025;4893.902121957576;5125.615578831603;5130.897382052338;5181.740912954375;5260.342457192851;5265;5689.146628005791;5689.772409103631;5703.62926409782;5704.77180912763;5755.453231942959;5707.857303567403;5719.370869204384;5723.484886360206;5725.112607545837;5731.713414329267;5252.264682944391;5281.313429254173;5321.8935621287355;5343.091674415358;5382.6770393776105;5785.971070144622;5802.100674395476;5810.535157187415;5828.921649494857;5835.649861008353;5485.835424937259;5565.1374037024325;5576.247206627135;5599.944000559943;5637.46444087811;5557.41647127054;5687.971560142256;5698.515626171822;5699.2590963174525;5719.456651618173;5623.437656234344;5683.602147849693;5768.394318596571;5773.971130144322;5784.248047753765;5655.745491452894;5658.377578466448;5659.236003139524;5659.462351076641;5660.405657405995;4358.825646974149;4375.037491751809;4385.473743150778;4387.14450682114;4427.889302767457;3881.9611803882162;3933.4886464759397;3965.18713663704;3965.2267807777785;3985.163115745726;5279.788808447696;5286.682799032071;5291.074062039128;5291.603129765283;5292.391374991848;5667.773289068474;5744.195812586241;5763.884722305615;5769.9711501442225;5782.3639399666;5210.426853046162;5222.8955420892125;5284;5311.123664595376;5324.148136298174;4891.26631005352;4900.163405205057;4901;4901.877453063702;4937.703737775745;5725.713714314267;5805.36141024487;5809.970950145223;5822.272215973004;5823.359430462646;5627.971860140673;5689.971550142222;5695.800646977336;5728.513076388554;5747.770089196552;5741.45456181662;5744.569157313134;5749;5756.827295181151;5766.509846663081;5468.316460442445;5575.135853942646;5587.720613969204;5609.719514024201;5624.634398764068;5656.462636049569;5674.233978413026;5704.771809127588;5710.857228569319;5713.285839270091;5545.279113715191;5615.8876822464135;5642.210090587403;5693.886122277614;5699.829005129853;5584.916226256528;5588;5588.77644894216;5589.664620122806;5593.216949626974;5325.573954083741;5432.701201433801;5495.065838807493;5506.91739623898;5546.473085056913;5521.558275338044;5550.111982082847;5646.520045796154;5650.491455769001;5694.829155125353;5434.076207044733;5449.073657478318;5451.236826844324;5454.4545545445135;5489.698066606375 02:06:02 INFO - PROCESS | 14487 | |1;ext.html;527.2039220776626;529.9894002119958;536.3670868375317;551.1814954792133;552.1662289942187;28246.011389601368;28886.422271554555;35482.645173548226;35861;35888.461673074926;37887.621123788755;38216.617833821656;38300.61699383005;38310.23379532408;38363.23273534528;7385.409167266633;8431.704890328825;8559.48643081414;8602.78493037676;8606.78483037926;7455.962720186391;7570.8485830283635;10097.091261786474;10322.587096516168;10325.53535090919;9976.700698979042;10065.345752526098;10090.091891729742;10091;10098.394096354206;7530.209328020534;7710.074791025113;9924.503774811266;10007.949960250226;10016.198704103654;7337.779866604011;10012.649557265533;10252.94873525635;10262.7434314142;10270.7432314192;35747;36193.457098143546;36245;36265.09337266563;36320.0919977;3145.4495463293833;3183.8567264473154;3308.1894935740656;3310.139363765414;3769.830357633913;27518.449631007268;27822;28413.857930710215;28424.147275581767;28425.57361639577;3123.250419899208;3194.244604316547;3233.4826427771445;3262.200760813616;3280.1799550112473;192687;193143;193238;193345;193542;56863.43136568664;58493.70753146207;59276.70361648164;59937.100943485886;60572.39427605756;53466;53524.732376337866;53738;53791.19313210305;53881.73059134679;15104.169270689998;15298.923505382401;15299.46451874179;15312;15313.923430383;11661.76676466483;11684.47419866108;11802.822957655642;11805.822912656316;11808.114391420679;19103;19843.60312793736;19984;20022.59954800896;20031.699524507145;7754.418418618626;7773.961130194426;7915.683372665029;7942.920570794334;7944.523328600302;929.4609126706629;997.581015973293;1002.318423472046;1012.9797404051877;1026.235454586338;25137.62293565598;26604;26819.463610727675;27087.1873843785;27192.728072719416;1013.9847902281472;1038.08129805123;1109.5395410904546;1120.9887901121047;1151.6890439581266;13987.580372588838;15399.153046582545;15504.457343992906;15863.444779432664;16189.838101618832;304822;309043;309729;309958;310488;51297.487025130016;51518;51665.48334516607;51670.483295167316;51715.74142129265;1331.3476396565613;1347.0772520823268;1352.5468967895865;1357.2874241023542;1367.8016687580246;27908.30229244285;29111.272218194714;29279.076963000567;29515;29750.851245743634;45760.8815206633;46328.768356158005;46329.768351158025;46333;46361.304580430646;282335;288230;289179;299090;299204;29837.850810745807;29930.401391972475;29963.250918727208;30013.549796752628;30045.849770751007;38454.42318365283;39605;39826.55235640967;42636;43064;35311.64688353083;35374.823125884206;35660.46509302415;35761.821190893876;36610.45084323791;35816.64183358133;36371.81814090913;36590.8170459146;36646.26707465889;36881.44677829781;32807.83596082004;35475.64524354723;35952.28095438129;36152.819235903655;36169.276614468086;27483;29257.707422925498;30973;31273.37453250968;31576.684233158292;24155.15456958998;24433.75566244315;24514.87742561347;24898.626520602567;24920.750792491843 02:06:02 INFO - PROCESS | 14487 | |2;jquery.html;340.7614669731188;346.05354355836766;346.7382126494496;347.8799814064147;352.1969908608373;14076.296185190726;14560.854391456081;16376.344946202153;16464.259108340124;17243.65512689747;15051.6989660207;15062.774058389134;15066.54800355991;15857.762133568005;16250.75623865643;5031.195008798602;5322.973385133069;5323.8136665216725;5326.520613144816;5330.813421530247;3837.9424308635394;3968;5165.173572228444;5607.271054762875;5717.428257174291;5661.8584535386535;5678.353277549506;5682.573806964473;5686.317641882959;5726.742296596663;5562.610617256793;5759.769609215627;5777.682227477487;5781.161731548944;5782.56630752691;5077.035363280965;5093.694378337312;5094.235864620299;5103;5108.7445627718835;15225.61935951599;15232.466863659718;16019.11894845783;17799.73300400495;19983.80016199834;2135.530183359658;2197.6923230747707;2222.9444263893533;2275.2719129878446;2529.190658989124;12860.228386296852;13284.933575332061;13335.133216340906;13337.799933001013;13580;1689.2736123466905;1721.7933847938202;1760.0319824096696;1802.97295540567;1875.5029917071986;57938;58801.70599146977;61169.38830611726;61417.38582614161;61476.692616537075;9769.560369783234;9935.416791634083;10028.147607453448;10118.747031324128;10156.542955567018;13044.217346959213;13053.804192937114;13066.608001759962;13085.08404411682;13168.341582920815;7674.232576742281;7707.884381734279;7749.225077492319;7809.375249980101;7900.170482099412;7412.740554080689;7482.139553951257;7501;7509.436792240604;7546.434017448713;5967.850803729942;6022;6030.638161710312;6058.878822423527;6119.663418512025;1638.6231166831697;1707.6926153292527;1731.5930756272267;1748.3793253395115;1764.461839139075;900.9234215091791;905.1988989743992;913.7532866126242;1027.9331843430152;1084.7233955341337;14927.40290388394;16014.91992540053;17055.48833534996;17257.482275531755;17842.643147136983;890.0965519997208;908.2779190543533;972.5915115651443;974.8927617962019;1028.5114570578914;9200.631974721071;9335.533223338805;9412.67055653049;9438.622455101857;9500.42997420157;498274;505143;506751;512043;582129;38490.80754596209;38653;63159.684201579614;75505.24494755092;76828.61585692035;1146.3752255021034;1152.1992215410378;1159.3044173495834;1171.7246447084929;1171.9355435451132;13995.720085598434;14458.710825783635;14523;14586.819330589155;14597.489087881873;30918.69081309158;31453.8427307862;32345;32720;32860;45022;45950.31074533951;47216.527834721215;48321.5167848317;50395;9392.168527137143;9469.431834089977;9552.808943820946;9559.522023898639;9576.186024188022;11356.659300221007;11418.714532136431;13191.736165276832;13435.932820335836;17977.370792022215;14081.788773168206;14184.787228191379;14314.642133946318;14665.633359166106;14954.850451495346;14117.08238964464;14155.787663185267;14211.147331160164;14252.857471425154;14361.281935902955;13586.524471643444;14634.902382321581;14688.55934321972;15121.470748523749;15165.92417037952;9507.049295070437;9520.381175223589;9547.28395370364;9700.805983880424;9720.222382209266;13656.112352697042;14254.714905701621;14526.636834079232;14555.345009474388;14851.257437128317 02:06:02 INFO - PROCESS | 14487 | |3;mootools.html;1271.1292764456355;1410.8941829362798;1413.3145424469135;1549.5893588199128;1781.1895587507686;6584.111144995424;7119.216886142527;7169.462290328227;7181.9281807181915;7214.927850721491;7038.401735852446;7182.389496892771;7189.928100718991;7209.963950180255;7216.314450127243;1975.4172519106826;1998.1308130963005;2183.5960347335713;2194.5281764420647;2228.0419419649543;2243.2260869999823;2248.5053288276554;2249.718785151856;2251.7297924249033;2253.4929640830765;2138.9786102139014;2207.6798864164684;2207.9558408831813;2213.5904857601395;2213.5904857601395;2180.0407820558903;2207.4591725027312;2208.8785116818567;2224.3549370682563;2235.452314183019;2244.2706120510734;2251.5609456155894;2285.4971906180613;2289.610766169755;2303.4011157099108;7035.542689725152;7089.574625522434;7095.538789978635;7103.360697537195;7108.182559005729;4478.641708663299;4546.704464209849;4551.089782043605;4559.772011399416;4571.588557029883;2816.2114607909816;2860.7139286071433;2862.699416561252;2866.942661146786;3042.589250451205;883.491992104536;895.5208963204655;896.4486840592988;915.1306259053925;1685.148999755128;9726.124648781573;9836.950815245878;9843.803123937481;9848.507574621312;9850.21198304141;4030.234255491447;4102.651274641689;4160.625543701081;4167.374893765959;4191.413202151702;8104.149064348277;8138.633761480747;8146.592670366458;8221.506709597443;8221.54781487024;4599.517050709695;4600.95399046012;4604.40142781443;4626.653001024936;4628.490866004737;4304.053108316165;4309.439772829513;4351.456067991501;4357.237483440385;4362.105768317488;3204.1348835814665;3230.402375560529;3366.848491817874;3408;3445.2248244145367;1094.075506197262;1100.3068067117824;1108.939008354532;1121.6691076132397;1125.4035361258545;1096.276457538021;1159.1248607301434;1268.9619311420672;1272.688191393096;1277.8977681785434;6933.965330173418;6992.510524263253;6995.650217489105;7010.649467526603;7011.92988070123;593.3087952535334;597.4384078965759;598.8293336399105;602.3314121325326;744.4230721191012;5417.187421886749;5442.265294185314;5552.083906155439;5560.972195138998;5562.137868630288;8705.695300664447;8996.955015224881;9006.144416280444;9011.549422528848;9013.864792028126;8901.198892099743;8915.643374265086;8915.910840891638;8920.73237802867;8924;6916;7026.789196324118;7042.154941406961;7065.0815393998455;7112.786616401516;6893.862122757617;6910.723571057101;6930.203026652;6932.7226910923;6942.132233470817;7660.119086305146;7742.380609551335;7915.05019397676;7922.881156782768;7938.920610793818;8123.228293312126;8236.094029656853;8243.587820608825;8245.587720614065;8259.091499935123;6231.1276421300145;6399.424051835357;6415.294317625151;6418.614883107029;6427.228732552124;6141;6228.626282423069;6707.195136583641;6867.244603093556;6872.965635171792;6254.562180647311;6456.580322279036;6461.127747754181;6506.902396464152;6690.83272918181;6309.7160627770945;6390.392912673288;6432.839179020562;6569.967150164219;6591.14315139048;6446.967765161145;6460.903086453613;6500.967495162494;6511.055896894829;6511.837204069747;6038.943184942706;6063.181470501426;6063.818085457443;6091.695415229309;6093.725782339894;6021;6111.633302001894;6124.846878828065;6129.754809807736;6148.200733904564 02:06:02 INFO - PROCESS | 14487 | |4;prototype.html;311.9204602826279;316.87958575741214;319.58773182594456;322.85955609309946;334.5583829345264;5910.379410161936;5973.701314934252;5979.37216592257;5986.551008674345;6040.30536488304;5897.793577224798;5914.378990206031;5919.37846526115;5919.585629005971;5927.140564618127;4380.364847097169;4470.619997300217;4471.105778844228;4595.977020114895;4600.424946881648;4540.228161212602;4575.428071491064;4578.97710511447;4579.198640237962;4583.335416364625;4527.886802829923;4527.886802829939;4528.0943811237885;4529.977350113261;4537.8184872605225;4357.782110894443;4446.822127114911;4467.888302792456;4530.660200484944;4557.225271703818;3994.7603143811466;4003.539592946819;4012.959870401317;4022.7184097113213;4032.495938007749;5599.664020158803;5634.0703783875615;5645.040343141676;5647.040003199466;5648.096304591287;5261.631685781997;5367.973160134214;5370.731463426852;5373.704446255454;5376.838694839161;6282.340354262782;6298.2442106947;6314.62112273265;6321.494280457552;6338;4454.465464144323;4488.865334039951;4490.348899409567;4493.5281795411665;4494.68537202396;6546.18172728409;6576.145101136822;6584.835379115512;6585.703643336014;6588.308227636077;4510.954890451119;4596.4254468191475;4604.434492272643;4612.377329060601;4622.930656040162;4672.252439609714;4674.485806561275;4675.766211689402;4677.508861569554;4679.321498382784;5340.385855626575;5347.572194224453;5350.5184533392185;5352.411234764173;5353.598480114007;6276.717547710364;6371.96814015927;6377.266614339411;6379.393957574023;6380.042993551005;1608.8069431668275;1650.2408891909615;1655.370959035583;1656.7100757367411;1656.9254383552768;1081.5457507846722;1086.6631344283298;1094.5676457799125;1103.0789290941993;1103.773726386089;5960.195373624592;5968.671723055274;5972.25346831646;5973.104034394789;5974.85062873423;6517.804465865936;6524.967375163189;6526.412622863965;6530.869382612321;6536;5947.197128387612;5957.493613042853;5962.910556341659;5966.0454327307425;5969.701514924236;3473.5484387029524;3554;3558.8042657654078;3560.6795388415167;3564.625714300013;6676.499262555328;6730.293319201512;6730.528862979642;6734.528582999143;6739.393454589111;6770.69531871067;6780.457563394916;6782.253952065269;6786.966065169741;6798.694058767268;6523.510736694672;6696.2968888267005;6700.095487109178;6719.227288861745;6727.192736871509;6577.934220657732;6587.505937054644;6587.604743715392;6587.802365928838;6596.406323430914;6408.711607977559;6469.676516174267;6480.384363485461;6511.186101737283;6520.282768895323;6657.0361743284875;6659.900101498578;6718.764843230463;6721.050895240521;6723.428508576826;4485.080558485568;4525.773711314487;4528.320751887111;4529.977350113229;4532.796024178854;6601.273859875506;6606.966965165144;6609.735610575715;6611.933880661132;6620.106285651375;6270.905936411049;6425.775097871552;6425.839354016187;6426.742930282736;6438.5171112165835;6388.87222255543;6393.808185754435;6395.552311338161;6396.712147953446;6400.775972840928;6273.215848018997;6286.497080233662;6287.842803929939;6290.465310448663;6290.622562646256;5671.206031155559;5952.280079150959;6358.1734374531015;6385.074164246251;6391.520635952415;6257.561970662192;6288.434040936338;6288.905666414916;6294.905576416449;6298.685065746603 02:06:02 INFO - PROCESS | 14487 | |5;yui.html;685.0785693242593;712.4976891291639;720.7513407874283;723.7249845058877;750.2010358967699;13537.52618658346;13655.863441365584;13659;13685.452581896738;13712.725745485097;12361.690957726061;12403.751924961496;12450.937745311283;12451.875481245184;14082.155070695766;821.7657967479255;837.7863644770575;838.1660248053196;838.4591938199858;838.5262326785378;821.2280456371022;824.8309096635205;828.2835347424494;829.2785276809185;829.7261903571837;869.8390797702414;874.0472884555833;874.6501399440211;874.6938571499987;875.0855356152836;866.1987661413231;868.5526953618892;869.5739087846973;871.3900269811157;874.2481465939319;639.3287048598999;641.2913730327967;641.6278558436096;642.00809748938;642.3544337940386;13143.079984401096;13152.605421837361;13156.40796164175;13160.144590601676;13187.86812131876;12453.93773031129;12536.561220357244;12544.435500402504;12663.746725065446;12680.556180533637;10047;10281.074703276741;10412.68761937143;10530.78938421235;10628.415437150954;3598.8560457581925;3644.890653280406;3663.7618554793853;3742;3742.5883152853435;43648.12703745939;43719.56280437187;43797.562024379986;43861;43868.78065609683;9513.524323783922;9612.75968100789;9688.660896868576;9761.316707830383;9793.363431376938;17302.740458893128;17304.307827686753;17379.91310043467;17396.65206695859;17424.82575174232;7025.648717564101;7212.423006159494;7373.88939165913;7400.925990740131;7683.116441609175;4119.443875076826;4178.937315940263;4183.1215444756335;4190.664746820247;4367.563243675607;3040.3159289160203;3044.2237229506336;3071.1707838883376;3080.245339891696;3086;524.0880867290887;574.7384939852441;579.956503262257;592.599995003371;606.7845914700218;550.3368441028551;559.8880223955225;571.7798647520734;640.5324113397246;663.1660736114292;8482.533460659723;8601;8624.827503449897;8729.214370706666;8813.25087367568;532.9946700532945;550.3231025838242;647.7668039505775;654.5745265577318;659.6536818170499;3951.585083566184;3970.285348637215;4016.6786657067364;4091.5499295077516;4096.26267271888;54177.1873421899;57753.42246577564;57964;58113.709431452575;58216.41783582194;48219.276710849364;49067;50252.74873625681;50878.74560627173;50972.235416468786;39904.201915961516;41761.79119104446;42150;45167;45662.315065274044;7801.570913599807;8202.630881610223;8278.130796266547;8346.582670866312;8496.745097647081;34052.31895362029;34127;34139;34172.48741268833;34473;41212.38181427341;41350.58649413467;42053.36919946142;44689.10621787611;44781.32828007648;9543.33196676226;9732.318737688294;9895.554700038372;9904.306698531034;10494.632687856194;9865.161461275871;10572.682819515427;10979.1216702662;11058.171415538984;11801.881981180079;10469.842952355873;10496.527656255334;10594.894051059391;10898.18263630215;11384.487698053774;10721.678349649523;10817.837732433862;10847.403392813156;10940.124790016938;10953.45232738344;10618.73453163677;10853;10984.176186786182;11177.441127943734;11228.606998755004;8641.308695304486;8810;8961.641534338814;9129;9220.492872892055;7976.800579985546;8227.629756661085;8255.463394879314;8594.183552562497;8671.4363566368 02:06:02 INFO - PROCESS | 14487 | __end_tp_report 02:06:02 INFO - PROCESS | 14487 | __start_cc_report 02:06:02 INFO - PROCESS | 14487 | _x_x_mozilla_cycle_collect,991 02:06:02 INFO - PROCESS | 14487 | __end_cc_report 02:06:02 INFO - PROCESS | 14487 | __startTimestamp1451469962350__endTimestamp 02:06:02 INFO - PROCESS | 14487 | 02:06:02 INFO - PROCESS | 14487 | ------- Summary: start ------- 02:06:02 INFO - PROCESS | 14487 | Number of tests: 6 02:06:02 INFO - PROCESS | 14487 | 02:06:02 INFO - PROCESS | 14487 | [#0] dojo.html Cycles:165 Average:5279.96 Median:5485.84 stddev:573.59 (10.5%) stddev-sans-first:550.27 02:06:02 INFO - PROCESS | 14487 | Values: 3141.6 3187.7 3220.1 3222.5 3253.2 5233.8 5288.2 5310.2 5365.6 5366.5 5187.6 5237.8 5281.3 5291.7 5295.0 4762.7 4769.1 4793.5 4837.2 4848.1 4718.2 4882.9 4893.0 4906.3 4962.5 4789.4 4894.2 4895.0 4917.0 4938.3 4847.5 4850.2 4860.9 4874.2 4899.7 4750.8 4833.1 4845.2 4865.1 4893.9 5125.6 5130.9 5181.7 5260.3 5265.0 5689.1 5689.8 5703.6 5704.8 5755.5 5707.9 5719.4 5723.5 5725.1 5731.7 5252.3 5281.3 5321.9 5343.1 5382.7 5786.0 5802.1 5810.5 5828.9 5835.6 5485.8 5565.1 5576.2 5599.9 5637.5 5557.4 5688.0 5698.5 5699.3 5719.5 5623.4 5683.6 5768.4 5774.0 5784.2 5655.7 5658.4 5659.2 5659.5 5660.4 4358.8 4375.0 4385.5 4387.1 4427.9 3882.0 3933.5 3965.2 3965.2 3985.2 5279.8 5286.7 5291.1 5291.6 5292.4 5667.8 5744.2 5763.9 5770.0 5782.4 5210.4 5222.9 5284.0 5311.1 5324.1 4891.3 4900.2 4901.0 4901.9 4937.7 5725.7 5805.4 5810.0 5822.3 5823.4 5628.0 5690.0 5695.8 5728.5 5747.8 5741.5 5744.6 5749.0 5756.8 5766.5 5468.3 5575.1 5587.7 5609.7 5624.6 5656.5 5674.2 5704.8 5710.9 5713.3 5545.3 5615.9 5642.2 5693.9 5699.8 5584.9 5588.0 5588.8 5589.7 5593.2 5325.6 5432.7 5495.1 5506.9 5546.5 5521.6 5550.1 5646.5 5650.5 5694.8 5434.1 5449.1 5451.2 5454.5 5489.7 02:06:02 INFO - PROCESS | 14487 | 02:06:02 INFO - PROCESS | 14487 | [#1] ext.html Cycles:180 Average:43190.30 Median:156805.63 stddev:70400.56 (44.9%) stddev-sans-first:70525.17 02:06:02 INFO - PROCESS | 14487 | Values: 527.2 530.0 536.4 551.2 552.2 28246.0 28886.4 35482.6 35861.0 35888.5 37887.6 38216.6 38300.6 38310.2 38363.2 7385.4 8431.7 8559.5 8602.8 8606.8 7456.0 7570.8 10097.1 10322.6 10325.5 9976.7 10065.3 10090.1 10091.0 10098.4 7530.2 7710.1 9924.5 10007.9 10016.2 7337.8 10012.6 10252.9 10262.7 10270.7 35747.0 36193.5 36245.0 36265.1 36320.1 3145.4 3183.9 3308.2 3310.1 3769.8 27518.4 27822.0 28413.9 28424.1 28425.6 3123.3 3194.2 3233.5 3262.2 3280.2 192687.0 193143.0 193238.0 193345.0 193542.0 56863.4 58493.7 59276.7 59937.1 60572.4 53466.0 53524.7 53738.0 53791.2 53881.7 15104.2 15298.9 15299.5 15312.0 15313.9 11661.8 11684.5 11802.8 11805.8 11808.1 19103.0 19843.6 19984.0 20022.6 20031.7 7754.4 7774.0 7915.7 7942.9 7944.5 929.5 997.6 1002.3 1013.0 1026.2 25137.6 26604.0 26819.5 27087.2 27192.7 1014.0 1038.1 1109.5 1121.0 1151.7 13987.6 15399.2 15504.5 15863.4 16189.8 304822.0 309043.0 309729.0 309958.0 310488.0 51297.5 51518.0 51665.5 51670.5 51715.7 1331.3 1347.1 1352.5 1357.3 1367.8 27908.3 29111.3 29279.1 29515.0 29750.9 45760.9 46328.8 46329.8 46333.0 46361.3 282335.0 288230.0 289179.0 299090.0 299204.0 29837.9 29930.4 29963.3 30013.5 30045.8 38454.4 39605.0 39826.6 42636.0 43064.0 35311.6 35374.8 35660.5 35761.8 36610.5 35816.6 36371.8 36590.8 36646.3 36881.4 32807.8 35475.6 35952.3 36152.8 36169.3 27483.0 29257.7 30973.0 31273.4 31576.7 24155.2 24433.8 24514.9 24898.6 24920.8 02:06:02 INFO - PROCESS | 14487 | 02:06:02 INFO - PROCESS | 14487 | [#2] jquery.html Cycles:180 Average:27534.09 Median:16600.38 stddev:85038.69 (512.3%) stddev-sans-first:85252.73 02:06:02 INFO - PROCESS | 14487 | Values: 340.8 346.1 346.7 347.9 352.2 14076.3 14560.9 16376.3 16464.3 17243.7 15051.7 15062.8 15066.5 15857.8 16250.8 5031.2 5323.0 5323.8 5326.5 5330.8 3837.9 3968.0 5165.2 5607.3 5717.4 5661.9 5678.4 5682.6 5686.3 5726.7 5562.6 5759.8 5777.7 5781.2 5782.6 5077.0 5093.7 5094.2 5103.0 5108.7 15225.6 15232.5 16019.1 17799.7 19983.8 2135.5 2197.7 2222.9 2275.3 2529.2 12860.2 13284.9 13335.1 13337.8 13580.0 1689.3 1721.8 1760.0 1803.0 1875.5 57938.0 58801.7 61169.4 61417.4 61476.7 9769.6 9935.4 10028.1 10118.7 10156.5 13044.2 13053.8 13066.6 13085.1 13168.3 7674.2 7707.9 7749.2 7809.4 7900.2 7412.7 7482.1 7501.0 7509.4 7546.4 5967.9 6022.0 6030.6 6058.9 6119.7 1638.6 1707.7 1731.6 1748.4 1764.5 900.9 905.2 913.8 1027.9 1084.7 14927.4 16014.9 17055.5 17257.5 17842.6 890.1 908.3 972.6 974.9 1028.5 9200.6 9335.5 9412.7 9438.6 9500.4 498274.0 505143.0 506751.0 512043.0 582129.0 38490.8 38653.0 63159.7 75505.2 76828.6 1146.4 1152.2 1159.3 1171.7 1171.9 13995.7 14458.7 14523.0 14586.8 14597.5 30918.7 31453.8 32345.0 32720.0 32860.0 45022.0 45950.3 47216.5 48321.5 50395.0 9392.2 9469.4 9552.8 9559.5 9576.2 11356.7 11418.7 13191.7 13435.9 17977.4 14081.8 14184.8 14314.6 14665.6 14954.9 14117.1 14155.8 14211.1 14252.9 14361.3 13586.5 14634.9 14688.6 15121.5 15165.9 9507.0 9520.4 9547.3 9700.8 9720.2 13656.1 14254.7 14526.6 14555.3 14851.3 02:06:02 INFO - PROCESS | 14487 | 02:06:02 INFO - PROCESS | 14487 | [#3] mootools.html Cycles:180 Average:5127.38 Median:6188.41 stddev:2617.09 (42.3%) stddev-sans-first:2608.38 02:06:02 INFO - PROCESS | 14487 | Values: 1271.1 1410.9 1413.3 1549.6 1781.2 6584.1 7119.2 7169.5 7181.9 7214.9 7038.4 7182.4 7189.9 7210.0 7216.3 1975.4 1998.1 2183.6 2194.5 2228.0 2243.2 2248.5 2249.7 2251.7 2253.5 2139.0 2207.7 2208.0 2213.6 2213.6 2180.0 2207.5 2208.9 2224.4 2235.5 2244.3 2251.6 2285.5 2289.6 2303.4 7035.5 7089.6 7095.5 7103.4 7108.2 4478.6 4546.7 4551.1 4559.8 4571.6 2816.2 2860.7 2862.7 2866.9 3042.6 883.5 895.5 896.4 915.1 1685.1 9726.1 9837.0 9843.8 9848.5 9850.2 4030.2 4102.7 4160.6 4167.4 4191.4 8104.1 8138.6 8146.6 8221.5 8221.5 4599.5 4601.0 4604.4 4626.7 4628.5 4304.1 4309.4 4351.5 4357.2 4362.1 3204.1 3230.4 3366.8 3408.0 3445.2 1094.1 1100.3 1108.9 1121.7 1125.4 1096.3 1159.1 1269.0 1272.7 1277.9 6934.0 6992.5 6995.7 7010.6 7011.9 593.3 597.4 598.8 602.3 744.4 5417.2 5442.3 5552.1 5561.0 5562.1 8705.7 8997.0 9006.1 9011.5 9013.9 8901.2 8915.6 8915.9 8920.7 8924.0 6916.0 7026.8 7042.2 7065.1 7112.8 6893.9 6910.7 6930.2 6932.7 6942.1 7660.1 7742.4 7915.1 7922.9 7938.9 8123.2 8236.1 8243.6 8245.6 8259.1 6231.1 6399.4 6415.3 6418.6 6427.2 6141.0 6228.6 6707.2 6867.2 6873.0 6254.6 6456.6 6461.1 6506.9 6690.8 6309.7 6390.4 6432.8 6570.0 6591.1 6447.0 6460.9 6501.0 6511.1 6511.8 6038.9 6063.2 6063.8 6091.7 6093.7 6021.0 6111.6 6124.8 6129.8 6148.2 02:06:02 INFO - PROCESS | 14487 | 02:06:02 INFO - PROCESS | 14487 | [#4] prototype.html Cycles:180 Average:5304.45 Median:5961.55 stddev:1588.35 (26.6%) stddev-sans-first:1547.97 02:06:02 INFO - PROCESS | 14487 | Values: 311.9 316.9 319.6 322.9 334.6 5910.4 5973.7 5979.4 5986.6 6040.3 5897.8 5914.4 5919.4 5919.6 5927.1 4380.4 4470.6 4471.1 4596.0 4600.4 4540.2 4575.4 4579.0 4579.2 4583.3 4527.9 4527.9 4528.1 4530.0 4537.8 4357.8 4446.8 4467.9 4530.7 4557.2 3994.8 4003.5 4013.0 4022.7 4032.5 5599.7 5634.1 5645.0 5647.0 5648.1 5261.6 5368.0 5370.7 5373.7 5376.8 6282.3 6298.2 6314.6 6321.5 6338.0 4454.5 4488.9 4490.3 4493.5 4494.7 6546.2 6576.1 6584.8 6585.7 6588.3 4511.0 4596.4 4604.4 4612.4 4622.9 4672.3 4674.5 4675.8 4677.5 4679.3 5340.4 5347.6 5350.5 5352.4 5353.6 6276.7 6372.0 6377.3 6379.4 6380.0 1608.8 1650.2 1655.4 1656.7 1656.9 1081.5 1086.7 1094.6 1103.1 1103.8 5960.2 5968.7 5972.3 5973.1 5974.9 6517.8 6525.0 6526.4 6530.9 6536.0 5947.2 5957.5 5962.9 5966.0 5969.7 3473.5 3554.0 3558.8 3560.7 3564.6 6676.5 6730.3 6730.5 6734.5 6739.4 6770.7 6780.5 6782.3 6787.0 6798.7 6523.5 6696.3 6700.1 6719.2 6727.2 6577.9 6587.5 6587.6 6587.8 6596.4 6408.7 6469.7 6480.4 6511.2 6520.3 6657.0 6659.9 6718.8 6721.1 6723.4 4485.1 4525.8 4528.3 4530.0 4532.8 6601.3 6607.0 6609.7 6611.9 6620.1 6270.9 6425.8 6425.8 6426.7 6438.5 6388.9 6393.8 6395.6 6396.7 6400.8 6273.2 6286.5 6287.8 6290.5 6290.6 5671.2 5952.3 6358.2 6385.1 6391.5 6257.6 6288.4 6288.9 6294.9 6298.7 02:06:02 INFO - PROCESS | 14487 | 02:06:02 INFO - PROCESS | 14487 | [#5] yui.html Cycles:180 Average:13244.29 Median:48643.14 stddev:15304.53 (31.5%) stddev-sans-first:15318.40 02:06:02 INFO - PROCESS | 14487 | Values: 685.1 712.5 720.8 723.7 750.2 13537.5 13655.9 13659.0 13685.5 13712.7 12361.7 12403.8 12450.9 12451.9 14082.2 821.8 837.8 838.2 838.5 838.5 821.2 824.8 828.3 829.3 829.7 869.8 874.0 874.7 874.7 875.1 866.2 868.6 869.6 871.4 874.2 639.3 641.3 641.6 642.0 642.4 13143.1 13152.6 13156.4 13160.1 13187.9 12453.9 12536.6 12544.4 12663.7 12680.6 10047.0 10281.1 10412.7 10530.8 10628.4 3598.9 3644.9 3663.8 3742.0 3742.6 43648.1 43719.6 43797.6 43861.0 43868.8 9513.5 9612.8 9688.7 9761.3 9793.4 17302.7 17304.3 17379.9 17396.7 17424.8 7025.6 7212.4 7373.9 7400.9 7683.1 4119.4 4178.9 4183.1 4190.7 4367.6 3040.3 3044.2 3071.2 3080.2 3086.0 524.1 574.7 580.0 592.6 606.8 550.3 559.9 571.8 640.5 663.2 8482.5 8601.0 8624.8 8729.2 8813.3 533.0 550.3 647.8 654.6 659.7 3951.6 3970.3 4016.7 4091.5 4096.3 54177.2 57753.4 57964.0 58113.7 58216.4 48219.3 49067.0 50252.7 50878.7 50972.2 39904.2 41761.8 42150.0 45167.0 45662.3 7801.6 8202.6 8278.1 8346.6 8496.7 34052.3 34127.0 34139.0 34172.5 34473.0 41212.4 41350.6 42053.4 44689.1 44781.3 9543.3 9732.3 9895.6 9904.3 10494.6 9865.2 10572.7 10979.1 11058.2 11801.9 10469.8 10496.5 10594.9 10898.2 11384.5 10721.7 10817.8 10847.4 10940.1 10953.5 10618.7 10853.0 10984.2 11177.4 11228.6 8641.3 8810.0 8961.6 9129.0 9220.5 7976.8 8227.6 8255.5 8594.2 8671.4 02:06:02 INFO - PROCESS | 14487 | -------- Summary: end -------- 02:06:02 INFO - PROCESS | 14487 | 02:06:03 INFO - TEST-INFO | 14487: exit 0 02:06:03 INFO - TEST-OK | dromaeo_css | took 1112389ms 02:06:03 INFO - TEST-START | kraken 02:06:03 INFO - operating with platform_type : linux_ 02:06:03 INFO - Initialising browser for kraken test... 02:06:03 INFO - TEST-INFO | started process 14683 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxj0a50/profile http://localhost:44873/getInfo.html) 02:06:06 INFO - PROCESS | 14683 | __metrics Screen width/height:1600/1200 02:06:06 INFO - PROCESS | 14683 | colorDepth:24 02:06:06 INFO - PROCESS | 14683 | Browser inner width/height: 1024/697 02:06:06 INFO - PROCESS | 14683 | __metrics 02:06:06 INFO - PROCESS | 14683 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:06:06 INFO - PROCESS | 14683 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:06:07 INFO - TEST-INFO | 14683: exit 0 02:06:07 INFO - Browser initialized. 02:06:07 INFO - Running cycle 1/1 for kraken test... 02:06:07 INFO - TEST-INFO | started process 14766 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxj0a50/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:06:19 INFO - PROCESS | 14766 | RSS: Main: 149790720 02:06:19 INFO - PROCESS | 14766 | 02:06:22 INFO - PROCESS | 14766 | Cycle 1(1): loaded http://localhost:44873/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44873/tests/kraken/driver.html?testName=audio-beat-detection) 02:06:22 INFO - PROCESS | 14766 | RSS: Main: 186748928 02:06:22 INFO - PROCESS | 14766 | 02:06:25 INFO - PROCESS | 14766 | Cycle 1(1): loaded http://localhost:44873/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44873/tests/kraken/driver.html?testName=audio-dft) 02:06:26 INFO - PROCESS | 14766 | RSS: Main: 174600192 02:06:26 INFO - PROCESS | 14766 | 02:06:28 INFO - PROCESS | 14766 | Cycle 1(1): loaded http://localhost:44873/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44873/tests/kraken/driver.html?testName=audio-fft) 02:06:29 INFO - PROCESS | 14766 | RSS: Main: 159801344 02:06:29 INFO - PROCESS | 14766 | 02:06:31 INFO - PROCESS | 14766 | Cycle 1(1): loaded http://localhost:44873/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44873/tests/kraken/driver.html?testName=audio-oscillator) 02:06:32 INFO - PROCESS | 14766 | RSS: Main: 164540416 02:06:32 INFO - PROCESS | 14766 | 02:06:34 INFO - PROCESS | 14766 | Cycle 1(1): loaded http://localhost:44873/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44873/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:06:34 INFO - PROCESS | 14766 | RSS: Main: 164225024 02:06:34 INFO - PROCESS | 14766 | 02:06:37 INFO - PROCESS | 14766 | Cycle 1(1): loaded http://localhost:44873/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44873/tests/kraken/driver.html?testName=imaging-darkroom) 02:06:38 INFO - PROCESS | 14766 | RSS: Main: 164225024 02:06:38 INFO - PROCESS | 14766 | 02:06:41 INFO - PROCESS | 14766 | Cycle 1(1): loaded http://localhost:44873/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44873/tests/kraken/driver.html?testName=imaging-desaturate) 02:06:42 INFO - PROCESS | 14766 | RSS: Main: 166576128 02:06:42 INFO - PROCESS | 14766 | 02:06:45 INFO - PROCESS | 14766 | Cycle 1(1): loaded http://localhost:44873/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44873/tests/kraken/driver.html?testName=json-parse-financial) 02:06:45 INFO - PROCESS | 14766 | RSS: Main: 166580224 02:06:45 INFO - PROCESS | 14766 | 02:06:47 INFO - PROCESS | 14766 | Cycle 1(1): loaded http://localhost:44873/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44873/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:06:47 INFO - PROCESS | 14766 | RSS: Main: 174624768 02:06:47 INFO - PROCESS | 14766 | 02:06:49 INFO - PROCESS | 14766 | Cycle 1(1): loaded http://localhost:44873/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44873/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:06:50 INFO - PROCESS | 14766 | RSS: Main: 173629440 02:06:50 INFO - PROCESS | 14766 | 02:06:52 INFO - PROCESS | 14766 | Cycle 1(1): loaded http://localhost:44873/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44873/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:06:52 INFO - PROCESS | 14766 | RSS: Main: 186871808 02:06:52 INFO - PROCESS | 14766 | 02:06:55 INFO - PROCESS | 14766 | Cycle 1(1): loaded http://localhost:44873/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44873/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:06:55 INFO - PROCESS | 14766 | RSS: Main: 194834432 02:06:55 INFO - PROCESS | 14766 | 02:06:58 INFO - PROCESS | 14766 | Cycle 1(1): loaded http://localhost:44873/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44873/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:06:58 INFO - PROCESS | 14766 | RSS: Main: 189403136 02:06:58 INFO - PROCESS | 14766 | 02:07:00 INFO - PROCESS | 14766 | Cycle 1(1): loaded http://localhost:44873/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44873/tests/kraken/driver.html?testName=ai-astar) 02:07:00 INFO - PROCESS | 14766 | RSS: Main: 246857728 02:07:00 INFO - PROCESS | 14766 | 02:07:00 INFO - PROCESS | 14766 | __start_tp_report 02:07:00 INFO - PROCESS | 14766 | _x_x_mozilla_page_load 02:07:00 INFO - PROCESS | 14766 | _x_x_mozilla_page_load_details 02:07:00 INFO - PROCESS | 14766 | |i|pagename|runs| 02:07:00 INFO - PROCESS | 14766 | |0;ai-astar;110;111;104;110;112;113;102;112;110;102 02:07:00 INFO - PROCESS | 14766 | |1;audio-beat-detection;152;128;149;163;129;151;157;127;173;134 02:07:00 INFO - PROCESS | 14766 | |2;audio-dft;160;159;161;161;164;161;161;165;161;162 02:07:00 INFO - PROCESS | 14766 | |3;audio-fft;75;72;84;100;72;71;71;129;95;75 02:07:00 INFO - PROCESS | 14766 | |4;audio-oscillator;96;97;150;96;97;97;142;95;96;143 02:07:00 INFO - PROCESS | 14766 | |5;imaging-gaussian-blur;109;110;110;110;110;110;110;111;110;109 02:07:00 INFO - PROCESS | 14766 | |6;imaging-darkroom;146;146;147;146;146;145;144;146;146;146 02:07:00 INFO - PROCESS | 14766 | |7;imaging-desaturate;95;96;96;96;96;95;96;95;97;96 02:07:00 INFO - PROCESS | 14766 | |8;json-parse-financial;59;57;58;58;59;57;57;67;55;57 02:07:00 INFO - PROCESS | 14766 | |9;json-stringify-tinderbox;67;67;67;69;68;68;68;68;68;68 02:07:00 INFO - PROCESS | 14766 | |10;stanford-crypto-aes;87;86;88;96;87;87;86;85;86;87 02:07:00 INFO - PROCESS | 14766 | |11;stanford-crypto-ccm;133;119;119;118;123;116;121;125;118;124 02:07:00 INFO - PROCESS | 14766 | |12;stanford-crypto-pbkdf2;144;144;152;164;155;143;154;147;153;141 02:07:00 INFO - PROCESS | 14766 | |13;stanford-crypto-sha256-iterative;71;69;68;67;68;68;70;70;69;69 02:07:00 INFO - PROCESS | 14766 | __end_tp_report 02:07:00 INFO - PROCESS | 14766 | __start_cc_report 02:07:00 INFO - PROCESS | 14766 | _x_x_mozilla_cycle_collect,908 02:07:00 INFO - PROCESS | 14766 | __end_cc_report 02:07:00 INFO - PROCESS | 14766 | __startTimestamp1451470020889__endTimestamp 02:07:00 INFO - PROCESS | 14766 | 02:07:00 INFO - PROCESS | 14766 | ------- Summary: start ------- 02:07:00 INFO - PROCESS | 14766 | Number of tests: 14 02:07:00 INFO - PROCESS | 14766 | 02:07:00 INFO - PROCESS | 14766 | [#0] ai-astar Cycles:10 Average:108.60 Median:110.50 stddev:4.25 (3.8%) stddev-sans-first:4.48 02:07:00 INFO - PROCESS | 14766 | Values: 110.0 111.0 104.0 110.0 112.0 113.0 102.0 112.0 110.0 102.0 02:07:00 INFO - PROCESS | 14766 | 02:07:00 INFO - PROCESS | 14766 | [#1] audio-beat-detection Cycles:10 Average:146.30 Median:151.50 stddev:16.08 (10.6%) stddev-sans-first:16.92 02:07:00 INFO - PROCESS | 14766 | Values: 152.0 128.0 149.0 163.0 129.0 151.0 157.0 127.0 173.0 134.0 02:07:00 INFO - PROCESS | 14766 | 02:07:00 INFO - PROCESS | 14766 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.00 stddev:1.78 (1.1%) stddev-sans-first:1.80 02:07:00 INFO - PROCESS | 14766 | Values: 160.0 159.0 161.0 161.0 164.0 161.0 161.0 165.0 161.0 162.0 02:07:00 INFO - PROCESS | 14766 | 02:07:00 INFO - PROCESS | 14766 | [#3] audio-fft Cycles:10 Average:84.40 Median:73.50 stddev:18.82 (25.6%) stddev-sans-first:19.65 02:07:00 INFO - PROCESS | 14766 | Values: 75.0 72.0 84.0 100.0 72.0 71.0 71.0 129.0 95.0 75.0 02:07:00 INFO - PROCESS | 14766 | 02:07:00 INFO - PROCESS | 14766 | [#4] audio-oscillator Cycles:10 Average:110.90 Median:96.00 stddev:23.63 (24.6%) stddev-sans-first:24.44 02:07:00 INFO - PROCESS | 14766 | Values: 96.0 97.0 150.0 96.0 97.0 97.0 142.0 95.0 96.0 143.0 02:07:00 INFO - PROCESS | 14766 | 02:07:00 INFO - PROCESS | 14766 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 02:07:00 INFO - PROCESS | 14766 | Values: 109.0 110.0 110.0 110.0 110.0 110.0 110.0 111.0 110.0 109.0 02:07:00 INFO - PROCESS | 14766 | 02:07:00 INFO - PROCESS | 14766 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 02:07:00 INFO - PROCESS | 14766 | Values: 146.0 146.0 147.0 146.0 146.0 145.0 144.0 146.0 146.0 146.0 02:07:00 INFO - PROCESS | 14766 | 02:07:00 INFO - PROCESS | 14766 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 02:07:00 INFO - PROCESS | 14766 | Values: 95.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 97.0 96.0 02:07:00 INFO - PROCESS | 14766 | 02:07:00 INFO - PROCESS | 14766 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:58.00 stddev:3.24 (5.6%) stddev-sans-first:3.43 02:07:00 INFO - PROCESS | 14766 | Values: 59.0 57.0 58.0 58.0 59.0 57.0 57.0 67.0 55.0 57.0 02:07:00 INFO - PROCESS | 14766 | 02:07:00 INFO - PROCESS | 14766 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 02:07:00 INFO - PROCESS | 14766 | Values: 67.0 67.0 67.0 69.0 68.0 68.0 68.0 68.0 68.0 68.0 02:07:00 INFO - PROCESS | 14766 | 02:07:00 INFO - PROCESS | 14766 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:87.00 stddev:3.10 (3.6%) stddev-sans-first:3.28 02:07:00 INFO - PROCESS | 14766 | Values: 87.0 86.0 88.0 96.0 87.0 87.0 86.0 85.0 86.0 87.0 02:07:00 INFO - PROCESS | 14766 | 02:07:00 INFO - PROCESS | 14766 | [#11] stanford-crypto-ccm Cycles:10 Average:121.60 Median:122.00 stddev:4.95 (4.1%) stddev-sans-first:3.08 02:07:00 INFO - PROCESS | 14766 | Values: 133.0 119.0 119.0 118.0 123.0 116.0 121.0 125.0 118.0 124.0 02:07:00 INFO - PROCESS | 14766 | 02:07:00 INFO - PROCESS | 14766 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.70 Median:152.50 stddev:7.15 (4.7%) stddev-sans-first:7.28 02:07:00 INFO - PROCESS | 14766 | Values: 144.0 144.0 152.0 164.0 155.0 143.0 154.0 147.0 153.0 141.0 02:07:00 INFO - PROCESS | 14766 | 02:07:00 INFO - PROCESS | 14766 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:1.20 (1.7%) stddev-sans-first:1.00 02:07:00 INFO - PROCESS | 14766 | Values: 71.0 69.0 68.0 67.0 68.0 68.0 70.0 70.0 69.0 69.0 02:07:00 INFO - PROCESS | 14766 | -------- Summary: end -------- 02:07:00 INFO - PROCESS | 14766 | 02:07:01 INFO - TEST-INFO | 14766: exit 0 02:07:01 INFO - TEST-OK | kraken | took 58642ms 02:07:01 INFO - TEST-START | v8_7 02:07:01 INFO - operating with platform_type : linux_ 02:07:01 INFO - Initialising browser for v8_7 test... 02:07:01 INFO - TEST-INFO | started process 15017 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcl8ut7/profile http://localhost:44873/getInfo.html) 02:07:05 INFO - PROCESS | 15017 | __metrics Screen width/height:1600/1200 02:07:05 INFO - PROCESS | 15017 | colorDepth:24 02:07:05 INFO - PROCESS | 15017 | Browser inner width/height: 1024/697 02:07:05 INFO - PROCESS | 15017 | __metrics 02:07:05 INFO - PROCESS | 15017 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:07:05 INFO - PROCESS | 15017 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:07:06 INFO - TEST-INFO | 15017: exit 0 02:07:06 INFO - Browser initialized. 02:07:06 INFO - Running cycle 1/1 for v8_7 test... 02:07:06 INFO - TEST-INFO | started process 15102 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcl8ut7/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:07:18 INFO - PROCESS | 15102 | RSS: Main: 150192128 02:07:18 INFO - PROCESS | 15102 | 02:07:39 INFO - PROCESS | 15102 | Cycle 1(1): loaded http://localhost:44873/tests/v8_7/run.html (next: http://localhost:44873/tests/v8_7/run.html) 02:07:39 INFO - PROCESS | 15102 | RSS: Main: 583421952 02:07:39 INFO - PROCESS | 15102 | 02:07:39 INFO - PROCESS | 15102 | __start_tp_report 02:07:39 INFO - PROCESS | 15102 | _x_x_mozilla_page_load 02:07:39 INFO - PROCESS | 15102 | _x_x_mozilla_page_load_details 02:07:39 INFO - PROCESS | 15102 | |i|pagename|runs| 02:07:39 INFO - PROCESS | 15102 | |0;Richards;167.64459346186086 02:07:39 INFO - PROCESS | 15102 | |1;DeltaBlue;190.11406844106463 02:07:39 INFO - PROCESS | 15102 | |2;Encrypt;280.0336040324839 02:07:39 INFO - PROCESS | 15102 | |3;Decrypt;5170.103092783505 02:07:39 INFO - PROCESS | 15102 | |4;RayTrace;1121.0762331838564 02:07:39 INFO - PROCESS | 15102 | |5;Earley;786.7820613690008 02:07:39 INFO - PROCESS | 15102 | |6;Boyer;11941.176470588236 02:07:39 INFO - PROCESS | 15102 | |7;RegExp;26051.28205128205 02:07:39 INFO - PROCESS | 15102 | |8;Splay;663.3532140490391 02:07:39 INFO - PROCESS | 15102 | |9;NavierStokes;4830.917874396136 02:07:39 INFO - PROCESS | 15102 | __end_tp_report 02:07:39 INFO - PROCESS | 15102 | __startTimestamp1451470059844__endTimestamp 02:07:39 INFO - PROCESS | 15102 | 02:07:39 INFO - PROCESS | 15102 | ------- Summary: start ------- 02:07:39 INFO - PROCESS | 15102 | Number of tests: 10 02:07:39 INFO - PROCESS | 15102 | 02:07:39 INFO - PROCESS | 15102 | [#0] Richards Cycles:1 Average:167.64 Median:167.64 stddev:0.00 (0.0%) 02:07:39 INFO - PROCESS | 15102 | Values: 167.6 02:07:39 INFO - PROCESS | 15102 | 02:07:39 INFO - PROCESS | 15102 | [#1] DeltaBlue Cycles:1 Average:190.11 Median:190.11 stddev:0.00 (0.0%) 02:07:39 INFO - PROCESS | 15102 | Values: 190.1 02:07:39 INFO - PROCESS | 15102 | 02:07:39 INFO - PROCESS | 15102 | [#2] Encrypt Cycles:1 Average:280.03 Median:280.03 stddev:0.00 (0.0%) 02:07:39 INFO - PROCESS | 15102 | Values: 280.0 02:07:39 INFO - PROCESS | 15102 | 02:07:39 INFO - PROCESS | 15102 | [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 02:07:39 INFO - PROCESS | 15102 | Values: 5170.1 02:07:39 INFO - PROCESS | 15102 | 02:07:39 INFO - PROCESS | 15102 | [#4] RayTrace Cycles:1 Average:1121.08 Median:1121.08 stddev:0.00 (0.0%) 02:07:39 INFO - PROCESS | 15102 | Values: 1121.1 02:07:39 INFO - PROCESS | 15102 | 02:07:39 INFO - PROCESS | 15102 | [#5] Earley Cycles:1 Average:786.78 Median:786.78 stddev:0.00 (0.0%) 02:07:39 INFO - PROCESS | 15102 | Values: 786.8 02:07:39 INFO - PROCESS | 15102 | 02:07:39 INFO - PROCESS | 15102 | [#6] Boyer Cycles:1 Average:11941.18 Median:11941.18 stddev:0.00 (0.0%) 02:07:39 INFO - PROCESS | 15102 | Values: 11941.2 02:07:39 INFO - PROCESS | 15102 | 02:07:39 INFO - PROCESS | 15102 | [#7] RegExp Cycles:1 Average:26051.28 Median:26051.28 stddev:0.00 (0.0%) 02:07:39 INFO - PROCESS | 15102 | Values: 26051.3 02:07:39 INFO - PROCESS | 15102 | 02:07:39 INFO - PROCESS | 15102 | [#8] Splay Cycles:1 Average:663.35 Median:663.35 stddev:0.00 (0.0%) 02:07:39 INFO - PROCESS | 15102 | Values: 663.4 02:07:39 INFO - PROCESS | 15102 | 02:07:39 INFO - PROCESS | 15102 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 02:07:39 INFO - PROCESS | 15102 | Values: 4830.9 02:07:39 INFO - PROCESS | 15102 | -------- Summary: end -------- 02:07:39 INFO - PROCESS | 15102 | 02:07:40 INFO - TEST-INFO | 15102: exit 0 02:07:40 INFO - TEST-OK | v8_7 | took 38865ms 02:07:40 INFO - SUITE-END | took 1209s 02:07:40 INFO - Completed test suite (00:20:10) 02:07:40 INFO - Working with test: dromaeo_css 02:07:40 INFO - Generating results file: dromaeo_css 02:07:40 INFO - Working with test: kraken 02:07:40 INFO - Generating results file: kraken 02:07:40 INFO - javascript benchmark 02:07:40 INFO - Working with test: v8_7 02:07:40 INFO - Generating results file: v8_7 02:07:40 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:07:41 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 02:07:41 INFO - process_Request line: dromaeo_css 6831.04 graph.html#tests=[[72,64,35]] 02:07:41 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:07:41 INFO - process_Request line: kraken 1517.10 graph.html#tests=[[232,64,35]] 02:07:41 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:07:41 INFO - process_Request line: v8_7 20827.76 graph.html#tests=[[230,64,35]] 02:07:41 INFO - RETURN: dromaeo_css: 6831.04 02:07:41 INFO - RETURN: kraken: 1517.10 02:07:41 INFO - RETURN: v8_7: 20827.76 02:07:41 INFO - javascript benchmark 02:07:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3141.638711548172, 3187.6652951440115, 3220.114468521158, 3222.5327327537507, 3253.2029652735077, 5233.842984710464, 5288.206768984654, 5310.15037593985, 5365.5975801814875, 5366.517013468787, 5187.559057480109, 5237.764300606473, 5281.313429254201, 5291.735413229342, 5295.0, 4762.738049407281, 4769.141554520185, 4793.520647935214, 4837.201861692834, 4848.093404546019, 4718.174319494092, 4882.877928051792, 4892.951070489303, 4906.31311616374, 4962.454130045692, 4789.353437285957, 4894.192458244385, 4894.975525122351, 4916.975415122937, 4938.333325001133, 4847.466778654345, 4850.151223535867, 4860.927086093711, 4874.195757699975, 4899.706017638953, 4750.786214620351, 4833.057553777015, 4845.152098382804, 4865.124277630025, 4893.902121957576, 5125.615578831603, 5130.897382052338, 5181.740912954375, 5260.342457192851, 5265.0, 5689.146628005791, 5689.772409103631, 5703.62926409782, 5704.77180912763, 5755.453231942959, 5707.857303567403, 5719.370869204384, 5723.484886360206, 5725.112607545837, 5731.713414329267, 5252.264682944391, 5281.313429254173, 5321.8935621287355, 5343.091674415358, 5382.6770393776105, 5785.971070144622, 5802.100674395476, 5810.535157187415, 5828.921649494857, 5835.649861008353, 5485.835424937259, 5565.1374037024325, 5576.247206627135, 5599.944000559943, 5637.46444087811, 5557.41647127054, 5687.971560142256, 5698.515626171822, 5699.2590963174525, 5719.456651618173, 5623.437656234344, 5683.602147849693, 5768.394318596571, 5773.971130144322, 5784.248047753765, 5655.745491452894, 5658.377578466448, 5659.236003139524, 5659.462351076641, 5660.405657405995, 4358.825646974149, 4375.037491751809, 4385.473743150778, 4387.14450682114, 4427.889302767457, 3881.9611803882162, 3933.4886464759397, 3965.18713663704, 3965.2267807777785, 3985.163115745726, 5279.788808447696, 5286.682799032071, 5291.074062039128, 5291.603129765283, 5292.391374991848, 5667.773289068474, 5744.195812586241, 5763.884722305615, 5769.9711501442225, 5782.3639399666, 5210.426853046162, 5222.8955420892125, 5284.0, 5311.123664595376, 5324.148136298174, 4891.26631005352, 4900.163405205057, 4901.0, 4901.877453063702, 4937.703737775745, 5725.713714314267, 5805.36141024487, 5809.970950145223, 5822.272215973004, 5823.359430462646, 5627.971860140673, 5689.971550142222, 5695.800646977336, 5728.513076388554, 5747.770089196552, 5741.45456181662, 5744.569157313134, 5749.0, 5756.827295181151, 5766.509846663081, 5468.316460442445, 5575.135853942646, 5587.720613969204, 5609.719514024201, 5624.634398764068, 5656.462636049569, 5674.233978413026, 5704.771809127588, 5710.857228569319, 5713.285839270091, 5545.279113715191, 5615.8876822464135, 5642.210090587403, 5693.886122277614, 5699.829005129853, 5584.916226256528, 5588.0, 5588.77644894216, 5589.664620122806, 5593.216949626974, 5325.573954083741, 5432.701201433801, 5495.065838807493, 5506.91739623898, 5546.473085056913, 5521.558275338044, 5550.111982082847, 5646.520045796154, 5650.491455769001, 5694.829155125353, 5434.076207044733, 5449.073657478318, 5451.236826844324, 5454.4545545445135, 5489.698066606375], "unit": "score", "name": "dojo.html", "value": 5243.536017032862}, {"lowerIsBetter": false, "replicates": [527.2039220776626, 529.9894002119958, 536.3670868375317, 551.1814954792133, 552.1662289942187, 28246.011389601368, 28886.422271554555, 35482.645173548226, 35861.0, 35888.461673074926, 37887.621123788755, 38216.617833821656, 38300.61699383005, 38310.23379532408, 38363.23273534528, 7385.409167266633, 8431.704890328825, 8559.48643081414, 8602.78493037676, 8606.78483037926, 7455.962720186391, 7570.8485830283635, 10097.091261786474, 10322.587096516168, 10325.53535090919, 9976.700698979042, 10065.345752526098, 10090.091891729742, 10091.0, 10098.394096354206, 7530.209328020534, 7710.074791025113, 9924.503774811266, 10007.949960250226, 10016.198704103654, 7337.779866604011, 10012.649557265533, 10252.94873525635, 10262.7434314142, 10270.7432314192, 35747.0, 36193.457098143546, 36245.0, 36265.09337266563, 36320.0919977, 3145.4495463293833, 3183.8567264473154, 3308.1894935740656, 3310.139363765414, 3769.830357633913, 27518.449631007268, 27822.0, 28413.857930710215, 28424.147275581767, 28425.57361639577, 3123.250419899208, 3194.244604316547, 3233.4826427771445, 3262.200760813616, 3280.1799550112473, 192687.0, 193143.0, 193238.0, 193345.0, 193542.0, 56863.43136568664, 58493.70753146207, 59276.70361648164, 59937.100943485886, 60572.39427605756, 53466.0, 53524.732376337866, 53738.0, 53791.19313210305, 53881.73059134679, 15104.169270689998, 15298.923505382401, 15299.46451874179, 15312.0, 15313.923430383, 11661.76676466483, 11684.47419866108, 11802.822957655642, 11805.822912656316, 11808.114391420679, 19103.0, 19843.60312793736, 19984.0, 20022.59954800896, 20031.699524507145, 7754.418418618626, 7773.961130194426, 7915.683372665029, 7942.920570794334, 7944.523328600302, 929.4609126706629, 997.581015973293, 1002.318423472046, 1012.9797404051877, 1026.235454586338, 25137.62293565598, 26604.0, 26819.463610727675, 27087.1873843785, 27192.728072719416, 1013.9847902281472, 1038.08129805123, 1109.5395410904546, 1120.9887901121047, 1151.6890439581266, 13987.580372588838, 15399.153046582545, 15504.457343992906, 15863.444779432664, 16189.838101618832, 304822.0, 309043.0, 309729.0, 309958.0, 310488.0, 51297.487025130016, 51518.0, 51665.48334516607, 51670.483295167316, 51715.74142129265, 1331.3476396565613, 1347.0772520823268, 1352.5468967895865, 1357.2874241023542, 1367.8016687580246, 27908.30229244285, 29111.272218194714, 29279.076963000567, 29515.0, 29750.851245743634, 45760.8815206633, 46328.768356158005, 46329.768351158025, 46333.0, 46361.304580430646, 282335.0, 288230.0, 289179.0, 299090.0, 299204.0, 29837.850810745807, 29930.401391972475, 29963.250918727208, 30013.549796752628, 30045.849770751007, 38454.42318365283, 39605.0, 39826.55235640967, 42636.0, 43064.0, 35311.64688353083, 35374.823125884206, 35660.46509302415, 35761.821190893876, 36610.45084323791, 35816.64183358133, 36371.81814090913, 36590.8170459146, 36646.26707465889, 36881.44677829781, 32807.83596082004, 35475.64524354723, 35952.28095438129, 36152.819235903655, 36169.276614468086, 27483.0, 29257.707422925498, 30973.0, 31273.37453250968, 31576.684233158292, 24155.15456958998, 24433.75566244315, 24514.87742561347, 24898.626520602567, 24920.750792491843], "unit": "score", "name": "ext.html", "value": 17919.009227331087}, {"lowerIsBetter": false, "replicates": [340.7614669731188, 346.05354355836766, 346.7382126494496, 347.8799814064147, 352.1969908608373, 14076.296185190726, 14560.854391456081, 16376.344946202153, 16464.259108340124, 17243.65512689747, 15051.6989660207, 15062.774058389134, 15066.54800355991, 15857.762133568005, 16250.75623865643, 5031.195008798602, 5322.973385133069, 5323.8136665216725, 5326.520613144816, 5330.813421530247, 3837.9424308635394, 3968.0, 5165.173572228444, 5607.271054762875, 5717.428257174291, 5661.8584535386535, 5678.353277549506, 5682.573806964473, 5686.317641882959, 5726.742296596663, 5562.610617256793, 5759.769609215627, 5777.682227477487, 5781.161731548944, 5782.56630752691, 5077.035363280965, 5093.694378337312, 5094.235864620299, 5103.0, 5108.7445627718835, 15225.61935951599, 15232.466863659718, 16019.11894845783, 17799.73300400495, 19983.80016199834, 2135.530183359658, 2197.6923230747707, 2222.9444263893533, 2275.2719129878446, 2529.190658989124, 12860.228386296852, 13284.933575332061, 13335.133216340906, 13337.799933001013, 13580.0, 1689.2736123466905, 1721.7933847938202, 1760.0319824096696, 1802.97295540567, 1875.5029917071986, 57938.0, 58801.70599146977, 61169.38830611726, 61417.38582614161, 61476.692616537075, 9769.560369783234, 9935.416791634083, 10028.147607453448, 10118.747031324128, 10156.542955567018, 13044.217346959213, 13053.804192937114, 13066.608001759962, 13085.08404411682, 13168.341582920815, 7674.232576742281, 7707.884381734279, 7749.225077492319, 7809.375249980101, 7900.170482099412, 7412.740554080689, 7482.139553951257, 7501.0, 7509.436792240604, 7546.434017448713, 5967.850803729942, 6022.0, 6030.638161710312, 6058.878822423527, 6119.663418512025, 1638.6231166831697, 1707.6926153292527, 1731.5930756272267, 1748.3793253395115, 1764.461839139075, 900.9234215091791, 905.1988989743992, 913.7532866126242, 1027.9331843430152, 1084.7233955341337, 14927.40290388394, 16014.91992540053, 17055.48833534996, 17257.482275531755, 17842.643147136983, 890.0965519997208, 908.2779190543533, 972.5915115651443, 974.8927617962019, 1028.5114570578914, 9200.631974721071, 9335.533223338805, 9412.67055653049, 9438.622455101857, 9500.42997420157, 498274.0, 505143.0, 506751.0, 512043.0, 582129.0, 38490.80754596209, 38653.0, 63159.684201579614, 75505.24494755092, 76828.61585692035, 1146.3752255021034, 1152.1992215410378, 1159.3044173495834, 1171.7246447084929, 1171.9355435451132, 13995.720085598434, 14458.710825783635, 14523.0, 14586.819330589155, 14597.489087881873, 30918.69081309158, 31453.8427307862, 32345.0, 32720.0, 32860.0, 45022.0, 45950.31074533951, 47216.527834721215, 48321.5167848317, 50395.0, 9392.168527137143, 9469.431834089977, 9552.808943820946, 9559.522023898639, 9576.186024188022, 11356.659300221007, 11418.714532136431, 13191.736165276832, 13435.932820335836, 17977.370792022215, 14081.788773168206, 14184.787228191379, 14314.642133946318, 14665.633359166106, 14954.850451495346, 14117.08238964464, 14155.787663185267, 14211.147331160164, 14252.857471425154, 14361.281935902955, 13586.524471643444, 14634.902382321581, 14688.55934321972, 15121.470748523749, 15165.92417037952, 9507.049295070437, 9520.381175223589, 9547.28395370364, 9700.805983880424, 9720.222382209266, 13656.112352697042, 14254.714905701621, 14526.636834079232, 14555.345009474388, 14851.257437128317], "unit": "score", "name": "jquery.html", "value": 8777.575782829907}, {"lowerIsBetter": false, "replicates": [1271.1292764456355, 1410.8941829362798, 1413.3145424469135, 1549.5893588199128, 1781.1895587507686, 6584.111144995424, 7119.216886142527, 7169.462290328227, 7181.9281807181915, 7214.927850721491, 7038.401735852446, 7182.389496892771, 7189.928100718991, 7209.963950180255, 7216.314450127243, 1975.4172519106826, 1998.1308130963005, 2183.5960347335713, 2194.5281764420647, 2228.0419419649543, 2243.2260869999823, 2248.5053288276554, 2249.718785151856, 2251.7297924249033, 2253.4929640830765, 2138.9786102139014, 2207.6798864164684, 2207.9558408831813, 2213.5904857601395, 2213.5904857601395, 2180.0407820558903, 2207.4591725027312, 2208.8785116818567, 2224.3549370682563, 2235.452314183019, 2244.2706120510734, 2251.5609456155894, 2285.4971906180613, 2289.610766169755, 2303.4011157099108, 7035.542689725152, 7089.574625522434, 7095.538789978635, 7103.360697537195, 7108.182559005729, 4478.641708663299, 4546.704464209849, 4551.089782043605, 4559.772011399416, 4571.588557029883, 2816.2114607909816, 2860.7139286071433, 2862.699416561252, 2866.942661146786, 3042.589250451205, 883.491992104536, 895.5208963204655, 896.4486840592988, 915.1306259053925, 1685.148999755128, 9726.124648781573, 9836.950815245878, 9843.803123937481, 9848.507574621312, 9850.21198304141, 4030.234255491447, 4102.651274641689, 4160.625543701081, 4167.374893765959, 4191.413202151702, 8104.149064348277, 8138.633761480747, 8146.592670366458, 8221.506709597443, 8221.54781487024, 4599.517050709695, 4600.95399046012, 4604.40142781443, 4626.653001024936, 4628.490866004737, 4304.053108316165, 4309.439772829513, 4351.456067991501, 4357.237483440385, 4362.105768317488, 3204.1348835814665, 3230.402375560529, 3366.848491817874, 3408.0, 3445.2248244145367, 1094.075506197262, 1100.3068067117824, 1108.939008354532, 1121.6691076132397, 1125.4035361258545, 1096.276457538021, 1159.1248607301434, 1268.9619311420672, 1272.688191393096, 1277.8977681785434, 6933.965330173418, 6992.510524263253, 6995.650217489105, 7010.649467526603, 7011.92988070123, 593.3087952535334, 597.4384078965759, 598.8293336399105, 602.3314121325326, 744.4230721191012, 5417.187421886749, 5442.265294185314, 5552.083906155439, 5560.972195138998, 5562.137868630288, 8705.695300664447, 8996.955015224881, 9006.144416280444, 9011.549422528848, 9013.864792028126, 8901.198892099743, 8915.643374265086, 8915.910840891638, 8920.73237802867, 8924.0, 6916.0, 7026.789196324118, 7042.154941406961, 7065.0815393998455, 7112.786616401516, 6893.862122757617, 6910.723571057101, 6930.203026652, 6932.7226910923, 6942.132233470817, 7660.119086305146, 7742.380609551335, 7915.05019397676, 7922.881156782768, 7938.920610793818, 8123.228293312126, 8236.094029656853, 8243.587820608825, 8245.587720614065, 8259.091499935123, 6231.1276421300145, 6399.424051835357, 6415.294317625151, 6418.614883107029, 6427.228732552124, 6141.0, 6228.626282423069, 6707.195136583641, 6867.244603093556, 6872.965635171792, 6254.562180647311, 6456.580322279036, 6461.127747754181, 6506.902396464152, 6690.83272918181, 6309.7160627770945, 6390.392912673288, 6432.839179020562, 6569.967150164219, 6591.14315139048, 6446.967765161145, 6460.903086453613, 6500.967495162494, 6511.055896894829, 6511.837204069747, 6038.943184942706, 6063.181470501426, 6063.818085457443, 6091.695415229309, 6093.725782339894, 6021.0, 6111.633302001894, 6124.846878828065, 6129.754809807736, 6148.200733904564], "unit": "score", "name": "mootools.html", "value": 4208.476767866347}, {"lowerIsBetter": false, "replicates": [311.9204602826279, 316.87958575741214, 319.58773182594456, 322.85955609309946, 334.5583829345264, 5910.379410161936, 5973.701314934252, 5979.37216592257, 5986.551008674345, 6040.30536488304, 5897.793577224798, 5914.378990206031, 5919.37846526115, 5919.585629005971, 5927.140564618127, 4380.364847097169, 4470.619997300217, 4471.105778844228, 4595.977020114895, 4600.424946881648, 4540.228161212602, 4575.428071491064, 4578.97710511447, 4579.198640237962, 4583.335416364625, 4527.886802829923, 4527.886802829939, 4528.0943811237885, 4529.977350113261, 4537.8184872605225, 4357.782110894443, 4446.822127114911, 4467.888302792456, 4530.660200484944, 4557.225271703818, 3994.7603143811466, 4003.539592946819, 4012.959870401317, 4022.7184097113213, 4032.495938007749, 5599.664020158803, 5634.0703783875615, 5645.040343141676, 5647.040003199466, 5648.096304591287, 5261.631685781997, 5367.973160134214, 5370.731463426852, 5373.704446255454, 5376.838694839161, 6282.340354262782, 6298.2442106947, 6314.62112273265, 6321.494280457552, 6338.0, 4454.465464144323, 4488.865334039951, 4490.348899409567, 4493.5281795411665, 4494.68537202396, 6546.18172728409, 6576.145101136822, 6584.835379115512, 6585.703643336014, 6588.308227636077, 4510.954890451119, 4596.4254468191475, 4604.434492272643, 4612.377329060601, 4622.930656040162, 4672.252439609714, 4674.485806561275, 4675.766211689402, 4677.508861569554, 4679.321498382784, 5340.385855626575, 5347.572194224453, 5350.5184533392185, 5352.411234764173, 5353.598480114007, 6276.717547710364, 6371.96814015927, 6377.266614339411, 6379.393957574023, 6380.042993551005, 1608.8069431668275, 1650.2408891909615, 1655.370959035583, 1656.7100757367411, 1656.9254383552768, 1081.5457507846722, 1086.6631344283298, 1094.5676457799125, 1103.0789290941993, 1103.773726386089, 5960.195373624592, 5968.671723055274, 5972.25346831646, 5973.104034394789, 5974.85062873423, 6517.804465865936, 6524.967375163189, 6526.412622863965, 6530.869382612321, 6536.0, 5947.197128387612, 5957.493613042853, 5962.910556341659, 5966.0454327307425, 5969.701514924236, 3473.5484387029524, 3554.0, 3558.8042657654078, 3560.6795388415167, 3564.625714300013, 6676.499262555328, 6730.293319201512, 6730.528862979642, 6734.528582999143, 6739.393454589111, 6770.69531871067, 6780.457563394916, 6782.253952065269, 6786.966065169741, 6798.694058767268, 6523.510736694672, 6696.2968888267005, 6700.095487109178, 6719.227288861745, 6727.192736871509, 6577.934220657732, 6587.505937054644, 6587.604743715392, 6587.802365928838, 6596.406323430914, 6408.711607977559, 6469.676516174267, 6480.384363485461, 6511.186101737283, 6520.282768895323, 6657.0361743284875, 6659.900101498578, 6718.764843230463, 6721.050895240521, 6723.428508576826, 4485.080558485568, 4525.773711314487, 4528.320751887111, 4529.977350113229, 4532.796024178854, 6601.273859875506, 6606.966965165144, 6609.735610575715, 6611.933880661132, 6620.106285651375, 6270.905936411049, 6425.775097871552, 6425.839354016187, 6426.742930282736, 6438.5171112165835, 6388.87222255543, 6393.808185754435, 6395.552311338161, 6396.712147953446, 6400.775972840928, 6273.215848018997, 6286.497080233662, 6287.842803929939, 6290.465310448663, 6290.622562646256, 5671.206031155559, 5952.280079150959, 6358.1734374531015, 6385.074164246251, 6391.520635952415, 6257.561970662192, 6288.434040936338, 6288.905666414916, 6294.905576416449, 6298.685065746603], "unit": "score", "name": "prototype.html", "value": 4784.8891785933565}, {"lowerIsBetter": false, "replicates": [685.0785693242593, 712.4976891291639, 720.7513407874283, 723.7249845058877, 750.2010358967699, 13537.52618658346, 13655.863441365584, 13659.0, 13685.452581896738, 13712.725745485097, 12361.690957726061, 12403.751924961496, 12450.937745311283, 12451.875481245184, 14082.155070695766, 821.7657967479255, 837.7863644770575, 838.1660248053196, 838.4591938199858, 838.5262326785378, 821.2280456371022, 824.8309096635205, 828.2835347424494, 829.2785276809185, 829.7261903571837, 869.8390797702414, 874.0472884555833, 874.6501399440211, 874.6938571499987, 875.0855356152836, 866.1987661413231, 868.5526953618892, 869.5739087846973, 871.3900269811157, 874.2481465939319, 639.3287048598999, 641.2913730327967, 641.6278558436096, 642.00809748938, 642.3544337940386, 13143.079984401096, 13152.605421837361, 13156.40796164175, 13160.144590601676, 13187.86812131876, 12453.93773031129, 12536.561220357244, 12544.435500402504, 12663.746725065446, 12680.556180533637, 10047.0, 10281.074703276741, 10412.68761937143, 10530.78938421235, 10628.415437150954, 3598.8560457581925, 3644.890653280406, 3663.7618554793853, 3742.0, 3742.5883152853435, 43648.12703745939, 43719.56280437187, 43797.562024379986, 43861.0, 43868.78065609683, 9513.524323783922, 9612.75968100789, 9688.660896868576, 9761.316707830383, 9793.363431376938, 17302.740458893128, 17304.307827686753, 17379.91310043467, 17396.65206695859, 17424.82575174232, 7025.648717564101, 7212.423006159494, 7373.88939165913, 7400.925990740131, 7683.116441609175, 4119.443875076826, 4178.937315940263, 4183.1215444756335, 4190.664746820247, 4367.563243675607, 3040.3159289160203, 3044.2237229506336, 3071.1707838883376, 3080.245339891696, 3086.0, 524.0880867290887, 574.7384939852441, 579.956503262257, 592.599995003371, 606.7845914700218, 550.3368441028551, 559.8880223955225, 571.7798647520734, 640.5324113397246, 663.1660736114292, 8482.533460659723, 8601.0, 8624.827503449897, 8729.214370706666, 8813.25087367568, 532.9946700532945, 550.3231025838242, 647.7668039505775, 654.5745265577318, 659.6536818170499, 3951.585083566184, 3970.285348637215, 4016.6786657067364, 4091.5499295077516, 4096.26267271888, 54177.1873421899, 57753.42246577564, 57964.0, 58113.709431452575, 58216.41783582194, 48219.276710849364, 49067.0, 50252.74873625681, 50878.74560627173, 50972.235416468786, 39904.201915961516, 41761.79119104446, 42150.0, 45167.0, 45662.315065274044, 7801.570913599807, 8202.630881610223, 8278.130796266547, 8346.582670866312, 8496.745097647081, 34052.31895362029, 34127.0, 34139.0, 34172.48741268833, 34473.0, 41212.38181427341, 41350.58649413467, 42053.36919946142, 44689.10621787611, 44781.32828007648, 9543.33196676226, 9732.318737688294, 9895.554700038372, 9904.306698531034, 10494.632687856194, 9865.161461275871, 10572.682819515427, 10979.1216702662, 11058.171415538984, 11801.881981180079, 10469.842952355873, 10496.527656255334, 10594.894051059391, 10898.18263630215, 11384.487698053774, 10721.678349649523, 10817.837732433862, 10847.403392813156, 10940.124790016938, 10953.45232738344, 10618.73453163677, 10853.0, 10984.176186786182, 11177.441127943734, 11228.606998755004, 8641.308695304486, 8810.0, 8961.641534338814, 9129.0, 9220.492872892055, 7976.800579985546, 8227.629756661085, 8255.463394879314, 8594.183552562497, 8671.4363566368], "unit": "score", "name": "yui.html", "value": 6117.458885360033}], "name": "dromaeo_css", "value": 6831.039377346332}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 104.0, 110.0, 112.0, 113.0, 102.0, 112.0, 110.0, 102.0], "unit": "score", "name": "ai-astar", "value": 108.6}, {"lowerIsBetter": true, "replicates": [152.0, 128.0, 149.0, 163.0, 129.0, 151.0, 157.0, 127.0, 173.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 146.3}, {"lowerIsBetter": true, "replicates": [160.0, 159.0, 161.0, 161.0, 164.0, 161.0, 161.0, 165.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [75.0, 72.0, 84.0, 100.0, 72.0, 71.0, 71.0, 129.0, 95.0, 75.0], "unit": "score", "name": "audio-fft", "value": 84.4}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 150.0, 96.0, 97.0, 97.0, 142.0, 95.0, 96.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 110.9}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 145.0, 144.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [59.0, 57.0, 58.0, 58.0, 59.0, 57.0, 57.0, 67.0, 55.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 58.4}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 69.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 88.0, 96.0, 87.0, 87.0, 86.0, 85.0, 86.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.5}, {"lowerIsBetter": true, "replicates": [133.0, 119.0, 119.0, 118.0, 123.0, 116.0, 121.0, 125.0, 118.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.6}, {"lowerIsBetter": true, "replicates": [144.0, 144.0, 152.0, 164.0, 155.0, 143.0, 154.0, 147.0, 153.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.7}, {"lowerIsBetter": true, "replicates": [71.0, 69.0, 68.0, 67.0, 68.0, 68.0, 70.0, 70.0, 69.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1517.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.64459346186086], "unit": "score", "name": "Richards", "value": 210.57643000000002}, {"lowerIsBetter": false, "replicates": [190.11406844106463], "unit": "score", "name": "DeltaBlue", "value": 347.7806799999999}, {"lowerIsBetter": false, "replicates": [280.0336040324839], "unit": "score", "name": "Encrypt", "value": 950.5323509999997}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [1121.0762331838564], "unit": "score", "name": "RayTrace", "value": 660.070188}, {"lowerIsBetter": false, "replicates": [786.7820613690008], "unit": "score", "name": "Earley", "value": 847.0744729999998}, {"lowerIsBetter": false, "replicates": [11941.176470588236], "unit": "score", "name": "Boyer", "value": 55.812172413793114}, {"lowerIsBetter": false, "replicates": [26051.28205128205], "unit": "score", "name": "RegExp", "value": 34.96891240157479}, {"lowerIsBetter": false, "replicates": [663.3532140490391], "unit": "score", "name": "Splay", "value": 122.84707192807188}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20827.75963209423}]} 02:07:41 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20827.76"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1517.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6831.04"}}} 02:07:41 INFO - Return code: 0 02:07:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 02:07:41 INFO - # TBPL SUCCESS # 02:07:41 INFO - Running post-action listener: _resource_record_post_action 02:07:41 INFO - Running post-run listener: _resource_record_post_run 02:07:42 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 4096; Write bytes: 545443840; Read time: 8; Write time: 527980 02:07:42 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 235270144; Read time: 0; Write time: 305216 02:07:42 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 309895168; Read time: 8; Write time: 222736 02:07:42 INFO - Running post-run listener: _upload_blobber_files 02:07:42 INFO - Blob upload gear active. 02:07:42 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 02:07:42 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:07:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 02:07:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 02:07:42 INFO - (blobuploader) - INFO - Open directory for files ... 02:07:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:07:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:07:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:07:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:07:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:07:43 INFO - (blobuploader) - INFO - Done attempting. 02:07:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 02:07:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:07:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:07:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:07:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:07:44 INFO - (blobuploader) - INFO - Done attempting. 02:07:44 INFO - (blobuploader) - INFO - Iteration through files over. 02:07:44 INFO - Return code: 0 02:07:44 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 02:07:44 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 02:07:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b496b31082622641b2a74b370cb493fcac27ed99fc9ac1888250ac62b0cc1c771d3b270f543f2af654d18a748dbf13290d9012aadc50a53d934b47b4aeab63c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ad7ca967e111df6aef51bec9946cc54d15e44499d378142a4303608643313f37bdfb6317e28b1cd80085be7a03a7300d7b32db4b06e9dd1b2fe0bed32d03e35b"} 02:07:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 02:07:44 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 02:07:44 INFO - Contents: 02:07:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b496b31082622641b2a74b370cb493fcac27ed99fc9ac1888250ac62b0cc1c771d3b270f543f2af654d18a748dbf13290d9012aadc50a53d934b47b4aeab63c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ad7ca967e111df6aef51bec9946cc54d15e44499d378142a4303608643313f37bdfb6317e28b1cd80085be7a03a7300d7b32db4b06e9dd1b2fe0bed32d03e35b"} 02:07:44 INFO - Copying logs to upload dir... 02:07:44 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1278.230557 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2015-12-30 02:07:43.963386) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 02:07:43.970673) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1451467931.220899-2012922020 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/9b496b31082622641b2a74b370cb493fcac27ed99fc9ac1888250ac62b0cc1c771d3b270f543f2af654d18a748dbf13290d9012aadc50a53d934b47b4aeab63c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ad7ca967e111df6aef51bec9946cc54d15e44499d378142a4303608643313f37bdfb6317e28b1cd80085be7a03a7300d7b32db4b06e9dd1b2fe0bed32d03e35b"} build_url:https://queue.taskcluster.net/v1/task/a6SmKlwqTXCQM-iMHV0yxg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011244 build_url: 'https://queue.taskcluster.net/v1/task/a6SmKlwqTXCQM-iMHV0yxg/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/9b496b31082622641b2a74b370cb493fcac27ed99fc9ac1888250ac62b0cc1c771d3b270f543f2af654d18a748dbf13290d9012aadc50a53d934b47b4aeab63c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ad7ca967e111df6aef51bec9946cc54d15e44499d378142a4303608643313f37bdfb6317e28b1cd80085be7a03a7300d7b32db4b06e9dd1b2fe0bed32d03e35b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 02:07:44.001862) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 02:07:44.002428) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1451467931.220899-2012922020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 02:07:44.085409) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 02:07:44.085935) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 02:07:44.086408) ========= ========= Total master_lag: 0.30 =========