builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-033 starttime: 1452278904.63 results: success (0) buildid: 20160108083146 builduid: a6a61b1bff174f2ebb3b450892fba5f1 revision: deaf711a7bc8a8cb604666b0e4e7a91edc90018e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-08 10:48:24.627565) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-08 10:48:24.628091) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-08 10:48:24.628379) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1452278550.739751-76097925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006376 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-08 10:48:24.657763) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-08 10:48:24.658043) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-08 10:48:24.684574) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 10:48:24.684861) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1452278550.739751-76097925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004639 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 10:48:24.733242) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-08 10:48:24.733523) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-08 10:48:24.733870) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 10:48:24.734140) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1452278550.739751-76097925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-08 10:48:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.2M=0s 2016-01-08 10:48:25 (47.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.210979 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 10:48:24.957260) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 10:48:24.957560) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1452278550.739751-76097925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014497 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 10:48:25.007787) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 10:48:25.008119) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev deaf711a7bc8a8cb604666b0e4e7a91edc90018e --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 deaf711a7bc8a8cb604666b0e4e7a91edc90018e --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=edae0fb5fee9fb758e8af6d3000002a4-1452278550.739751-76097925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-08 10:48:25,327 truncating revision to first 12 chars 2016-01-08 10:48:25,327 Setting DEBUG logging. 2016-01-08 10:48:25,327 attempt 1/10 2016-01-08 10:48:25,327 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/deaf711a7bc8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-08 10:48:25,609 unpacking tar archive at: fx-team-deaf711a7bc8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.539607 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 10:48:25.560587) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-08 10:48:25.560932) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-08 10:48:25.568265) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-08 10:48:25.568525) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-08 10:48:25.568922) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-08 10:48:25.569210) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1452278550.739751-76097925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:48:25 INFO - MultiFileLogger online at 20160108 10:48:25 in /builds/slave/test-pgo 10:48:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 10:48:25 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:48:25 INFO - {'append_to_log': False, 10:48:25 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:48:25 INFO - 'blob_upload_branch': 'Fx-Team', 10:48:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:48:25 INFO - 'branch': 'Fx-Team', 10:48:25 INFO - 'buildbot_json_path': 'buildprops.json', 10:48:25 INFO - 'config_files': ('talos/linux_config.py',), 10:48:25 INFO - 'default_actions': ('clobber', 10:48:25 INFO - 'read-buildbot-config', 10:48:25 INFO - 'download-and-extract', 10:48:25 INFO - 'populate-webroot', 10:48:25 INFO - 'create-virtualenv', 10:48:25 INFO - 'install', 10:48:25 INFO - 'run-tests'), 10:48:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:48:25 INFO - 'download_minidump_stackwalk': True, 10:48:25 INFO - 'download_symbols': 'ondemand', 10:48:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:48:25 INFO - 'tooltool.py': '/tools/tooltool.py', 10:48:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:48:25 INFO - '/tools/misc-python/virtualenv.py')}, 10:48:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:48:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:48:25 INFO - 'installer_path': 'installer.exe', 10:48:25 INFO - 'log_level': 'info', 10:48:25 INFO - 'log_name': 'talos', 10:48:25 INFO - 'log_to_console': True, 10:48:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:48:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:48:25 INFO - 'opt_config_files': (), 10:48:25 INFO - 'pip_index': False, 10:48:25 INFO - 'sps_profile': False, 10:48:25 INFO - 'sps_profile_interval': 0, 10:48:25 INFO - 'suite': 'dromaeojs-e10s', 10:48:25 INFO - 'system_bits': '32', 10:48:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:48:25 INFO - 'title': 'talos-linux64-ix-033', 10:48:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:48:25 INFO - 'use_talos_json': True, 10:48:25 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:48:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:48:25 INFO - 'work_dir': 'build'} 10:48:25 INFO - ##### 10:48:25 INFO - ##### Running clobber step. 10:48:25 INFO - ##### 10:48:25 INFO - Running pre-action listener: _resource_record_pre_action 10:48:25 INFO - Running main action method: clobber 10:48:25 INFO - rmtree: /builds/slave/test-pgo/build 10:48:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:48:26 INFO - Running post-action listener: _resource_record_post_action 10:48:26 INFO - ##### 10:48:26 INFO - ##### Running read-buildbot-config step. 10:48:26 INFO - ##### 10:48:26 INFO - Running pre-action listener: _resource_record_pre_action 10:48:26 INFO - Running main action method: read_buildbot_config 10:48:26 INFO - Using buildbot properties: 10:48:26 INFO - { 10:48:26 INFO - "project": "", 10:48:26 INFO - "product": "firefox", 10:48:26 INFO - "script_repo_revision": "production", 10:48:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 10:48:26 INFO - "repository": "", 10:48:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 10:48:26 INFO - "buildid": "20160108083146", 10:48:26 INFO - "pgo_build": "True", 10:48:26 INFO - "basedir": "/builds/slave/test-pgo", 10:48:26 INFO - "buildnumber": 430, 10:48:26 INFO - "slavename": "talos-linux64-ix-033", 10:48:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:48:26 INFO - "platform": "ubuntu64_hw", 10:48:26 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 10:48:26 INFO - "branch": "fx-team", 10:48:26 INFO - "repo_path": "integration/fx-team", 10:48:26 INFO - "revision": "deaf711a7bc8a8cb604666b0e4e7a91edc90018e", 10:48:26 INFO - "stage_platform": "linux64-pgo", 10:48:26 INFO - "builduid": "a6a61b1bff174f2ebb3b450892fba5f1", 10:48:26 INFO - "slavebuilddir": "test" 10:48:26 INFO - } 10:48:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/JoVNINrqRRezQG5raw0M6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 10:48:26 INFO - Running post-action listener: _resource_record_post_action 10:48:26 INFO - ##### 10:48:26 INFO - ##### Running download-and-extract step. 10:48:26 INFO - ##### 10:48:26 INFO - Running pre-action listener: _resource_record_pre_action 10:48:26 INFO - Running main action method: download_and_extract 10:48:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:48: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')]} 10:48:26 INFO - https://queue.taskcluster.net/v1/task/JoVNINrqRRezQG5raw0M6A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:48:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoVNINrqRRezQG5raw0M6A/artifacts/public/build/test_packages.json 10:48:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoVNINrqRRezQG5raw0M6A/artifacts/public/build/test_packages.json 10:48:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoVNINrqRRezQG5raw0M6A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:48:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoVNINrqRRezQG5raw0M6A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:48:27 INFO - Downloaded 1302 bytes. 10:48:27 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:48:27 INFO - Using the following test package requirements: 10:48:27 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:48:27 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:48:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:48:27 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:48:27 INFO - u'jsshell-linux-x86_64.zip'], 10:48:27 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:48:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:48:27 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:48:27 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:48:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:48:27 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:48:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:48:27 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:48:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:48:27 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:48:27 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:48:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:48:27 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:48:27 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')]} 10:48:27 INFO - https://queue.taskcluster.net/v1/task/JoVNINrqRRezQG5raw0M6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:48:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoVNINrqRRezQG5raw0M6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:48:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoVNINrqRRezQG5raw0M6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:48:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoVNINrqRRezQG5raw0M6A/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 10:48:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoVNINrqRRezQG5raw0M6A/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 10:48:29 INFO - Downloaded 24025563 bytes. 10:48:29 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 10:48:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:48:29 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 10:48:30 INFO - Return code: 0 10:48:30 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 10:48:30 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')]} 10:48:30 INFO - https://queue.taskcluster.net/v1/task/JoVNINrqRRezQG5raw0M6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:48:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoVNINrqRRezQG5raw0M6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:48:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoVNINrqRRezQG5raw0M6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:48:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoVNINrqRRezQG5raw0M6A/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 10:48:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoVNINrqRRezQG5raw0M6A/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 10:48:35 INFO - Downloaded 24025563 bytes. 10:48:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 10:48:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:48:35 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:48:36 INFO - Return code: 0 10:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:48:36 INFO - https://queue.taskcluster.net/v1/task/JoVNINrqRRezQG5raw0M6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:48:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoVNINrqRRezQG5raw0M6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:48:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoVNINrqRRezQG5raw0M6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:48:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoVNINrqRRezQG5raw0M6A/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 10:48:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoVNINrqRRezQG5raw0M6A/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 10:48:37 INFO - Downloaded 11132285 bytes. 10:48:37 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 10:48:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:48:37 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 10:48:38 INFO - Return code: 0 10:48:38 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')]} 10:48:38 INFO - https://queue.taskcluster.net/v1/task/JoVNINrqRRezQG5raw0M6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:48:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoVNINrqRRezQG5raw0M6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:48:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoVNINrqRRezQG5raw0M6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:48:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoVNINrqRRezQG5raw0M6A/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 10:48:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JoVNINrqRRezQG5raw0M6A/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 10:48:39 INFO - Downloaded 55784035 bytes. 10:48:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JoVNINrqRRezQG5raw0M6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:48:39 INFO - mkdir: /builds/slave/test-pgo/properties 10:48:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:48:39 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:48:39 INFO - Contents: 10:48:39 INFO - build_url:https://queue.taskcluster.net/v1/task/JoVNINrqRRezQG5raw0M6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:48:39 INFO - Running post-action listener: _resource_record_post_action 10:48:39 INFO - Running post-action listener: set_extra_try_arguments 10:48:39 INFO - ##### 10:48:39 INFO - ##### Running populate-webroot step. 10:48:39 INFO - ##### 10:48:39 INFO - Running pre-action listener: _resource_record_pre_action 10:48:39 INFO - Running main action method: populate_webroot 10:48:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:48:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:48:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:48:39 INFO - '--tppagecycles', 10:48:39 INFO - '7'], 10:48:39 INFO - 'tests': ['tsvgm']}}, 10:48:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:48:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:48:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:48:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:48:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:48:39 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:48:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:48:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:39 INFO - 'talos_options': ['--e10s'], 10:48:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:48:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:39 INFO - 'tests': ['damp', 'tps']}, 10:48:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:39 INFO - 'talos_options': ['--e10s'], 10:48:39 INFO - 'tests': ['damp', 'tps']}, 10:48:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:48:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:48:39 INFO - 'other': {'tests': ['a11yr', 10:48:39 INFO - 'ts_paint', 10:48:39 INFO - 'tpaint', 10:48:39 INFO - 'sessionrestore', 10:48:39 INFO - 'sessionrestore_no_auto_restore']}, 10:48:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:48:39 INFO - 'tests': ['a11yr', 10:48:39 INFO - 'ts_paint', 10:48:39 INFO - 'tpaint', 10:48:39 INFO - 'sessionrestore', 10:48:39 INFO - 'sessionrestore_no_auto_restore']}, 10:48:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:48:39 INFO - 'tests': ['a11yr', 10:48:39 INFO - 'ts_paint', 10:48:39 INFO - 'tpaint', 10:48:39 INFO - 'sessionrestore', 10:48:39 INFO - 'sessionrestore_no_auto_restore']}, 10:48:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:48:39 INFO - 'tests': ['a11yr', 10:48:39 INFO - 'ts_paint', 10:48:39 INFO - 'tpaint', 10:48:39 INFO - 'sessionrestore', 10:48:39 INFO - 'sessionrestore_no_auto_restore']}, 10:48:39 INFO - 'other_l64': {'tests': ['a11yr', 10:48:39 INFO - 'ts_paint', 10:48:39 INFO - 'tpaint', 10:48:39 INFO - 'sessionrestore', 10:48:39 INFO - 'sessionrestore_no_auto_restore']}, 10:48:39 INFO - 'other_nol64': {'tests': ['a11yr', 10:48:39 INFO - 'ts_paint', 10:48:39 INFO - 'tpaint', 10:48:39 INFO - 'sessionrestore', 10:48:39 INFO - 'sessionrestore_no_auto_restore']}, 10:48:39 INFO - 'svgr': {'tests': ['tsvgx', 10:48:39 INFO - 'tsvgr_opacity', 10:48:39 INFO - 'tart', 10:48:39 INFO - 'tscrollx', 10:48:39 INFO - 'cart']}, 10:48:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:48:39 INFO - 'tests': ['tsvgx', 10:48:39 INFO - 'tsvgr_opacity', 10:48:39 INFO - 'tart', 10:48:39 INFO - 'tscrollx', 10:48:39 INFO - 'cart']}, 10:48:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:39 INFO - 'tests': ['tp5o']}, 10:48:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:39 INFO - 'talos_options': ['--e10s'], 10:48:39 INFO - 'tests': ['tp5o']}, 10:48:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:39 INFO - 'talos_options': ['--xperf_path', 10:48:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:48:39 INFO - 'tests': ['tp5n']}, 10:48:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:39 INFO - 'talos_options': ['--e10s', 10:48:39 INFO - '--xperf_path', 10:48:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:48:39 INFO - 'tests': ['tp5n']}}, 10:48:39 INFO - 'talos.zip': {'path': '', 10:48:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:48:39 INFO - Running post-action listener: _resource_record_post_action 10:48:39 INFO - ##### 10:48:39 INFO - ##### Running create-virtualenv step. 10:48:39 INFO - ##### 10:48:39 INFO - Running pre-action listener: _resource_record_pre_action 10:48:39 INFO - Running main action method: create_virtualenv 10:48:39 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:48:39 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 10:48:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:48:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:48:39 INFO - Using real prefix '/usr' 10:48:39 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:48:39 INFO - Installing distribute.............................................................................................................................................................................................done. 10:48:42 INFO - Installing pip.................done. 10:48:42 INFO - Return code: 0 10:48:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:48: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')]} 10:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48: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')]} 10:48:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:42 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 0x7fdc0fa0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fba360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2049540>, '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 0x204a440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204a8f0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452278550.739751-76097925', '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 10:48:42 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 10:48:42 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 10:48:42 INFO - Using env: {'DISPLAY': ':0', 10:48:42 INFO - 'HOME': '/home/cltbld', 10:48:42 INFO - 'LANG': 'en_US.UTF-8', 10:48:42 INFO - 'LANGUAGE': 'en_US:en', 10:48:42 INFO - 'LOGNAME': 'cltbld', 10:48:42 INFO - 'MAIL': '/var/mail/cltbld', 10:48:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:42 INFO - 'MOZ_NO_REMOTE': '1', 10:48:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:48:42 INFO - 'NO_EM_RESTART': '1', 10:48:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:48:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:48:42 INFO - 'PWD': '/builds/slave/test-pgo', 10:48:42 INFO - 'SHELL': '/bin/bash', 10:48:42 INFO - 'SHLVL': '1', 10:48:42 INFO - 'TERM': 'linux', 10:48:42 INFO - 'TMOUT': '86400', 10:48:42 INFO - 'USER': 'cltbld', 10:48:42 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452278550.739751-76097925', 10:48:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:42 INFO - '_': '/tools/buildbot/bin/python'} 10:48:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:42 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 10:48:42 INFO - Cleaning up... 10:48:42 INFO - Return code: 0 10:48:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:48: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')]} 10:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48: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')]} 10:48:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:42 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 0x7fdc0fa0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fba360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2049540>, '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 0x204a440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204a8f0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452278550.739751-76097925', '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 10:48:42 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 10:48:42 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 10:48:42 INFO - Using env: {'DISPLAY': ':0', 10:48:42 INFO - 'HOME': '/home/cltbld', 10:48:42 INFO - 'LANG': 'en_US.UTF-8', 10:48:42 INFO - 'LANGUAGE': 'en_US:en', 10:48:42 INFO - 'LOGNAME': 'cltbld', 10:48:42 INFO - 'MAIL': '/var/mail/cltbld', 10:48:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:42 INFO - 'MOZ_NO_REMOTE': '1', 10:48:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:48:42 INFO - 'NO_EM_RESTART': '1', 10:48:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:48:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:48:42 INFO - 'PWD': '/builds/slave/test-pgo', 10:48:42 INFO - 'SHELL': '/bin/bash', 10:48:42 INFO - 'SHLVL': '1', 10:48:42 INFO - 'TERM': 'linux', 10:48:42 INFO - 'TMOUT': '86400', 10:48:42 INFO - 'USER': 'cltbld', 10:48:42 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452278550.739751-76097925', 10:48:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:42 INFO - '_': '/tools/buildbot/bin/python'} 10:48:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:42 INFO - Downloading/unpacking psutil>=0.7.1 10:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:44 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 10:48:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:48:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:48:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:48:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:48:44 INFO - Installing collected packages: psutil 10:48:44 INFO - Running setup.py install for psutil 10:48:44 INFO - building 'psutil._psutil_linux' extension 10:48:44 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 10:48:44 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 10:48:44 INFO - building 'psutil._psutil_posix' extension 10:48:44 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 10:48:44 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 10:48:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:48:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:48:44 INFO - Successfully installed psutil 10:48:44 INFO - Cleaning up... 10:48:44 INFO - Return code: 0 10:48:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:48:44 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')]} 10:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:44 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')]} 10:48:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:44 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 0x7fdc0fa0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fba360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2049540>, '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 0x204a440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204a8f0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452278550.739751-76097925', '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 10:48:44 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 10:48:44 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 10:48:44 INFO - Using env: {'DISPLAY': ':0', 10:48:44 INFO - 'HOME': '/home/cltbld', 10:48:44 INFO - 'LANG': 'en_US.UTF-8', 10:48:44 INFO - 'LANGUAGE': 'en_US:en', 10:48:44 INFO - 'LOGNAME': 'cltbld', 10:48:44 INFO - 'MAIL': '/var/mail/cltbld', 10:48:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:44 INFO - 'MOZ_NO_REMOTE': '1', 10:48:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:48:44 INFO - 'NO_EM_RESTART': '1', 10:48:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:48:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:48:44 INFO - 'PWD': '/builds/slave/test-pgo', 10:48:44 INFO - 'SHELL': '/bin/bash', 10:48:44 INFO - 'SHLVL': '1', 10:48:44 INFO - 'TERM': 'linux', 10:48:44 INFO - 'TMOUT': '86400', 10:48:44 INFO - 'USER': 'cltbld', 10:48:44 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452278550.739751-76097925', 10:48:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:44 INFO - '_': '/tools/buildbot/bin/python'} 10:48:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:48:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:48:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:48:46 INFO - Installing collected packages: mozsystemmonitor 10:48:46 INFO - Running setup.py install for mozsystemmonitor 10:48:47 INFO - Successfully installed mozsystemmonitor 10:48:47 INFO - Cleaning up... 10:48:47 INFO - Return code: 0 10:48:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:48:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:48:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdc0fa0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fba360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2049540>, '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 0x204a440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204a8f0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452278550.739751-76097925', '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 10:48:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 10:48:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:48:47 INFO - Using env: {'DISPLAY': ':0', 10:48:47 INFO - 'HOME': '/home/cltbld', 10:48:47 INFO - 'LANG': 'en_US.UTF-8', 10:48:47 INFO - 'LANGUAGE': 'en_US:en', 10:48:47 INFO - 'LOGNAME': 'cltbld', 10:48:47 INFO - 'MAIL': '/var/mail/cltbld', 10:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:47 INFO - 'MOZ_NO_REMOTE': '1', 10:48:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:48:47 INFO - 'NO_EM_RESTART': '1', 10:48:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:48:47 INFO - 'PWD': '/builds/slave/test-pgo', 10:48:47 INFO - 'SHELL': '/bin/bash', 10:48:47 INFO - 'SHLVL': '1', 10:48:47 INFO - 'TERM': 'linux', 10:48:47 INFO - 'TMOUT': '86400', 10:48:47 INFO - 'USER': 'cltbld', 10:48:47 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452278550.739751-76097925', 10:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:47 INFO - '_': '/tools/buildbot/bin/python'} 10:48:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:47 INFO - Downloading/unpacking blobuploader==1.2.4 10:48:47 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 10:48:47 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 10:48:47 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 10:48:47 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 10:48:47 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 10:48:47 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 10:48:48 INFO - Downloading blobuploader-1.2.4.tar.gz 10:48:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:48:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:48:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:48:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:48:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:49 INFO - Downloading docopt-0.6.1.tar.gz 10:48:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:48:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:48:49 INFO - Installing collected packages: blobuploader, requests, docopt 10:48:49 INFO - Running setup.py install for blobuploader 10:48:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:48:49 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:48:49 INFO - Running setup.py install for requests 10:48:50 INFO - Running setup.py install for docopt 10:48:50 INFO - Successfully installed blobuploader requests docopt 10:48:50 INFO - Cleaning up... 10:48:50 INFO - Return code: 0 10:48:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:48:50 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')]} 10:48:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:50 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')]} 10:48:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:50 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 0x7fdc0fa0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fba360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2049540>, '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 0x204a440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204a8f0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452278550.739751-76097925', '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 10:48:50 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 10:48:50 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 10:48:50 INFO - Using env: {'DISPLAY': ':0', 10:48:50 INFO - 'HOME': '/home/cltbld', 10:48:50 INFO - 'LANG': 'en_US.UTF-8', 10:48:50 INFO - 'LANGUAGE': 'en_US:en', 10:48:50 INFO - 'LOGNAME': 'cltbld', 10:48:50 INFO - 'MAIL': '/var/mail/cltbld', 10:48:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:50 INFO - 'MOZ_NO_REMOTE': '1', 10:48:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:48:50 INFO - 'NO_EM_RESTART': '1', 10:48:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:48:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:48:50 INFO - 'PWD': '/builds/slave/test-pgo', 10:48:50 INFO - 'SHELL': '/bin/bash', 10:48:50 INFO - 'SHLVL': '1', 10:48:50 INFO - 'TERM': 'linux', 10:48:50 INFO - 'TMOUT': '86400', 10:48:50 INFO - 'USER': 'cltbld', 10:48:50 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452278550.739751-76097925', 10:48:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:50 INFO - '_': '/tools/buildbot/bin/python'} 10:48:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:48:50 INFO - Running setup.py (path:/tmp/pip-Uz____-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:48:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:48:50 INFO - Running setup.py (path:/tmp/pip-qx85zS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:48:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:48:50 INFO - Running setup.py (path:/tmp/pip-seRdMr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:48:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:48:50 INFO - Running setup.py (path:/tmp/pip-KwOf3k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:48:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:48:50 INFO - Running setup.py (path:/tmp/pip-zTA688-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:48:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:48:50 INFO - Running setup.py (path:/tmp/pip-GGO9YU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:48:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:48:50 INFO - Running setup.py (path:/tmp/pip-m1XgU6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:48:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:48:51 INFO - Running setup.py (path:/tmp/pip-9z8_c6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:48:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:48:51 INFO - Running setup.py (path:/tmp/pip-W3AOaX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:48:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:48:51 INFO - Running setup.py (path:/tmp/pip-v0HwIw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:48:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:48:51 INFO - Running setup.py (path:/tmp/pip-C0MAfN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:48:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:48:51 INFO - Running setup.py (path:/tmp/pip-EJ5bPJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:48:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:48:51 INFO - Running setup.py (path:/tmp/pip-dRHe6A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:48:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:48:51 INFO - Running setup.py (path:/tmp/pip-woNNO8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:48:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:48:51 INFO - Running setup.py (path:/tmp/pip-eMmfsB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:48:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:48:51 INFO - Running setup.py (path:/tmp/pip-Tz2k6P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:48:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:48:51 INFO - Running setup.py (path:/tmp/pip-QrYS9v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:48:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:48:51 INFO - Running setup.py install for manifestparser 10:48:51 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:48:51 INFO - Running setup.py install for mozcrash 10:48:51 INFO - Running setup.py install for mozdebug 10:48:52 INFO - Running setup.py install for mozdevice 10:48:52 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:48:52 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:48:52 INFO - Running setup.py install for mozfile 10:48:52 INFO - Running setup.py install for mozhttpd 10:48:52 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:48:52 INFO - Running setup.py install for mozinfo 10:48:52 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:48:52 INFO - Running setup.py install for mozInstall 10:48:52 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:48:52 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:48:52 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:48:52 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:48:52 INFO - Running setup.py install for mozleak 10:48:52 INFO - Running setup.py install for mozlog 10:48:52 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:48:52 INFO - Running setup.py install for moznetwork 10:48:52 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:48:52 INFO - Running setup.py install for mozprocess 10:48:52 INFO - Running setup.py install for mozprofile 10:48:53 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:48:53 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:48:53 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:48:53 INFO - Running setup.py install for mozrunner 10:48:53 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:48:53 INFO - Running setup.py install for mozscreenshot 10:48:53 INFO - Running setup.py install for moztest 10:48:53 INFO - Running setup.py install for mozversion 10:48:53 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:48:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:48:53 INFO - Cleaning up... 10:48:53 INFO - Return code: 0 10:48:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:48: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')]} 10:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48: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')]} 10:48:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48: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', '-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 0x7fdc0fa0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fba360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2049540>, '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 0x204a440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204a8f0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452278550.739751-76097925', '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 10:48:53 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 10:48:53 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 10:48:53 INFO - Using env: {'DISPLAY': ':0', 10:48:53 INFO - 'HOME': '/home/cltbld', 10:48:53 INFO - 'LANG': 'en_US.UTF-8', 10:48:53 INFO - 'LANGUAGE': 'en_US:en', 10:48:53 INFO - 'LOGNAME': 'cltbld', 10:48:53 INFO - 'MAIL': '/var/mail/cltbld', 10:48:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:53 INFO - 'MOZ_NO_REMOTE': '1', 10:48:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:48:53 INFO - 'NO_EM_RESTART': '1', 10:48:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:48:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:48:53 INFO - 'PWD': '/builds/slave/test-pgo', 10:48:53 INFO - 'SHELL': '/bin/bash', 10:48:53 INFO - 'SHLVL': '1', 10:48:53 INFO - 'TERM': 'linux', 10:48:53 INFO - 'TMOUT': '86400', 10:48:53 INFO - 'USER': 'cltbld', 10:48:53 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452278550.739751-76097925', 10:48:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:53 INFO - '_': '/tools/buildbot/bin/python'} 10:48:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:48:53 INFO - Running setup.py (path:/tmp/pip-BK8N0N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:48:53 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)) 10:48:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:48:53 INFO - Running setup.py (path:/tmp/pip-zEeEz3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:48:53 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)) 10:48:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:48:53 INFO - Running setup.py (path:/tmp/pip-WUvtCq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:48:53 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)) 10:48:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:48:53 INFO - Running setup.py (path:/tmp/pip-vIGx4k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:48:54 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)) 10:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:48:54 INFO - Running setup.py (path:/tmp/pip-0KS1r1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:48:54 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)) 10:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:48:54 INFO - Running setup.py (path:/tmp/pip-d8ienm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:48:54 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)) 10:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:48:54 INFO - Running setup.py (path:/tmp/pip-5bXP4v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:48:54 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)) 10:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:48:54 INFO - Running setup.py (path:/tmp/pip-v6XON_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:48:54 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)) 10:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:48:54 INFO - Running setup.py (path:/tmp/pip-TnTzIY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:48:54 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)) 10:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:48:54 INFO - Running setup.py (path:/tmp/pip-jnlLDX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:48:54 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)) 10:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:48:54 INFO - Running setup.py (path:/tmp/pip-qMVe63-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:48:54 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)) 10:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:48:54 INFO - Running setup.py (path:/tmp/pip-6va4bX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:48:54 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)) 10:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:48:54 INFO - Running setup.py (path:/tmp/pip-kqAdMF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:48:54 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)) 10:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:48:54 INFO - Running setup.py (path:/tmp/pip-Y_xaIP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:48:54 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)) 10:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:48:54 INFO - Running setup.py (path:/tmp/pip-XEdd4C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:48:54 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)) 10:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:48:54 INFO - Running setup.py (path:/tmp/pip-ES2B2F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:48:54 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)) 10:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:48:54 INFO - Running setup.py (path:/tmp/pip-0Cch4Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:48:54 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)) 10:48:54 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)) 10:48:54 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)) 10:48:54 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)) 10:48:54 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)) 10:48:54 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)) 10:48:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:56 INFO - Downloading blessings-1.5.1.tar.gz 10:48:56 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 10:48:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:48:56 INFO - Installing collected packages: blessings 10:48:56 INFO - Running setup.py install for blessings 10:48:56 INFO - Successfully installed blessings 10:48:56 INFO - Cleaning up... 10:48:56 INFO - Return code: 0 10:48:56 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:48:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:48:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:48:57 INFO - Reading from file tmpfile_stdout 10:48:57 INFO - Current package versions: 10:48:57 INFO - argparse == 1.2.1 10:48:57 INFO - blessings == 1.5.1 10:48:57 INFO - blobuploader == 1.2.4 10:48:57 INFO - docopt == 0.6.1 10:48:57 INFO - manifestparser == 1.1 10:48:57 INFO - mozInstall == 1.12 10:48:57 INFO - mozcrash == 0.16 10:48:57 INFO - mozdebug == 0.1 10:48:57 INFO - mozdevice == 0.47 10:48:57 INFO - mozfile == 1.2 10:48:57 INFO - mozhttpd == 0.7 10:48:57 INFO - mozinfo == 0.9 10:48:57 INFO - mozleak == 0.1 10:48:57 INFO - mozlog == 3.1 10:48:57 INFO - moznetwork == 0.27 10:48:57 INFO - mozprocess == 0.22 10:48:57 INFO - mozprofile == 0.28 10:48:57 INFO - mozrunner == 6.11 10:48:57 INFO - mozscreenshot == 0.1 10:48:57 INFO - mozsystemmonitor == 0.0 10:48:57 INFO - moztest == 0.7 10:48:57 INFO - mozversion == 1.4 10:48:57 INFO - psutil == 3.1.1 10:48:57 INFO - requests == 1.2.3 10:48:57 INFO - wsgiref == 0.1.2 10:48:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:48: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')]} 10:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48: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')]} 10:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7fdc0fa0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fba360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2049540>, '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 0x204a440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204a8f0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452278550.739751-76097925', '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 10:48:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 10:48:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 10:48:57 INFO - Using env: {'DISPLAY': ':0', 10:48:57 INFO - 'HOME': '/home/cltbld', 10:48:57 INFO - 'LANG': 'en_US.UTF-8', 10:48:57 INFO - 'LANGUAGE': 'en_US:en', 10:48:57 INFO - 'LOGNAME': 'cltbld', 10:48:57 INFO - 'MAIL': '/var/mail/cltbld', 10:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:57 INFO - 'MOZ_NO_REMOTE': '1', 10:48:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:48:57 INFO - 'NO_EM_RESTART': '1', 10:48:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:48:57 INFO - 'PWD': '/builds/slave/test-pgo', 10:48:57 INFO - 'SHELL': '/bin/bash', 10:48:57 INFO - 'SHLVL': '1', 10:48:57 INFO - 'TERM': 'linux', 10:48:57 INFO - 'TMOUT': '86400', 10:48:57 INFO - 'USER': 'cltbld', 10:48:57 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452278550.739751-76097925', 10:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:57 INFO - '_': '/tools/buildbot/bin/python'} 10:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:57 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)) 10:48:57 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)) 10:48:57 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)) 10:48:57 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)) 10:48:57 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)) 10:48:57 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)) 10:48:57 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)) 10:48:57 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)) 10:48:57 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)) 10:48:57 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)) 10:48:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 10:48:57 INFO - Cleaning up... 10:48:57 INFO - Return code: 0 10:48:57 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:48: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')]} 10:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48: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')]} 10:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0fa0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fba360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2049540>, '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 0x204a440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204a8f0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452278550.739751-76097925', '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 10:48: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', 'jsonschema'] in /builds/slave/test-pgo/build 10:48: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 jsonschema 10:48:57 INFO - Using env: {'DISPLAY': ':0', 10:48:57 INFO - 'HOME': '/home/cltbld', 10:48:57 INFO - 'LANG': 'en_US.UTF-8', 10:48:57 INFO - 'LANGUAGE': 'en_US:en', 10:48:57 INFO - 'LOGNAME': 'cltbld', 10:48:57 INFO - 'MAIL': '/var/mail/cltbld', 10:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:57 INFO - 'MOZ_NO_REMOTE': '1', 10:48:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:48:57 INFO - 'NO_EM_RESTART': '1', 10:48:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:48:57 INFO - 'PWD': '/builds/slave/test-pgo', 10:48:57 INFO - 'SHELL': '/bin/bash', 10:48:57 INFO - 'SHLVL': '1', 10:48:57 INFO - 'TERM': 'linux', 10:48:57 INFO - 'TMOUT': '86400', 10:48:57 INFO - 'USER': 'cltbld', 10:48:57 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452278550.739751-76097925', 10:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:57 INFO - '_': '/tools/buildbot/bin/python'} 10:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:57 INFO - Downloading/unpacking jsonschema 10:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:48:59 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 10:48:59 INFO - Downloading/unpacking functools32 (from jsonschema) 10:48: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 10:48: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 10:48: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 10:48: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 10:48: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 10:48: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 10:48:59 INFO - Downloading functools32-3.2.3-2.tar.gz 10:48:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:48:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:48:59 INFO - warning: no files found matching '*.txt' 10:48:59 INFO - no previously-included directories found matching 'build' 10:48:59 INFO - no previously-included directories found matching 'dist' 10:48:59 INFO - no previously-included directories found matching '.git*' 10:48:59 INFO - Installing collected packages: jsonschema, functools32 10:48:59 INFO - Running setup.py install for functools32 10:48:59 INFO - warning: no files found matching '*.txt' 10:48:59 INFO - no previously-included directories found matching 'build' 10:48:59 INFO - no previously-included directories found matching 'dist' 10:48:59 INFO - no previously-included directories found matching '.git*' 10:48:59 INFO - Successfully installed jsonschema functools32 10:48:59 INFO - Cleaning up... 10:48:59 INFO - Return code: 0 10:48:59 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:48:59 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')]} 10:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:59 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')]} 10:48:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:59 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 0x7fdc0fa0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fba360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2049540>, '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 0x204a440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204a8f0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1452278550.739751-76097925', '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 10:48:59 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 10:48:59 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 10:48:59 INFO - Using env: {'DISPLAY': ':0', 10:48:59 INFO - 'HOME': '/home/cltbld', 10:48:59 INFO - 'LANG': 'en_US.UTF-8', 10:48:59 INFO - 'LANGUAGE': 'en_US:en', 10:48:59 INFO - 'LOGNAME': 'cltbld', 10:48:59 INFO - 'MAIL': '/var/mail/cltbld', 10:48:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:59 INFO - 'MOZ_NO_REMOTE': '1', 10:48:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:48:59 INFO - 'NO_EM_RESTART': '1', 10:48:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:48:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:48:59 INFO - 'PWD': '/builds/slave/test-pgo', 10:48:59 INFO - 'SHELL': '/bin/bash', 10:48:59 INFO - 'SHLVL': '1', 10:48:59 INFO - 'TERM': 'linux', 10:48:59 INFO - 'TMOUT': '86400', 10:48:59 INFO - 'USER': 'cltbld', 10:48:59 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452278550.739751-76097925', 10:48:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:59 INFO - '_': '/tools/buildbot/bin/python'} 10:48:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:59 INFO - Downloading/unpacking flake8 10:48: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 10:48: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 10:48: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 10:48: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 10:48: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 10:48: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 10:49:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:49:01 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 10:49:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:49:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:49:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:49:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:49:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:49:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:49:01 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 10:49:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:49:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:49:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:49:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:49:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:49:02 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 10:49:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:49:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:49:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:49:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:49:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:49:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:49:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:49:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:49:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:49:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:49:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:49:02 INFO - no previously-included directories found matching 'docs/_build' 10:49:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:49:02 INFO - Running setup.py install for pep8 10:49:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:49:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:49:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:49:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:49:02 INFO - no previously-included directories found matching 'docs/_build' 10:49:02 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:49:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:49:02 INFO - Cleaning up... 10:49:02 INFO - Return code: 0 10:49:02 INFO - Running post-action listener: _resource_record_post_action 10:49:02 INFO - Running post-action listener: _start_resource_monitoring 10:49:02 INFO - Starting resource monitoring. 10:49:02 INFO - ##### 10:49:02 INFO - ##### Running install step. 10:49:02 INFO - ##### 10:49:02 INFO - Running pre-action listener: _resource_record_pre_action 10:49:02 INFO - Running main action method: install 10:49:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:49:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:49:02 INFO - Reading from file tmpfile_stdout 10:49:02 INFO - Detecting whether we're running mozinstall >=1.0... 10:49:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:49:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:49:02 INFO - Reading from file tmpfile_stdout 10:49:02 INFO - Output received: 10:49:02 INFO - Usage: mozinstall [options] installer 10:49:02 INFO - Options: 10:49:02 INFO - -h, --help show this help message and exit 10:49:02 INFO - -d DEST, --destination=DEST 10:49:02 INFO - Directory to install application into. [default: 10:49:02 INFO - "/builds/slave/test-pgo"] 10:49:02 INFO - --app=APP Application being installed. [default: firefox] 10:49:02 INFO - mkdir: /builds/slave/test-pgo/build/application 10:49:02 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'] 10:49:02 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 10:49:18 INFO - Reading from file tmpfile_stdout 10:49:18 INFO - Output received: 10:49:18 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:49:18 INFO - Running post-action listener: _resource_record_post_action 10:49:18 INFO - ##### 10:49:18 INFO - ##### Running run-tests step. 10:49:18 INFO - ##### 10:49:18 INFO - Running pre-action listener: _resource_record_pre_action 10:49:18 INFO - Running main action method: run_tests 10:49:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:49:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:49:18 INFO - Python 2.7.3 10:49:18 INFO - Return code: 0 10:49:18 INFO - grabbing minidump binary from tooltool 10:49:18 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')]} 10:49:18 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 0x2049540>, '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 0x204a440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x204a8f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:49:18 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 10:49:18 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 10:49:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:49:18 INFO - Return code: 0 10:49:18 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:49:18 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:49:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:49:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:49:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:49:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:49:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:49:19 INFO - Return code: 0 10:49:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JoVNINrqRRezQG5raw0M6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 10:49:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JoVNINrqRRezQG5raw0M6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:49:19 INFO - Using env: {'DISPLAY': ':0', 10:49:19 INFO - 'HOME': '/home/cltbld', 10:49:19 INFO - 'LANG': 'en_US.UTF-8', 10:49:19 INFO - 'LANGUAGE': 'en_US:en', 10:49:19 INFO - 'LOGNAME': 'cltbld', 10:49:19 INFO - 'MAIL': '/var/mail/cltbld', 10:49:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:49:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:49:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:19 INFO - 'MOZ_NO_REMOTE': '1', 10:49:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:49:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:19 INFO - 'NO_EM_RESTART': '1', 10:49:19 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:49:19 INFO - 'PWD': '/builds/slave/test-pgo', 10:49:19 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:49:19 INFO - 'SHELL': '/bin/bash', 10:49:19 INFO - 'SHLVL': '1', 10:49:19 INFO - 'TERM': 'linux', 10:49:19 INFO - 'TMOUT': '86400', 10:49:19 INFO - 'USER': 'cltbld', 10:49:19 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1452278550.739751-76097925', 10:49:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:19 INFO - '_': '/tools/buildbot/bin/python'} 10:49:19 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JoVNINrqRRezQG5raw0M6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:49:20 INFO - mozversion application_buildid: 20160108083146 10:49:20 INFO - mozversion application_changeset: deaf711a7bc8a8cb604666b0e4e7a91edc90018e 10:49:20 INFO - mozversion application_display_name: Nightly 10:49:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:49:20 INFO - mozversion application_name: Firefox 10:49:20 INFO - mozversion application_remotingname: firefox 10:49:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:49:20 INFO - mozversion application_vendor: Mozilla 10:49:20 INFO - mozversion application_version: 46.0a1 10:49:20 INFO - mozversion platform_buildid: 20160108083146 10:49:20 INFO - mozversion platform_changeset: deaf711a7bc8a8cb604666b0e4e7a91edc90018e 10:49:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:49:20 INFO - mozversion platform_version: 46.0a1 10:49:20 INFO - using testdate: 1452278960 10:49:20 INFO - actual date: 1452278960 10:49:20 INFO - starting webserver on 'localhost:42164' 10:49:20 INFO - SUITE-START | Running 3 tests 10:49:20 INFO - TEST-START | dromaeo_css 10:49:20 INFO - operating with platform_type : linux_ 10:49:20 INFO - Initialising browser for dromaeo_css test... 10:49:20 INFO - TEST-INFO | started process 2907 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpoSyeJc/profile http://localhost:42164/getInfo.html) 10:49:25 INFO - PROCESS | 2907 | __metrics Screen width/height:1600/1200 10:49:25 INFO - PROCESS | 2907 | colorDepth:24 10:49:25 INFO - PROCESS | 2907 | Browser inner width/height: 1024/697 10:49:25 INFO - PROCESS | 2907 | __metrics 10:49:25 INFO - PROCESS | 2907 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:49:26 INFO - TEST-INFO | 2907: exit 0 10:49:26 INFO - Browser initialized. 10:49:26 INFO - Running cycle 1/1 for dromaeo_css test... 10:49:26 INFO - TEST-INFO | started process 3044 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpoSyeJc/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:49:38 INFO - PROCESS | 3044 | RSS: Main: 150265856 10:49:38 INFO - PROCESS | 3044 | 10:50:28 INFO - PROCESS | 3044 | 1452279028385 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] 10:52:37 INFO - PROCESS | 3044 | Cycle 1(1): loaded http://localhost:42164/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42164/tests/dromaeo/cssquery-ext.html) 10:52:38 INFO - PROCESS | 3044 | RSS: Main: 156639232 10:52:38 INFO - PROCESS | 3044 | 10:55:40 INFO - PROCESS | 3044 | Cycle 1(1): loaded http://localhost:42164/tests/dromaeo/cssquery-ext.html (next: http://localhost:42164/tests/dromaeo/cssquery-jquery.html) 10:55:41 INFO - PROCESS | 3044 | RSS: Main: 151662592 10:55:41 INFO - PROCESS | 3044 | 10:58:43 INFO - PROCESS | 3044 | Cycle 1(1): loaded http://localhost:42164/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42164/tests/dromaeo/cssquery-mootools.html) 10:58:43 INFO - PROCESS | 3044 | RSS: Main: 151715840 10:58:43 INFO - PROCESS | 3044 | 11:01:45 INFO - PROCESS | 3044 | Cycle 1(1): loaded http://localhost:42164/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42164/tests/dromaeo/cssquery-prototype.html) 11:01:46 INFO - PROCESS | 3044 | RSS: Main: 149798912 11:01:46 INFO - PROCESS | 3044 | 11:04:48 INFO - PROCESS | 3044 | Cycle 1(1): loaded http://localhost:42164/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42164/tests/dromaeo/cssquery-yui.html) 11:04:49 INFO - PROCESS | 3044 | RSS: Main: 151699456 11:04:49 INFO - PROCESS | 3044 | 11:07:51 INFO - PROCESS | 3044 | Cycle 1(1): loaded http://localhost:42164/tests/dromaeo/cssquery-yui.html (next: http://localhost:42164/tests/dromaeo/cssquery-dojo.html) 11:07:51 INFO - PROCESS | 3044 | RSS: Main: 153645056 11:07:51 INFO - PROCESS | 3044 | 11:07:51 INFO - PROCESS | 3044 | __start_tp_report 11:07:51 INFO - PROCESS | 3044 | _x_x_mozilla_page_load 11:07:51 INFO - PROCESS | 3044 | _x_x_mozilla_page_load_details 11:07:51 INFO - PROCESS | 3044 | |i|pagename|runs| 11:07:51 INFO - PROCESS | 3044 | |0;dojo.html;3191.1224413286345;3209.4062598419277;3239.7084262416406;3259.771815972883;3275.0011246569793;2570.9742902570993;5208.114620514512;5230.320058392408;5275.973620131894;5378.946210537893;5280.947190528093;5339.119045357511;5353.143497040474;5372;5405.540529055025;4792.161371759928;4820.855374338776;4898.51014898509;4976.800927962877;5005.349304590398;4751.714897106167;4894.632902532307;4913.336699545552;4919.901601967958;4926.0394223126505;4758.904821903578;4767.451743049542;4846.079244943485;4913.8771530711665;4959;4866.099771542276;4877.219644856841;4883.584895283905;4892.461829198785;4899.583535399495;4746;4842.612590992712;4847.951520484785;4906.092372911023;4929.112759703252;5072.810215342919;5080.771365288534;5082.1360368737405;5086.618503612244;5104.183330667112;5594.992901277768;5602.243697100921;5608.327000759894;5610.18652295419;5620.775168993236;5717.914231286492;5769.3076830780155;5779.855503612402;5787.450192231731;5834.737436815353;5267.420583735786;5317.548008419289;5317.680939143664;5320.760565774511;5330.466953304638;5747.08046712524;5758.049921762946;5796.62321949072;5855.619384740064;5864.179014937912;5601.355844077902;5604.075327570905;5633.8309850704545;5642.069058605284;5661.3206415229615;5709.486146246858;5721.5136713379;5726.169705392695;5728.255326807488;5733.541316694738;5547.805826796042;5643.830685079372;5649.12438572022;5656.8020119295625;5757.884842303214;5653.547716182696;5654;5664.660120392789;5665.320161580555;5667.404922483162;4415.5363686812425;4427.269500532376;4430.601245887886;4434.379186913835;4473.351364052194;3850.7111966602615;3883.7475564088245;3941.2511622791576;3945.7237993340764;3960.7029472789654;5335.573154147659;5368.570514358842;5397.055515284888;5399.622026458111;5401.3248343957;5633.774649014075;5770.942290577124;5777.306723193244;5783.190353350535;5783.913241301384;5173.586113111018;5197.558207552324;5256.053910296107;5323.574114070865;5358.6248962572245;4861.951380486221;4882.0724062428735;4890.413150421901;4922.50774922512;4950.18321976877;5759.366469688331;5857.560682948796;5931.228940237742;5958.791442299499;5970.5223582114195;5605.32736071674;5702.914456283242;5707.942920570741;5736.942630573808;5742.59801813869;5929.940700592939;5931.406859314034;5940.524758019435;5946.524278057832;5987.880242395215;5469.945300546943;5572.108462645957;5642.717864106696;5700.543956483554;5718.571107166896;5686.004949133968;5800.477956983892;5805.651660900359;5808.767649293981;5850.414958504116;5552.69460179694;5608.242887210175;5614.354349249726;5621.718914054362;5623.606347555632;5438.918416223681;5535.335759708861;5537.2524709163745;5549.1676248563035;5602.411746766531;5454.645448045864;5474.507294343528;5481.671099734029;5483.7806487740045;5502.862428439321;5573.247611572386;5591.077472217039;5595.580331475075;5605.831825045255;5630.8029218977135;5384.623076384615;5451.836444906659;5494.36814766307;5511.889762204653;5561.777528898961 11:07:51 INFO - PROCESS | 3044 | |1;ext.html;527.5384038965907;543.1743749500758;555.1339909740803;555.29754860102;563.5970281248909;34869.12827179322;35457;35893.641063589355;35913.46129808055;35960;37467.812660936725;38091.4286285706;38120.61879381206;38213.61786382135;38226.617733822655;8368.079511253758;8531.104234055398;8545.786355341104;8558.486490810541;8571.828563428728;8270.37972152091;8330.62512186953;8386.832263354729;8396.160383961616;8414.158584141598;8604.52675102869;8654.264387527037;8673.956630216871;8699.173578510063;8700;8549.273311768507;8602.612882420244;8629;8634.740957771213;8649.308055355556;8540.871886921701;8672.089430609758;8683.739487815375;8694.087120852346;8704.521251331174;39091.60908390937;39560.604393956266;39658.40512392316;39681.60318396837;39695.81673007983;3140.952885706716;3172.9206769830707;3387.6951074403423;3415.624281329052;3674.3018826423163;29150;29258.122256332343;29515.852420737974;30048.39903201924;30621.846890765628;3872.7482713623526;3890.3775395936796;3970.801459927021;4045.9797701011307;4129.070959034193;256502;256822;257874;258743;259798.70100649566;48831.80256888449;49295;54345.72827135839;54918.725406372716;55088.44911550913;50504.74747626238;50521;50664;50702;50743.49256507387;15068.773968390484;15133.621659458602;15211.619709507351;15227.162506062274;15265.694686106437;11706.765864682659;11814.409279536161;11822.940885295518;11875.762484750257;11953.342566158944;18601.74469467838;18727.438176854717;18775;18820.905895470434;18896.622067558572;7439.256074392626;7620.542767433972;7648.235176482307;7696.230376962259;7822;890.7105190813012;910.1990248581207;945.0596656326861;973.2749101919115;1049.480507148951;27877.86061069682;27928.30179245535;28310.575341369895;28527.144185674464;28633.57049644257;1030.9845352319721;1049.2497864027105;1055.382601178304;1061.9787604247872;1139.2594813371375;14749.336279867432;14819.925900370428;14903.478378256708;14949.70100597982;14999.700005999819;299945;304213;304499;304759;308393;49911.25133123006;50307;50391;50403;50503.49496505062;1298.3832679477173;1303.9543615973585;1315.7565850317721;1319.6766792135795;1328.2030781531005;26691.733082668925;27153.72846271512;27491.31271718223;27651.170464886087;27820.721792781813;44681.77659111684;44874;45126.54873451223;45335.31997020113;45432.54567454283;290842;291638;291692;291888;294136;30725.38549228958;31464.37071258516;31489.370212596077;31593.8420307897;31768.682313176574;37584.24831503409;39313.60686393214;40411.59588404196;40643.1871362577;40762.79618601888;33239.50140747843;33889;35263;35349.29301414009;35598.64401355953;33721.15697107494;34374;34940.82529587336;35714.28571428609;35859.64140358563;31214;31624.525632115077;32053.358932820745;32141.196470088435;32424.513632295064;28670;29102.27244318909;29487.852560737058;29669.703302966693;29674.70325296806;24045.75954240435;24409.75590244075;24544.974546468682;24701;24709.439902756912 11:07:51 INFO - PROCESS | 3044 | |2;jquery.html;357.48165160517254;363.36955382411514;363.7926381962279;364.31690580162194;366.3223037380846;13465.192088474674;14124.505642302522;16828.915855420735;16997.490075297745;17979;15947.760783588226;16172.514824555254;16523.421680241194;16594.08732519711;16680.66638667229;4971.975140124303;5301.628885977983;5336.359636843565;5337.11937530307;5345.3585569731495;5108.361454818148;5227.895442091175;5258.211268309765;5263.078961181797;5315.0432922074015;5195.740212989354;5199.896002079956;5210.9218361724415;5217.713025783581;5218.895622087556;5186.7925282988635;5187.766550505217;5316.441773613754;5557.221988921554;5562.833115006556;4968.403791545038;4971.850844474636;4983.6013118950395;5006.249062640597;5143.074246635604;12596.748065038739;12794.48822047117;12797.040221983389;15301.387944482318;18610.255589776392;2125.6386414309604;2148.3877095027997;2185.278857976864;2233.8101261392803;2628.5531459651907;9350.71947841559;9448.905510944871;10047.196224302039;12067.818982715266;12282.14025018249;1744.3633073928052;1758.481248031821;1822.6901426757483;1843.6773564626137;1876.0807204469847;55604;56720.14919776207;57163.712721545635;57867.71066144684;57938.13092803612;10014.949925250472;10205.744856378502;10276.280660353703;10280.588776449007;10344.27590068688;12480.31515745381;12924.289164096064;13043.543475978486;13434.462621495226;13459.865401346056;7336.523125996793;7465.776026719099;7616.0099187105325;7801.063872335356;7889.763307100796;7326.377257933135;7355.227701091415;7375.741849035258;7500.099988001475;7573.46985710995;4387.890302742457;4432.202203603382;4465.687401881837;4468.709533880287;4476.619487343547;1836.908154592265;1873.8875667459995;1891.527118220445;1897.1652472911874;1902.6480101181048;797.3541431440551;914.9176574108229;964.7057647417605;1050.9369437833755;1058.3226734889677;15565.610859728371;15937.601559960862;16330;16339.673206535803;16594.58513537147;891.4294851295176;915.1626261970356;919.1451949686856;967.8257913575624;987.676513471951;8067.515949043076;8568.742937711879;9599.136077752895;9625.903740962642;9638.132568068908;161622.1918890398;161758;162759;163087;163101;72268;72320.63839680873;72524.2747572528;74135;74947;1131.7396998690183;1142.2632402100598;1143.6054561176381;1153.2330999884982;1153.5385845661801;14096.36566354496;14633.707325853211;14974.775378369552;15079;15122.09267443957;29192.27019324534;29686.257843554085;30090.84954575213;30686.539701904043;31446.528302075945;33654.49518257277;33728.49407258844;34443.827780860935;35585.28829423449;37426.25147497089;7169.318914703095;7383.224761399975;7416.295451932057;7540.736074237376;7622.847543049219;9614.51927403613;11170.050545703381;11216.046636036028;11250.381229032482;11537.596184133516;9418.62325506972;9450.102240287162;9488.525573721425;9708;9961.40231586107;9195.816083678155;9221.861672075058;9557.378770379903;9695.321327507289;9967.40195588267;9293.210077143518;9956.253281003808;9964.651237206663;10000.849987250343;10469.214808889212;6754.763583274758;7220.494565380373;7345.632718363953;7354.6322683866665;7361.558306501627;8897.154770296811;9112.407693499901;9555.952220238854;9582.185514231369;9846.261530385107 11:07:51 INFO - PROCESS | 3044 | |3;mootools.html;1412.3926711514048;1416.950406735764;1542.8148622165343;1711.8117007129222;1738.6696527659744;7758.767236982892;7838.764837054883;7920.445568810185;8000.519968801868;8093.39299552533;7948.364130869531;7965.561894095822;7994.200579942003;8064.475809072406;8072.233137851895;2312.1213938703313;2360.9645855312183;2371.905123795046;2374.1097088591778;2381.6427535869584;2385.355953892448;2394.736578976311;2412.2883749293915;2435.038159926828;2436.890339934698;2272.3296627494847;2335.369450248432;2358.6226203807396;2384.666146739458;2401.231605886117;2345.6012477878803;2358.080348664014;2378.892949817271;2386.5823480890776;2388;2315.7684231576877;2366.0535785685693;2370.3363058343693;2372.3120295114395;2372.383180373098;8063.838723225561;8097.797555061112;8113.391495637792;8117.715879944174;8118;4696.295555666643;4846.103470857903;4856;4858.878528036792;4880.853574392774;3125;3189.489681650925;3236.288016636336;3244.3349113431927;3247.772655914087;1021.9029192226726;1034.2656713733259;1048.161470823346;1049.564430761233;1078.1321036565562;11236.719082022933;11298.435078246055;11302;11313.83029254562;11320.377379244139;4252.192083504125;4270.765107919032;4328.632066274402;4330.675199360061;4344.370066340363;9061.184493395625;9108;9114.680986165586;9117.225035872025;9132.634694612274;4823.1800593899125;4837.9032419351415;4844.031193761261;4852.4662287148385;4860.538248866352;4341.674374421931;4343.543927887589;4387.868363949086;4399.604035636744;4420.093880754502;3507.2459421224557;3526.2594855080206;3561.5191949086543;3574.195805943694;3577.624349443323;1073.7959787640323;1076.042322333124;1078.1267173589417;1090.7000574841982;1096.6490722968733;963.942163470194;1014.9289549731448;1015.5836107196014;1121.3047910295668;1293.9611811645666;7232;7246.565206087652;7290.198078211392;7292.525985810906;7299.598522081336;1179.2688533109526;1202.5189924030458;1210.6489118155637;1220.1824777399163;1236.3509157692283;5837.153612726216;5895.528357731371;5922.170896074553;5974.761009559656;5996.340402555803;9206.26349892007;9477.715668529956;9598.088181622734;9623.133917947418;9649.13157815786;9351.15839574428;9362.672306469241;9476.099770521789;9491;9503.19222866064;7501.212372700897;7522.247775222543;7595.5822429766895;7602.087749469988;7630.923690763132;7207.423406127392;7313.853722925618;7334.376577990931;7336.96331518339;7368.963155184189;8540.103289154798;8680.826383472422;8712.303015758851;8722.476651400937;8836.248918841971;8890.955545222232;8916.375853690439;8920.152585504367;9089.454632722058;9138.13187747163;6707.396334329738;6709.295523970108;6773.525853190229;6838.897416538656;6859.2454829969665;7389.889151662837;7486.475946683898;7498.850022999619;7508.2867127622785;7527.096748390229;6993.825154371181;7200.135983681992;7212.603306818175;7290.307420795016;7363.410927125924;6869.690863911036;6956.443484521327;6981.581105133505;6989.440844732308;7003.684834182576;6961.99051137572;7087.574745515286;7106.253843346374;7113.253108423748;7170.784876453715;6520.543561950618;6571.112899758663;6601.801945941629;6606.966965165144;6613.371729685672;6645;6660.100886380276;6843.589384636938;6934.133233345832;6939.791806245821 11:07:51 INFO - PROCESS | 3044 | |4;prototype.html;344.7810640243445;349.67654919199737;352.44489928362833;354.21718003212897;355.25746214816326;6127.693615319227;6257.0927215553775;6304.306526282106;6328.62028278303;6338.7464501419945;6048.758049678007;6154.846128846781;6165.321814600402;6188.040853667678;6211.9068213976825;4796.472388037313;4804.495527969565;4810.879728006802;4813.109574728686;4813.470518242991;4804.25534042224;4817.012512434942;4825.372701548794;4827.927581086286;4833.299171620113;4706.058788242365;4805.231163013901;4807.495213002637;4813.061453016646;4829.613630909519;4788.353572267734;4799.328094066834;4799.784009719536;4811.903761924742;4813.133635945528;4213.557576454459;4226.640735537483;4227.767472788995;4238.19474299882;4251.171021650779;5871.471567558898;5877;5877.177195192677;5878.735456904449;5896.380880007623;5397.109476936301;5542.5565954723525;5557.694326812024;5557.722113894289;5564.165375193713;6625.602463852184;6632;6639.771642246152;6643.335666433366;6646.202455705346;4671.929921051187;4672.976635116803;4673.719576825401;4675.766211689436;4696.647751418657;6809.693563789641;6964.582125072512;6970.965145174242;6978.511504194708;6998.510104292702;4775.904481910342;4776.593989510861;4779.402574678165;4785.736784476818;4789.616830653539;4810;4834.033193361342;4837.588804951548;4845.6123510119105;4855.6115510759055;5582.49757521825;5586.1062230043;5588.748506317225;5598.468145526169;5601.271834661549;6586.1438013058;6679.56582822115;6700.162479690039;6705.195376554747;6729.293424190488;1651.3147043976614;1683.1163639089575;1691.4418241980118;1697.2871394014544;1700.6088599622155;1098.5880294889416;1120.1151090638468;1132.7281452451352;1135.500379832871;1145.5532342386475;6180.227471566054;6248.31268560458;6251.74993000284;6251.999680051261;6260.874782504416;6765.154355705537;6778.864422711518;6788.117544719254;6807;6823.420009299166;6118;6232.407921247474;6239.532035097386;6241.469475094668;6257.9687101564205;3702.9074273143387;3731.421629647409;3736.6076561961145;3739.9439008414897;3750.4186851038135;7100.609466479394;7104.360607545243;7104.467164962649;7112.608806515691;7122.145342558926;6917.308269173143;6992.720291188397;7019.438444924496;7031.226565077837;7070.292970702889;7032.472564557678;7077.504574679826;7086.326798954195;7086.574805511686;7097.680604372816;6790.524663273523;6791.45668346541;6806.9659651703405;6814.182298124257;6826.112605361272;6665.833354166185;6727.831804204934;6756.425703815231;6764.154480689914;6895.5173137881875;7276.126864776261;7280.381167600814;7284.053073100463;7297.452691048299;7305.634718263959;4681.976590117028;4703.294505824154;4740.928886066643;4753.215719406259;4763.380760501252;6811.318868113149;6885.173779146334;6903.792886213421;6917.342852429011;6962.860742785218;6669.7665581704405;6692.564983276072;6749.5612785168805;6797.66011699423;6812.216595091628;6740.359665831738;6750.459963202834;6755.932440675727;6779.457643388616;6786.728530858711;6453.257875344396;6596.241432235162;6619.205695316593;6628.171478565179;6658.83352916181;6782.423494002867;6785.898211526733;6797.320267973361;6801.557898736566;6807.625580593115;6573.94816829305;6605.5376123670885;6610.0084987250375;6613.503987200883;6616.2391324996315 11:07:51 INFO - PROCESS | 3044 | |5;yui.html;728.6866647341641;751.3726038757637;752.4394326226961;802.8193656427304;837.5686521441459;11354.318740875553;11536.423178841045;11554.133439992003;11588.768224635502;11649.708757281072;12246.387680615979;12250.754984900297;12319.322437265946;12339.691507712312;12343.01255899528;652.4128284543901;657.2540166910567;772.5364781131333;789.171370061436;795.3637090327744;773.0916173496148;786.8426314737047;793.7221972309675;793.7579038393287;793.809485723428;808.720991258015;818.9140140285274;821.3470291118546;821.6754382019099;822.0300045945781;814.2183503836325;815.3517953227199;817.2807929022451;819.1644522586987;821.1049955548451;603.6951339573532;603.846019265089;605.05913304811;606.6208619612742;607.1318015238207;11954.581589644407;11969.281843089442;11983.700407489796;11990.04079673624;12006.219595726338;11793.94103029488;11841;11848.34834084125;12031.51873925042;12447.004239660895;9756.707298781048;10342.844857327145;10435.165186785114;10446;10537.578496860117;3927.7446965947406;3927.8036098194975;3978.8806335809973;4019.015341241385;4088.325426304656;41328;42170.78914605438;42187.36718949218;42327;42371.788141059405;9194.080591940752;9310.255179585753;9430;9811.901880981242;9826.852597211047;16373.590660233589;16444.506664800076;16476.917615412087;16500.17499125039;16502.42241521565;7086.964565177141;7294.234105418961;7323.9267607323245;7324.63376831167;7329.303716146957;3874.651281384689;3908.159745654698;3965.20695860829;4035.051762835731;4036.3541833307117;3007.173027417434;3057.92355191122;3070.8771649134233;3074.123874695701;3075.384923015406;532.6298222735239;544.9373322067934;546.6856557479465;547.4744245524341;554.4981791478718;447.60163454525497;486.6812237984126;488.4626910398533;494.14759539794284;557.4258513730864;7614.390848732088;7693.384529237647;8024.479438764064;8038.115807261197;8050.637721302555;539.1669870050781;576.6396002498439;649.8602800397937;659.5679829711546;696.6485019063001;3692.1877187018813;4140.275451795924;4169.958300416957;4207.158568286355;4329.480462344476;52063;52983.20525192125;53286.46713532892;53406.19890701643;53526.46473535293;46925.061498769835;47644;48382.06471741162;48532.27201591979;48692.51307486951;42763;43978.780106099905;44321;44328.556714432445;44474.110517789464;8209.58952052383;8347.874781878156;8422.073571907207;8450.66197352099;8654.610542525475;33046.83476582602;33216.667833322324;33727.325453491285;34220.14449638779;34306.14234644154;40073.59926400699;41326;41910.580894190665;42774;42818.57181428146;9786.314957952874;10229.897701022894;10257.58969641206;10938.507767150339;11214.943925280322;10307.639232626821;10378.481075946022;10437.947810260901;10695.197860160364;10696.62561810333;9899.257555683209;10012.39925604466;10093.5457904393;10161.390316581028;10486.318389304672;10544.26190166681;10641.521131548943;10925.125989920629;10999.945000274947;11059.50232239535;9667.371620844622;9708.2718796092;9814.33019331718;9949.701508954742;9973.700788976343;7772.650230739743;7969.72105976288;8069.919300806917;8091.1099779025435;8482.915170848213;8382.858308011524;8726.69456569017;8862.158094980967;8965.910340896768;9282.257419406566 11:07:51 INFO - PROCESS | 3044 | __end_tp_report 11:07:51 INFO - PROCESS | 3044 | __start_cc_report 11:07:51 INFO - PROCESS | 3044 | _x_x_mozilla_cycle_collect,318 11:07:51 INFO - PROCESS | 3044 | __end_cc_report 11:07:51 INFO - PROCESS | 3044 | __startTimestamp1452280071886__endTimestamp 11:07:51 INFO - PROCESS | 3044 | 11:07:51 INFO - PROCESS | 3044 | ------- Summary: start ------- 11:07:51 INFO - PROCESS | 3044 | Number of tests: 6 11:07:51 INFO - PROCESS | 3044 | 11:07:51 INFO - PROCESS | 3044 | [#0] dojo.html Cycles:165 Average:5279.72 Median:5483.78 stddev:617.42 (11.3%) stddev-sans-first:597.18 11:07:51 INFO - PROCESS | 3044 | Values: 3191.1 3209.4 3239.7 3259.8 3275.0 2571.0 5208.1 5230.3 5276.0 5378.9 5280.9 5339.1 5353.1 5372.0 5405.5 4792.2 4820.9 4898.5 4976.8 5005.3 4751.7 4894.6 4913.3 4919.9 4926.0 4758.9 4767.5 4846.1 4913.9 4959.0 4866.1 4877.2 4883.6 4892.5 4899.6 4746.0 4842.6 4848.0 4906.1 4929.1 5072.8 5080.8 5082.1 5086.6 5104.2 5595.0 5602.2 5608.3 5610.2 5620.8 5717.9 5769.3 5779.9 5787.5 5834.7 5267.4 5317.5 5317.7 5320.8 5330.5 5747.1 5758.0 5796.6 5855.6 5864.2 5601.4 5604.1 5633.8 5642.1 5661.3 5709.5 5721.5 5726.2 5728.3 5733.5 5547.8 5643.8 5649.1 5656.8 5757.9 5653.5 5654.0 5664.7 5665.3 5667.4 4415.5 4427.3 4430.6 4434.4 4473.4 3850.7 3883.7 3941.3 3945.7 3960.7 5335.6 5368.6 5397.1 5399.6 5401.3 5633.8 5770.9 5777.3 5783.2 5783.9 5173.6 5197.6 5256.1 5323.6 5358.6 4862.0 4882.1 4890.4 4922.5 4950.2 5759.4 5857.6 5931.2 5958.8 5970.5 5605.3 5702.9 5707.9 5736.9 5742.6 5929.9 5931.4 5940.5 5946.5 5987.9 5469.9 5572.1 5642.7 5700.5 5718.6 5686.0 5800.5 5805.7 5808.8 5850.4 5552.7 5608.2 5614.4 5621.7 5623.6 5438.9 5535.3 5537.3 5549.2 5602.4 5454.6 5474.5 5481.7 5483.8 5502.9 5573.2 5591.1 5595.6 5605.8 5630.8 5384.6 5451.8 5494.4 5511.9 5561.8 11:07:51 INFO - PROCESS | 3044 | 11:07:51 INFO - PROCESS | 3044 | [#1] ext.html Cycles:180 Average:44449.00 Median:35101.91 stddev:74521.07 (212.3%) stddev-sans-first:74657.15 11:07:51 INFO - PROCESS | 3044 | Values: 527.5 543.2 555.1 555.3 563.6 34869.1 35457.0 35893.6 35913.5 35960.0 37467.8 38091.4 38120.6 38213.6 38226.6 8368.1 8531.1 8545.8 8558.5 8571.8 8270.4 8330.6 8386.8 8396.2 8414.2 8604.5 8654.3 8674.0 8699.2 8700.0 8549.3 8602.6 8629.0 8634.7 8649.3 8540.9 8672.1 8683.7 8694.1 8704.5 39091.6 39560.6 39658.4 39681.6 39695.8 3141.0 3172.9 3387.7 3415.6 3674.3 29150.0 29258.1 29515.9 30048.4 30621.8 3872.7 3890.4 3970.8 4046.0 4129.1 256502.0 256822.0 257874.0 258743.0 259798.7 48831.8 49295.0 54345.7 54918.7 55088.4 50504.7 50521.0 50664.0 50702.0 50743.5 15068.8 15133.6 15211.6 15227.2 15265.7 11706.8 11814.4 11822.9 11875.8 11953.3 18601.7 18727.4 18775.0 18820.9 18896.6 7439.3 7620.5 7648.2 7696.2 7822.0 890.7 910.2 945.1 973.3 1049.5 27877.9 27928.3 28310.6 28527.1 28633.6 1031.0 1049.2 1055.4 1062.0 1139.3 14749.3 14819.9 14903.5 14949.7 14999.7 299945.0 304213.0 304499.0 304759.0 308393.0 49911.3 50307.0 50391.0 50403.0 50503.5 1298.4 1304.0 1315.8 1319.7 1328.2 26691.7 27153.7 27491.3 27651.2 27820.7 44681.8 44874.0 45126.5 45335.3 45432.5 290842.0 291638.0 291692.0 291888.0 294136.0 30725.4 31464.4 31489.4 31593.8 31768.7 37584.2 39313.6 40411.6 40643.2 40762.8 33239.5 33889.0 35263.0 35349.3 35598.6 33721.2 34374.0 34940.8 35714.3 35859.6 31214.0 31624.5 32053.4 32141.2 32424.5 28670.0 29102.3 29487.9 29669.7 29674.7 24045.8 24409.8 24545.0 24701.0 24709.4 11:07:51 INFO - PROCESS | 3044 | 11:07:51 INFO - PROCESS | 3044 | [#2] jquery.html Cycles:180 Average:16599.69 Median:4722.51 stddev:28855.64 (611.0%) stddev-sans-first:28910.81 11:07:51 INFO - PROCESS | 3044 | Values: 357.5 363.4 363.8 364.3 366.3 13465.2 14124.5 16828.9 16997.5 17979.0 15947.8 16172.5 16523.4 16594.1 16680.7 4972.0 5301.6 5336.4 5337.1 5345.4 5108.4 5227.9 5258.2 5263.1 5315.0 5195.7 5199.9 5210.9 5217.7 5218.9 5186.8 5187.8 5316.4 5557.2 5562.8 4968.4 4971.9 4983.6 5006.2 5143.1 12596.7 12794.5 12797.0 15301.4 18610.3 2125.6 2148.4 2185.3 2233.8 2628.6 9350.7 9448.9 10047.2 12067.8 12282.1 1744.4 1758.5 1822.7 1843.7 1876.1 55604.0 56720.1 57163.7 57867.7 57938.1 10014.9 10205.7 10276.3 10280.6 10344.3 12480.3 12924.3 13043.5 13434.5 13459.9 7336.5 7465.8 7616.0 7801.1 7889.8 7326.4 7355.2 7375.7 7500.1 7573.5 4387.9 4432.2 4465.7 4468.7 4476.6 1836.9 1873.9 1891.5 1897.2 1902.6 797.4 914.9 964.7 1050.9 1058.3 15565.6 15937.6 16330.0 16339.7 16594.6 891.4 915.2 919.1 967.8 987.7 8067.5 8568.7 9599.1 9625.9 9638.1 161622.2 161758.0 162759.0 163087.0 163101.0 72268.0 72320.6 72524.3 74135.0 74947.0 1131.7 1142.3 1143.6 1153.2 1153.5 14096.4 14633.7 14974.8 15079.0 15122.1 29192.3 29686.3 30090.8 30686.5 31446.5 33654.5 33728.5 34443.8 35585.3 37426.3 7169.3 7383.2 7416.3 7540.7 7622.8 9614.5 11170.1 11216.0 11250.4 11537.6 9418.6 9450.1 9488.5 9708.0 9961.4 9195.8 9221.9 9557.4 9695.3 9967.4 9293.2 9956.3 9964.7 10000.8 10469.2 6754.8 7220.5 7345.6 7354.6 7361.6 8897.2 9112.4 9556.0 9582.2 9846.3 11:07:51 INFO - PROCESS | 3044 | 11:07:51 INFO - PROCESS | 3044 | [#3] mootools.html Cycles:180 Average:5583.67 Median:6586.46 stddev:2898.14 (44.0%) stddev-sans-first:2889.31 11:07:51 INFO - PROCESS | 3044 | Values: 1412.4 1417.0 1542.8 1711.8 1738.7 7758.8 7838.8 7920.4 8000.5 8093.4 7948.4 7965.6 7994.2 8064.5 8072.2 2312.1 2361.0 2371.9 2374.1 2381.6 2385.4 2394.7 2412.3 2435.0 2436.9 2272.3 2335.4 2358.6 2384.7 2401.2 2345.6 2358.1 2378.9 2386.6 2388.0 2315.8 2366.1 2370.3 2372.3 2372.4 8063.8 8097.8 8113.4 8117.7 8118.0 4696.3 4846.1 4856.0 4858.9 4880.9 3125.0 3189.5 3236.3 3244.3 3247.8 1021.9 1034.3 1048.2 1049.6 1078.1 11236.7 11298.4 11302.0 11313.8 11320.4 4252.2 4270.8 4328.6 4330.7 4344.4 9061.2 9108.0 9114.7 9117.2 9132.6 4823.2 4837.9 4844.0 4852.5 4860.5 4341.7 4343.5 4387.9 4399.6 4420.1 3507.2 3526.3 3561.5 3574.2 3577.6 1073.8 1076.0 1078.1 1090.7 1096.6 963.9 1014.9 1015.6 1121.3 1294.0 7232.0 7246.6 7290.2 7292.5 7299.6 1179.3 1202.5 1210.6 1220.2 1236.4 5837.2 5895.5 5922.2 5974.8 5996.3 9206.3 9477.7 9598.1 9623.1 9649.1 9351.2 9362.7 9476.1 9491.0 9503.2 7501.2 7522.2 7595.6 7602.1 7630.9 7207.4 7313.9 7334.4 7337.0 7369.0 8540.1 8680.8 8712.3 8722.5 8836.2 8891.0 8916.4 8920.2 9089.5 9138.1 6707.4 6709.3 6773.5 6838.9 6859.2 7389.9 7486.5 7498.9 7508.3 7527.1 6993.8 7200.1 7212.6 7290.3 7363.4 6869.7 6956.4 6981.6 6989.4 7003.7 6962.0 7087.6 7106.3 7113.3 7170.8 6520.5 6571.1 6601.8 6607.0 6613.4 6645.0 6660.1 6843.6 6934.1 6939.8 11:07:51 INFO - PROCESS | 3044 | 11:07:51 INFO - PROCESS | 3044 | [#4] prototype.html Cycles:180 Average:5576.31 Median:6244.89 stddev:1676.46 (26.8%) stddev-sans-first:1634.53 11:07:51 INFO - PROCESS | 3044 | Values: 344.8 349.7 352.4 354.2 355.3 6127.7 6257.1 6304.3 6328.6 6338.7 6048.8 6154.8 6165.3 6188.0 6211.9 4796.5 4804.5 4810.9 4813.1 4813.5 4804.3 4817.0 4825.4 4827.9 4833.3 4706.1 4805.2 4807.5 4813.1 4829.6 4788.4 4799.3 4799.8 4811.9 4813.1 4213.6 4226.6 4227.8 4238.2 4251.2 5871.5 5877.0 5877.2 5878.7 5896.4 5397.1 5542.6 5557.7 5557.7 5564.2 6625.6 6632.0 6639.8 6643.3 6646.2 4671.9 4673.0 4673.7 4675.8 4696.6 6809.7 6964.6 6971.0 6978.5 6998.5 4775.9 4776.6 4779.4 4785.7 4789.6 4810.0 4834.0 4837.6 4845.6 4855.6 5582.5 5586.1 5588.7 5598.5 5601.3 6586.1 6679.6 6700.2 6705.2 6729.3 1651.3 1683.1 1691.4 1697.3 1700.6 1098.6 1120.1 1132.7 1135.5 1145.6 6180.2 6248.3 6251.7 6252.0 6260.9 6765.2 6778.9 6788.1 6807.0 6823.4 6118.0 6232.4 6239.5 6241.5 6258.0 3702.9 3731.4 3736.6 3739.9 3750.4 7100.6 7104.4 7104.5 7112.6 7122.1 6917.3 6992.7 7019.4 7031.2 7070.3 7032.5 7077.5 7086.3 7086.6 7097.7 6790.5 6791.5 6807.0 6814.2 6826.1 6665.8 6727.8 6756.4 6764.2 6895.5 7276.1 7280.4 7284.1 7297.5 7305.6 4682.0 4703.3 4740.9 4753.2 4763.4 6811.3 6885.2 6903.8 6917.3 6962.9 6669.8 6692.6 6749.6 6797.7 6812.2 6740.4 6750.5 6755.9 6779.5 6786.7 6453.3 6596.2 6619.2 6628.2 6658.8 6782.4 6785.9 6797.3 6801.6 6807.6 6573.9 6605.5 6610.0 6613.5 6616.2 11:07:51 INFO - PROCESS | 3044 | 11:07:51 INFO - PROCESS | 3044 | [#5] yui.html Cycles:180 Average:12786.08 Median:48457.17 stddev:14754.36 (30.4%) stddev-sans-first:14767.96 11:07:51 INFO - PROCESS | 3044 | Values: 728.7 751.4 752.4 802.8 837.6 11354.3 11536.4 11554.1 11588.8 11649.7 12246.4 12250.8 12319.3 12339.7 12343.0 652.4 657.3 772.5 789.2 795.4 773.1 786.8 793.7 793.8 793.8 808.7 818.9 821.3 821.7 822.0 814.2 815.4 817.3 819.2 821.1 603.7 603.8 605.1 606.6 607.1 11954.6 11969.3 11983.7 11990.0 12006.2 11793.9 11841.0 11848.3 12031.5 12447.0 9756.7 10342.8 10435.2 10446.0 10537.6 3927.7 3927.8 3978.9 4019.0 4088.3 41328.0 42170.8 42187.4 42327.0 42371.8 9194.1 9310.3 9430.0 9811.9 9826.9 16373.6 16444.5 16476.9 16500.2 16502.4 7087.0 7294.2 7323.9 7324.6 7329.3 3874.7 3908.2 3965.2 4035.1 4036.4 3007.2 3057.9 3070.9 3074.1 3075.4 532.6 544.9 546.7 547.5 554.5 447.6 486.7 488.5 494.1 557.4 7614.4 7693.4 8024.5 8038.1 8050.6 539.2 576.6 649.9 659.6 696.6 3692.2 4140.3 4170.0 4207.2 4329.5 52063.0 52983.2 53286.5 53406.2 53526.5 46925.1 47644.0 48382.1 48532.3 48692.5 42763.0 43978.8 44321.0 44328.6 44474.1 8209.6 8347.9 8422.1 8450.7 8654.6 33046.8 33216.7 33727.3 34220.1 34306.1 40073.6 41326.0 41910.6 42774.0 42818.6 9786.3 10229.9 10257.6 10938.5 11214.9 10307.6 10378.5 10437.9 10695.2 10696.6 9899.3 10012.4 10093.5 10161.4 10486.3 10544.3 10641.5 10925.1 10999.9 11059.5 9667.4 9708.3 9814.3 9949.7 9973.7 7772.7 7969.7 8069.9 8091.1 8482.9 8382.9 8726.7 8862.2 8965.9 9282.3 11:07:51 INFO - PROCESS | 3044 | -------- Summary: end -------- 11:07:51 INFO - PROCESS | 3044 | 11:07:52 INFO - TEST-INFO | 3044: exit 0 11:07:52 INFO - TEST-OK | dromaeo_css | took 1112574ms 11:07:52 INFO - TEST-START | kraken 11:07:52 INFO - operating with platform_type : linux_ 11:07:52 INFO - Initialising browser for kraken test... 11:07:52 INFO - TEST-INFO | started process 3286 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNDyApl/profile http://localhost:42164/getInfo.html) 11:07:58 INFO - PROCESS | 3286 | __metrics Screen width/height:1600/1200 11:07:58 INFO - PROCESS | 3286 | colorDepth:24 11:07:58 INFO - PROCESS | 3286 | Browser inner width/height: 1024/697 11:07:58 INFO - PROCESS | 3286 | __metrics 11:07:58 INFO - PROCESS | 3286 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:07:58 INFO - PROCESS | 3286 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 11:07:59 INFO - TEST-INFO | 3286: exit 0 11:07:59 INFO - Browser initialized. 11:07:59 INFO - Running cycle 1/1 for kraken test... 11:07:59 INFO - TEST-INFO | started process 3408 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNDyApl/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:08:11 INFO - PROCESS | 3408 | RSS: Main: 150777856 11:08:11 INFO - PROCESS | 3408 | 11:08:13 INFO - PROCESS | 3408 | Cycle 1(1): loaded http://localhost:42164/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42164/tests/kraken/driver.html?testName=audio-beat-detection) 11:08:14 INFO - PROCESS | 3408 | RSS: Main: 150908928 11:08:14 INFO - PROCESS | 3408 | 11:08:17 INFO - PROCESS | 3408 | Cycle 1(1): loaded http://localhost:42164/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42164/tests/kraken/driver.html?testName=audio-dft) 11:08:17 INFO - PROCESS | 3408 | RSS: Main: 151289856 11:08:17 INFO - PROCESS | 3408 | 11:08:20 INFO - PROCESS | 3408 | Cycle 1(1): loaded http://localhost:42164/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42164/tests/kraken/driver.html?testName=audio-fft) 11:08:21 INFO - PROCESS | 3408 | RSS: Main: 146563072 11:08:21 INFO - PROCESS | 3408 | 11:08:23 INFO - PROCESS | 3408 | Cycle 1(1): loaded http://localhost:42164/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42164/tests/kraken/driver.html?testName=audio-oscillator) 11:08:23 INFO - PROCESS | 3408 | RSS: Main: 147263488 11:08:23 INFO - PROCESS | 3408 | 11:08:25 INFO - PROCESS | 3408 | Cycle 1(1): loaded http://localhost:42164/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42164/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:08:26 INFO - PROCESS | 3408 | RSS: Main: 145756160 11:08:26 INFO - PROCESS | 3408 | 11:08:29 INFO - PROCESS | 3408 | Cycle 1(1): loaded http://localhost:42164/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42164/tests/kraken/driver.html?testName=imaging-darkroom) 11:08:30 INFO - PROCESS | 3408 | RSS: Main: 148000768 11:08:30 INFO - PROCESS | 3408 | 11:08:33 INFO - PROCESS | 3408 | Cycle 1(1): loaded http://localhost:42164/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42164/tests/kraken/driver.html?testName=imaging-desaturate) 11:08:34 INFO - PROCESS | 3408 | RSS: Main: 148897792 11:08:34 INFO - PROCESS | 3408 | 11:08:36 INFO - PROCESS | 3408 | Cycle 1(1): loaded http://localhost:42164/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42164/tests/kraken/driver.html?testName=json-parse-financial) 11:08:37 INFO - PROCESS | 3408 | RSS: Main: 147841024 11:08:37 INFO - PROCESS | 3408 | 11:08:39 INFO - PROCESS | 3408 | Cycle 1(1): loaded http://localhost:42164/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42164/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:08:39 INFO - PROCESS | 3408 | RSS: Main: 147849216 11:08:39 INFO - PROCESS | 3408 | 11:08:41 INFO - PROCESS | 3408 | Cycle 1(1): loaded http://localhost:42164/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42164/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:08:42 INFO - PROCESS | 3408 | RSS: Main: 148553728 11:08:42 INFO - PROCESS | 3408 | 11:08:44 INFO - PROCESS | 3408 | Cycle 1(1): loaded http://localhost:42164/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42164/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:08:44 INFO - PROCESS | 3408 | RSS: Main: 148475904 11:08:44 INFO - PROCESS | 3408 | 11:08:47 INFO - PROCESS | 3408 | Cycle 1(1): loaded http://localhost:42164/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42164/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:08:47 INFO - PROCESS | 3408 | RSS: Main: 147935232 11:08:47 INFO - PROCESS | 3408 | 11:08:50 INFO - PROCESS | 3408 | Cycle 1(1): loaded http://localhost:42164/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42164/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:08:51 INFO - PROCESS | 3408 | RSS: Main: 148008960 11:08:51 INFO - PROCESS | 3408 | 11:08:52 INFO - PROCESS | 3408 | Cycle 1(1): loaded http://localhost:42164/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42164/tests/kraken/driver.html?testName=ai-astar) 11:08:53 INFO - PROCESS | 3408 | RSS: Main: 149676032 11:08:53 INFO - PROCESS | 3408 | 11:08:53 INFO - PROCESS | 3408 | __start_tp_report 11:08:53 INFO - PROCESS | 3408 | _x_x_mozilla_page_load 11:08:53 INFO - PROCESS | 3408 | _x_x_mozilla_page_load_details 11:08:53 INFO - PROCESS | 3408 | |i|pagename|runs| 11:08:53 INFO - PROCESS | 3408 | |0;ai-astar;113;106;113;111;112;123;111;112;114;112 11:08:53 INFO - PROCESS | 3408 | |1;audio-beat-detection;149;133;155;167;130;154;149;128;168;129 11:08:53 INFO - PROCESS | 3408 | |2;audio-dft;163;162;162;161;161;163;161;165;168;162 11:08:53 INFO - PROCESS | 3408 | |3;audio-fft;72;74;74;72;75;73;145;76;72;73 11:08:53 INFO - PROCESS | 3408 | |4;audio-oscillator;97;97;138;97;97;96;138;96;96;140 11:08:53 INFO - PROCESS | 3408 | |5;imaging-gaussian-blur;110;109;109;113;113;111;110;110;110;110 11:08:53 INFO - PROCESS | 3408 | |6;imaging-darkroom;146;147;147;148;147;147;146;147;147;146 11:08:53 INFO - PROCESS | 3408 | |7;imaging-desaturate;97;96;97;97;97;98;96;97;97;96 11:08:53 INFO - PROCESS | 3408 | |8;json-parse-financial;61;61;65;61;62;63;65;60;57;60 11:08:53 INFO - PROCESS | 3408 | |9;json-stringify-tinderbox;68;67;68;68;67;68;68;68;68;68 11:08:53 INFO - PROCESS | 3408 | |10;stanford-crypto-aes;85;86;86;88;87;86;87;88;87;86 11:08:53 INFO - PROCESS | 3408 | |11;stanford-crypto-ccm;124;131;122;125;123;124;123;127;121;132 11:08:53 INFO - PROCESS | 3408 | |12;stanford-crypto-pbkdf2;141;151;156;156;158;153;153;155;170;156 11:08:53 INFO - PROCESS | 3408 | |13;stanford-crypto-sha256-iterative;68;71;68;68;80;68;66;68;74;68 11:08:53 INFO - PROCESS | 3408 | __end_tp_report 11:08:53 INFO - PROCESS | 3408 | __start_cc_report 11:08:53 INFO - PROCESS | 3408 | _x_x_mozilla_cycle_collect,734 11:08:53 INFO - PROCESS | 3408 | __end_cc_report 11:08:53 INFO - PROCESS | 3408 | __startTimestamp1452280133031__endTimestamp 11:08:53 INFO - PROCESS | 3408 | 11:08:53 INFO - PROCESS | 3408 | ------- Summary: start ------- 11:08:53 INFO - PROCESS | 3408 | Number of tests: 14 11:08:53 INFO - PROCESS | 3408 | 11:08:53 INFO - PROCESS | 3408 | [#0] ai-astar Cycles:10 Average:112.70 Median:112.50 stddev:4.22 (3.7%) stddev-sans-first:4.47 11:08:53 INFO - PROCESS | 3408 | Values: 113.0 106.0 113.0 111.0 112.0 123.0 111.0 112.0 114.0 112.0 11:08:53 INFO - PROCESS | 3408 | 11:08:53 INFO - PROCESS | 3408 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:151.50 stddev:15.37 (10.1%) stddev-sans-first:16.27 11:08:53 INFO - PROCESS | 3408 | Values: 149.0 133.0 155.0 167.0 130.0 154.0 149.0 128.0 168.0 129.0 11:08:53 INFO - PROCESS | 3408 | 11:08:53 INFO - PROCESS | 3408 | [#2] audio-dft Cycles:10 Average:162.80 Median:162.50 stddev:2.20 (1.4%) stddev-sans-first:2.33 11:08:53 INFO - PROCESS | 3408 | Values: 163.0 162.0 162.0 161.0 161.0 163.0 161.0 165.0 168.0 162.0 11:08:53 INFO - PROCESS | 3408 | 11:08:53 INFO - PROCESS | 3408 | [#3] audio-fft Cycles:10 Average:80.60 Median:73.50 stddev:22.67 (30.8%) stddev-sans-first:23.83 11:08:53 INFO - PROCESS | 3408 | Values: 72.0 74.0 74.0 72.0 75.0 73.0 145.0 76.0 72.0 73.0 11:08:53 INFO - PROCESS | 3408 | 11:08:53 INFO - PROCESS | 3408 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:96.50 stddev:20.35 (21.1%) stddev-sans-first:21.10 11:08:53 INFO - PROCESS | 3408 | Values: 97.0 97.0 138.0 97.0 97.0 96.0 138.0 96.0 96.0 140.0 11:08:53 INFO - PROCESS | 3408 | 11:08:53 INFO - PROCESS | 3408 | [#5] imaging-gaussian-blur Cycles:10 Average:110.50 Median:110.00 stddev:1.43 (1.3%) stddev-sans-first:1.51 11:08:53 INFO - PROCESS | 3408 | Values: 110.0 109.0 109.0 113.0 113.0 111.0 110.0 110.0 110.0 110.0 11:08:53 INFO - PROCESS | 3408 | 11:08:53 INFO - PROCESS | 3408 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 11:08:53 INFO - PROCESS | 3408 | Values: 146.0 147.0 147.0 148.0 147.0 147.0 146.0 147.0 147.0 146.0 11:08:53 INFO - PROCESS | 3408 | 11:08:53 INFO - PROCESS | 3408 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:97.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 11:08:53 INFO - PROCESS | 3408 | Values: 97.0 96.0 97.0 97.0 97.0 98.0 96.0 97.0 97.0 96.0 11:08:53 INFO - PROCESS | 3408 | 11:08:53 INFO - PROCESS | 3408 | [#8] json-parse-financial Cycles:10 Average:61.50 Median:61.50 stddev:2.42 (3.9%) stddev-sans-first:2.55 11:08:53 INFO - PROCESS | 3408 | Values: 61.0 61.0 65.0 61.0 62.0 63.0 65.0 60.0 57.0 60.0 11:08:53 INFO - PROCESS | 3408 | 11:08:53 INFO - PROCESS | 3408 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 11:08:53 INFO - PROCESS | 3408 | Values: 68.0 67.0 68.0 68.0 67.0 68.0 68.0 68.0 68.0 68.0 11:08:53 INFO - PROCESS | 3408 | 11:08:53 INFO - PROCESS | 3408 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:87.00 stddev:0.97 (1.1%) stddev-sans-first:0.83 11:08:53 INFO - PROCESS | 3408 | Values: 85.0 86.0 86.0 88.0 87.0 86.0 87.0 88.0 87.0 86.0 11:08:53 INFO - PROCESS | 3408 | 11:08:53 INFO - PROCESS | 3408 | [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:124.50 stddev:3.71 (3.0%) stddev-sans-first:3.91 11:08:53 INFO - PROCESS | 3408 | Values: 124.0 131.0 122.0 125.0 123.0 124.0 123.0 127.0 121.0 132.0 11:08:53 INFO - PROCESS | 3408 | 11:08:53 INFO - PROCESS | 3408 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.90 Median:156.00 stddev:7.13 (4.6%) stddev-sans-first:5.50 11:08:53 INFO - PROCESS | 3408 | Values: 141.0 151.0 156.0 156.0 158.0 153.0 153.0 155.0 170.0 156.0 11:08:53 INFO - PROCESS | 3408 | 11:08:53 INFO - PROCESS | 3408 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:68.00 stddev:4.18 (6.1%) stddev-sans-first:4.37 11:08:53 INFO - PROCESS | 3408 | Values: 68.0 71.0 68.0 68.0 80.0 68.0 66.0 68.0 74.0 68.0 11:08:53 INFO - PROCESS | 3408 | -------- Summary: end -------- 11:08:53 INFO - PROCESS | 3408 | 11:08:53 INFO - TEST-INFO | 3408: exit 0 11:08:54 INFO - TEST-OK | kraken | took 61365ms 11:08:54 INFO - TEST-START | v8_7 11:08:54 INFO - operating with platform_type : linux_ 11:08:54 INFO - Initialising browser for v8_7 test... 11:08:54 INFO - TEST-INFO | started process 3696 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFALPvU/profile http://localhost:42164/getInfo.html) 11:08:59 INFO - PROCESS | 3696 | __metrics Screen width/height:1600/1200 11:08:59 INFO - PROCESS | 3696 | colorDepth:24 11:08:59 INFO - PROCESS | 3696 | Browser inner width/height: 1024/697 11:08:59 INFO - PROCESS | 3696 | __metrics 11:08:59 INFO - PROCESS | 3696 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:09:00 INFO - TEST-INFO | 3696: exit 0 11:09:00 INFO - Browser initialized. 11:09:00 INFO - Running cycle 1/1 for v8_7 test... 11:09:00 INFO - TEST-INFO | started process 3818 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFALPvU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:09:12 INFO - PROCESS | 3818 | RSS: Main: 150024192 11:09:12 INFO - PROCESS | 3818 | 11:09:34 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:42164/tests/v8_7/run.html (next: http://localhost:42164/tests/v8_7/run.html) 11:09:35 INFO - PROCESS | 3818 | RSS: Main: 147021824 11:09:35 INFO - PROCESS | 3818 | 11:09:35 INFO - PROCESS | 3818 | __start_tp_report 11:09:35 INFO - PROCESS | 3818 | _x_x_mozilla_page_load 11:09:35 INFO - PROCESS | 3818 | _x_x_mozilla_page_load_details 11:09:35 INFO - PROCESS | 3818 | |i|pagename|runs| 11:09:35 INFO - PROCESS | 3818 | |0;Richards;168.01075268817203 11:09:35 INFO - PROCESS | 3818 | |1;DeltaBlue;189.07165815844206 11:09:35 INFO - PROCESS | 3818 | |2;Encrypt;279.79854504756577 11:09:35 INFO - PROCESS | 3818 | |3;Decrypt;5186.5284974093265 11:09:35 INFO - PROCESS | 3818 | |4;RayTrace;1083.4236186348862 11:09:35 INFO - PROCESS | 3818 | |5;Earley;706.2146892655368 11:09:35 INFO - PROCESS | 3818 | |6;Boyer;12419.753086419752 11:09:35 INFO - PROCESS | 3818 | |7;RegExp;42416.666666666664 11:09:35 INFO - PROCESS | 3818 | |8;Splay;607.90273556231 11:09:35 INFO - PROCESS | 3818 | |9;NavierStokes;4850.241545893719 11:09:35 INFO - PROCESS | 3818 | __end_tp_report 11:09:35 INFO - PROCESS | 3818 | __startTimestamp1452280175220__endTimestamp 11:09:35 INFO - PROCESS | 3818 | 11:09:35 INFO - PROCESS | 3818 | ------- Summary: start ------- 11:09:35 INFO - PROCESS | 3818 | Number of tests: 10 11:09:35 INFO - PROCESS | 3818 | 11:09:35 INFO - PROCESS | 3818 | [#0] Richards Cycles:1 Average:168.01 Median:168.01 stddev:0.00 (0.0%) 11:09:35 INFO - PROCESS | 3818 | Values: 168.0 11:09:35 INFO - PROCESS | 3818 | 11:09:35 INFO - PROCESS | 3818 | [#1] DeltaBlue Cycles:1 Average:189.07 Median:189.07 stddev:0.00 (0.0%) 11:09:35 INFO - PROCESS | 3818 | Values: 189.1 11:09:35 INFO - PROCESS | 3818 | 11:09:35 INFO - PROCESS | 3818 | [#2] Encrypt Cycles:1 Average:279.80 Median:279.80 stddev:0.00 (0.0%) 11:09:35 INFO - PROCESS | 3818 | Values: 279.8 11:09:35 INFO - PROCESS | 3818 | 11:09:35 INFO - PROCESS | 3818 | [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 11:09:35 INFO - PROCESS | 3818 | Values: 5186.5 11:09:35 INFO - PROCESS | 3818 | 11:09:35 INFO - PROCESS | 3818 | [#4] RayTrace Cycles:1 Average:1083.42 Median:1083.42 stddev:0.00 (0.0%) 11:09:35 INFO - PROCESS | 3818 | Values: 1083.4 11:09:35 INFO - PROCESS | 3818 | 11:09:35 INFO - PROCESS | 3818 | [#5] Earley Cycles:1 Average:706.21 Median:706.21 stddev:0.00 (0.0%) 11:09:35 INFO - PROCESS | 3818 | Values: 706.2 11:09:35 INFO - PROCESS | 3818 | 11:09:35 INFO - PROCESS | 3818 | [#6] Boyer Cycles:1 Average:12419.75 Median:12419.75 stddev:0.00 (0.0%) 11:09:35 INFO - PROCESS | 3818 | Values: 12419.8 11:09:35 INFO - PROCESS | 3818 | 11:09:35 INFO - PROCESS | 3818 | [#7] RegExp Cycles:1 Average:42416.67 Median:42416.67 stddev:0.00 (0.0%) 11:09:35 INFO - PROCESS | 3818 | Values: 42416.7 11:09:35 INFO - PROCESS | 3818 | 11:09:35 INFO - PROCESS | 3818 | [#8] Splay Cycles:1 Average:607.90 Median:607.90 stddev:0.00 (0.0%) 11:09:35 INFO - PROCESS | 3818 | Values: 607.9 11:09:35 INFO - PROCESS | 3818 | 11:09:35 INFO - PROCESS | 3818 | [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 11:09:35 INFO - PROCESS | 3818 | Values: 4850.2 11:09:35 INFO - PROCESS | 3818 | -------- Summary: end -------- 11:09:35 INFO - PROCESS | 3818 | 11:09:36 INFO - TEST-INFO | 3818: exit 0 11:09:36 INFO - TEST-OK | v8_7 | took 42205ms 11:09:36 INFO - SUITE-END | took 1216s 11:09:36 INFO - Completed test suite (00:20:16) 11:09:36 INFO - Working with test: dromaeo_css 11:09:36 INFO - Generating results file: dromaeo_css 11:09:36 INFO - Working with test: kraken 11:09:36 INFO - Generating results file: kraken 11:09:36 INFO - javascript benchmark 11:09:36 INFO - Working with test: v8_7 11:09:36 INFO - Generating results file: v8_7 11:09:36 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:09:36 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 11:09:36 INFO - process_Request line: dromaeo_css 6796.34 graph.html#tests=[[72,64,43]] 11:09:36 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:09:36 INFO - process_Request line: kraken 1531.50 graph.html#tests=[[232,64,43]] 11:09:36 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:09:36 INFO - process_Request line: v8_7 20243.70 graph.html#tests=[[230,64,43]] 11:09:36 INFO - RETURN: dromaeo_css: 6796.34 11:09:36 INFO - RETURN: kraken: 1531.50 11:09:36 INFO - RETURN: v8_7: 20243.70 11:09:36 INFO - javascript benchmark 11:09:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3191.1224413286345, 3209.4062598419277, 3239.7084262416406, 3259.771815972883, 3275.0011246569793, 2570.9742902570993, 5208.114620514512, 5230.320058392408, 5275.973620131894, 5378.946210537893, 5280.947190528093, 5339.119045357511, 5353.143497040474, 5372.0, 5405.540529055025, 4792.161371759928, 4820.855374338776, 4898.51014898509, 4976.800927962877, 5005.349304590398, 4751.714897106167, 4894.632902532307, 4913.336699545552, 4919.901601967958, 4926.0394223126505, 4758.904821903578, 4767.451743049542, 4846.079244943485, 4913.8771530711665, 4959.0, 4866.099771542276, 4877.219644856841, 4883.584895283905, 4892.461829198785, 4899.583535399495, 4746.0, 4842.612590992712, 4847.951520484785, 4906.092372911023, 4929.112759703252, 5072.810215342919, 5080.771365288534, 5082.1360368737405, 5086.618503612244, 5104.183330667112, 5594.992901277768, 5602.243697100921, 5608.327000759894, 5610.18652295419, 5620.775168993236, 5717.914231286492, 5769.3076830780155, 5779.855503612402, 5787.450192231731, 5834.737436815353, 5267.420583735786, 5317.548008419289, 5317.680939143664, 5320.760565774511, 5330.466953304638, 5747.08046712524, 5758.049921762946, 5796.62321949072, 5855.619384740064, 5864.179014937912, 5601.355844077902, 5604.075327570905, 5633.8309850704545, 5642.069058605284, 5661.3206415229615, 5709.486146246858, 5721.5136713379, 5726.169705392695, 5728.255326807488, 5733.541316694738, 5547.805826796042, 5643.830685079372, 5649.12438572022, 5656.8020119295625, 5757.884842303214, 5653.547716182696, 5654.0, 5664.660120392789, 5665.320161580555, 5667.404922483162, 4415.5363686812425, 4427.269500532376, 4430.601245887886, 4434.379186913835, 4473.351364052194, 3850.7111966602615, 3883.7475564088245, 3941.2511622791576, 3945.7237993340764, 3960.7029472789654, 5335.573154147659, 5368.570514358842, 5397.055515284888, 5399.622026458111, 5401.3248343957, 5633.774649014075, 5770.942290577124, 5777.306723193244, 5783.190353350535, 5783.913241301384, 5173.586113111018, 5197.558207552324, 5256.053910296107, 5323.574114070865, 5358.6248962572245, 4861.951380486221, 4882.0724062428735, 4890.413150421901, 4922.50774922512, 4950.18321976877, 5759.366469688331, 5857.560682948796, 5931.228940237742, 5958.791442299499, 5970.5223582114195, 5605.32736071674, 5702.914456283242, 5707.942920570741, 5736.942630573808, 5742.59801813869, 5929.940700592939, 5931.406859314034, 5940.524758019435, 5946.524278057832, 5987.880242395215, 5469.945300546943, 5572.108462645957, 5642.717864106696, 5700.543956483554, 5718.571107166896, 5686.004949133968, 5800.477956983892, 5805.651660900359, 5808.767649293981, 5850.414958504116, 5552.69460179694, 5608.242887210175, 5614.354349249726, 5621.718914054362, 5623.606347555632, 5438.918416223681, 5535.335759708861, 5537.2524709163745, 5549.1676248563035, 5602.411746766531, 5454.645448045864, 5474.507294343528, 5481.671099734029, 5483.7806487740045, 5502.862428439321, 5573.247611572386, 5591.077472217039, 5595.580331475075, 5605.831825045255, 5630.8029218977135, 5384.623076384615, 5451.836444906659, 5494.36814766307, 5511.889762204653, 5561.777528898961], "unit": "score", "name": "dojo.html", "value": 5242.0478883823325}, {"lowerIsBetter": false, "replicates": [527.5384038965907, 543.1743749500758, 555.1339909740803, 555.29754860102, 563.5970281248909, 34869.12827179322, 35457.0, 35893.641063589355, 35913.46129808055, 35960.0, 37467.812660936725, 38091.4286285706, 38120.61879381206, 38213.61786382135, 38226.617733822655, 8368.079511253758, 8531.104234055398, 8545.786355341104, 8558.486490810541, 8571.828563428728, 8270.37972152091, 8330.62512186953, 8386.832263354729, 8396.160383961616, 8414.158584141598, 8604.52675102869, 8654.264387527037, 8673.956630216871, 8699.173578510063, 8700.0, 8549.273311768507, 8602.612882420244, 8629.0, 8634.740957771213, 8649.308055355556, 8540.871886921701, 8672.089430609758, 8683.739487815375, 8694.087120852346, 8704.521251331174, 39091.60908390937, 39560.604393956266, 39658.40512392316, 39681.60318396837, 39695.81673007983, 3140.952885706716, 3172.9206769830707, 3387.6951074403423, 3415.624281329052, 3674.3018826423163, 29150.0, 29258.122256332343, 29515.852420737974, 30048.39903201924, 30621.846890765628, 3872.7482713623526, 3890.3775395936796, 3970.801459927021, 4045.9797701011307, 4129.070959034193, 256502.0, 256822.0, 257874.0, 258743.0, 259798.70100649566, 48831.80256888449, 49295.0, 54345.72827135839, 54918.725406372716, 55088.44911550913, 50504.74747626238, 50521.0, 50664.0, 50702.0, 50743.49256507387, 15068.773968390484, 15133.621659458602, 15211.619709507351, 15227.162506062274, 15265.694686106437, 11706.765864682659, 11814.409279536161, 11822.940885295518, 11875.762484750257, 11953.342566158944, 18601.74469467838, 18727.438176854717, 18775.0, 18820.905895470434, 18896.622067558572, 7439.256074392626, 7620.542767433972, 7648.235176482307, 7696.230376962259, 7822.0, 890.7105190813012, 910.1990248581207, 945.0596656326861, 973.2749101919115, 1049.480507148951, 27877.86061069682, 27928.30179245535, 28310.575341369895, 28527.144185674464, 28633.57049644257, 1030.9845352319721, 1049.2497864027105, 1055.382601178304, 1061.9787604247872, 1139.2594813371375, 14749.336279867432, 14819.925900370428, 14903.478378256708, 14949.70100597982, 14999.700005999819, 299945.0, 304213.0, 304499.0, 304759.0, 308393.0, 49911.25133123006, 50307.0, 50391.0, 50403.0, 50503.49496505062, 1298.3832679477173, 1303.9543615973585, 1315.7565850317721, 1319.6766792135795, 1328.2030781531005, 26691.733082668925, 27153.72846271512, 27491.31271718223, 27651.170464886087, 27820.721792781813, 44681.77659111684, 44874.0, 45126.54873451223, 45335.31997020113, 45432.54567454283, 290842.0, 291638.0, 291692.0, 291888.0, 294136.0, 30725.38549228958, 31464.37071258516, 31489.370212596077, 31593.8420307897, 31768.682313176574, 37584.24831503409, 39313.60686393214, 40411.59588404196, 40643.1871362577, 40762.79618601888, 33239.50140747843, 33889.0, 35263.0, 35349.29301414009, 35598.64401355953, 33721.15697107494, 34374.0, 34940.82529587336, 35714.28571428609, 35859.64140358563, 31214.0, 31624.525632115077, 32053.358932820745, 32141.196470088435, 32424.513632295064, 28670.0, 29102.27244318909, 29487.852560737058, 29669.703302966693, 29674.70325296806, 24045.75954240435, 24409.75590244075, 24544.974546468682, 24701.0, 24709.439902756912], "unit": "score", "name": "ext.html", "value": 17794.355304165296}, {"lowerIsBetter": false, "replicates": [357.48165160517254, 363.36955382411514, 363.7926381962279, 364.31690580162194, 366.3223037380846, 13465.192088474674, 14124.505642302522, 16828.915855420735, 16997.490075297745, 17979.0, 15947.760783588226, 16172.514824555254, 16523.421680241194, 16594.08732519711, 16680.66638667229, 4971.975140124303, 5301.628885977983, 5336.359636843565, 5337.11937530307, 5345.3585569731495, 5108.361454818148, 5227.895442091175, 5258.211268309765, 5263.078961181797, 5315.0432922074015, 5195.740212989354, 5199.896002079956, 5210.9218361724415, 5217.713025783581, 5218.895622087556, 5186.7925282988635, 5187.766550505217, 5316.441773613754, 5557.221988921554, 5562.833115006556, 4968.403791545038, 4971.850844474636, 4983.6013118950395, 5006.249062640597, 5143.074246635604, 12596.748065038739, 12794.48822047117, 12797.040221983389, 15301.387944482318, 18610.255589776392, 2125.6386414309604, 2148.3877095027997, 2185.278857976864, 2233.8101261392803, 2628.5531459651907, 9350.71947841559, 9448.905510944871, 10047.196224302039, 12067.818982715266, 12282.14025018249, 1744.3633073928052, 1758.481248031821, 1822.6901426757483, 1843.6773564626137, 1876.0807204469847, 55604.0, 56720.14919776207, 57163.712721545635, 57867.71066144684, 57938.13092803612, 10014.949925250472, 10205.744856378502, 10276.280660353703, 10280.588776449007, 10344.27590068688, 12480.31515745381, 12924.289164096064, 13043.543475978486, 13434.462621495226, 13459.865401346056, 7336.523125996793, 7465.776026719099, 7616.0099187105325, 7801.063872335356, 7889.763307100796, 7326.377257933135, 7355.227701091415, 7375.741849035258, 7500.099988001475, 7573.46985710995, 4387.890302742457, 4432.202203603382, 4465.687401881837, 4468.709533880287, 4476.619487343547, 1836.908154592265, 1873.8875667459995, 1891.527118220445, 1897.1652472911874, 1902.6480101181048, 797.3541431440551, 914.9176574108229, 964.7057647417605, 1050.9369437833755, 1058.3226734889677, 15565.610859728371, 15937.601559960862, 16330.0, 16339.673206535803, 16594.58513537147, 891.4294851295176, 915.1626261970356, 919.1451949686856, 967.8257913575624, 987.676513471951, 8067.515949043076, 8568.742937711879, 9599.136077752895, 9625.903740962642, 9638.132568068908, 161622.1918890398, 161758.0, 162759.0, 163087.0, 163101.0, 72268.0, 72320.63839680873, 72524.2747572528, 74135.0, 74947.0, 1131.7396998690183, 1142.2632402100598, 1143.6054561176381, 1153.2330999884982, 1153.5385845661801, 14096.36566354496, 14633.707325853211, 14974.775378369552, 15079.0, 15122.09267443957, 29192.27019324534, 29686.257843554085, 30090.84954575213, 30686.539701904043, 31446.528302075945, 33654.49518257277, 33728.49407258844, 34443.827780860935, 35585.28829423449, 37426.25147497089, 7169.318914703095, 7383.224761399975, 7416.295451932057, 7540.736074237376, 7622.847543049219, 9614.51927403613, 11170.050545703381, 11216.046636036028, 11250.381229032482, 11537.596184133516, 9418.62325506972, 9450.102240287162, 9488.525573721425, 9708.0, 9961.40231586107, 9195.816083678155, 9221.861672075058, 9557.378770379903, 9695.321327507289, 9967.40195588267, 9293.210077143518, 9956.253281003808, 9964.651237206663, 10000.849987250343, 10469.214808889212, 6754.763583274758, 7220.494565380373, 7345.632718363953, 7354.6322683866665, 7361.558306501627, 8897.154770296811, 9112.407693499901, 9555.952220238854, 9582.185514231369, 9846.261530385107], "unit": "score", "name": "jquery.html", "value": 7775.886722330932}, {"lowerIsBetter": false, "replicates": [1412.3926711514048, 1416.950406735764, 1542.8148622165343, 1711.8117007129222, 1738.6696527659744, 7758.767236982892, 7838.764837054883, 7920.445568810185, 8000.519968801868, 8093.39299552533, 7948.364130869531, 7965.561894095822, 7994.200579942003, 8064.475809072406, 8072.233137851895, 2312.1213938703313, 2360.9645855312183, 2371.905123795046, 2374.1097088591778, 2381.6427535869584, 2385.355953892448, 2394.736578976311, 2412.2883749293915, 2435.038159926828, 2436.890339934698, 2272.3296627494847, 2335.369450248432, 2358.6226203807396, 2384.666146739458, 2401.231605886117, 2345.6012477878803, 2358.080348664014, 2378.892949817271, 2386.5823480890776, 2388.0, 2315.7684231576877, 2366.0535785685693, 2370.3363058343693, 2372.3120295114395, 2372.383180373098, 8063.838723225561, 8097.797555061112, 8113.391495637792, 8117.715879944174, 8118.0, 4696.295555666643, 4846.103470857903, 4856.0, 4858.878528036792, 4880.853574392774, 3125.0, 3189.489681650925, 3236.288016636336, 3244.3349113431927, 3247.772655914087, 1021.9029192226726, 1034.2656713733259, 1048.161470823346, 1049.564430761233, 1078.1321036565562, 11236.719082022933, 11298.435078246055, 11302.0, 11313.83029254562, 11320.377379244139, 4252.192083504125, 4270.765107919032, 4328.632066274402, 4330.675199360061, 4344.370066340363, 9061.184493395625, 9108.0, 9114.680986165586, 9117.225035872025, 9132.634694612274, 4823.1800593899125, 4837.9032419351415, 4844.031193761261, 4852.4662287148385, 4860.538248866352, 4341.674374421931, 4343.543927887589, 4387.868363949086, 4399.604035636744, 4420.093880754502, 3507.2459421224557, 3526.2594855080206, 3561.5191949086543, 3574.195805943694, 3577.624349443323, 1073.7959787640323, 1076.042322333124, 1078.1267173589417, 1090.7000574841982, 1096.6490722968733, 963.942163470194, 1014.9289549731448, 1015.5836107196014, 1121.3047910295668, 1293.9611811645666, 7232.0, 7246.565206087652, 7290.198078211392, 7292.525985810906, 7299.598522081336, 1179.2688533109526, 1202.5189924030458, 1210.6489118155637, 1220.1824777399163, 1236.3509157692283, 5837.153612726216, 5895.528357731371, 5922.170896074553, 5974.761009559656, 5996.340402555803, 9206.26349892007, 9477.715668529956, 9598.088181622734, 9623.133917947418, 9649.13157815786, 9351.15839574428, 9362.672306469241, 9476.099770521789, 9491.0, 9503.19222866064, 7501.212372700897, 7522.247775222543, 7595.5822429766895, 7602.087749469988, 7630.923690763132, 7207.423406127392, 7313.853722925618, 7334.376577990931, 7336.96331518339, 7368.963155184189, 8540.103289154798, 8680.826383472422, 8712.303015758851, 8722.476651400937, 8836.248918841971, 8890.955545222232, 8916.375853690439, 8920.152585504367, 9089.454632722058, 9138.13187747163, 6707.396334329738, 6709.295523970108, 6773.525853190229, 6838.897416538656, 6859.2454829969665, 7389.889151662837, 7486.475946683898, 7498.850022999619, 7508.2867127622785, 7527.096748390229, 6993.825154371181, 7200.135983681992, 7212.603306818175, 7290.307420795016, 7363.410927125924, 6869.690863911036, 6956.443484521327, 6981.581105133505, 6989.440844732308, 7003.684834182576, 6961.99051137572, 7087.574745515286, 7106.253843346374, 7113.253108423748, 7170.784876453715, 6520.543561950618, 6571.112899758663, 6601.801945941629, 6606.966965165144, 6613.371729685672, 6645.0, 6660.100886380276, 6843.589384636938, 6934.133233345832, 6939.791806245821], "unit": "score", "name": "mootools.html", "value": 4581.5668648558885}, {"lowerIsBetter": false, "replicates": [344.7810640243445, 349.67654919199737, 352.44489928362833, 354.21718003212897, 355.25746214816326, 6127.693615319227, 6257.0927215553775, 6304.306526282106, 6328.62028278303, 6338.7464501419945, 6048.758049678007, 6154.846128846781, 6165.321814600402, 6188.040853667678, 6211.9068213976825, 4796.472388037313, 4804.495527969565, 4810.879728006802, 4813.109574728686, 4813.470518242991, 4804.25534042224, 4817.012512434942, 4825.372701548794, 4827.927581086286, 4833.299171620113, 4706.058788242365, 4805.231163013901, 4807.495213002637, 4813.061453016646, 4829.613630909519, 4788.353572267734, 4799.328094066834, 4799.784009719536, 4811.903761924742, 4813.133635945528, 4213.557576454459, 4226.640735537483, 4227.767472788995, 4238.19474299882, 4251.171021650779, 5871.471567558898, 5877.0, 5877.177195192677, 5878.735456904449, 5896.380880007623, 5397.109476936301, 5542.5565954723525, 5557.694326812024, 5557.722113894289, 5564.165375193713, 6625.602463852184, 6632.0, 6639.771642246152, 6643.335666433366, 6646.202455705346, 4671.929921051187, 4672.976635116803, 4673.719576825401, 4675.766211689436, 4696.647751418657, 6809.693563789641, 6964.582125072512, 6970.965145174242, 6978.511504194708, 6998.510104292702, 4775.904481910342, 4776.593989510861, 4779.402574678165, 4785.736784476818, 4789.616830653539, 4810.0, 4834.033193361342, 4837.588804951548, 4845.6123510119105, 4855.6115510759055, 5582.49757521825, 5586.1062230043, 5588.748506317225, 5598.468145526169, 5601.271834661549, 6586.1438013058, 6679.56582822115, 6700.162479690039, 6705.195376554747, 6729.293424190488, 1651.3147043976614, 1683.1163639089575, 1691.4418241980118, 1697.2871394014544, 1700.6088599622155, 1098.5880294889416, 1120.1151090638468, 1132.7281452451352, 1135.500379832871, 1145.5532342386475, 6180.227471566054, 6248.31268560458, 6251.74993000284, 6251.999680051261, 6260.874782504416, 6765.154355705537, 6778.864422711518, 6788.117544719254, 6807.0, 6823.420009299166, 6118.0, 6232.407921247474, 6239.532035097386, 6241.469475094668, 6257.9687101564205, 3702.9074273143387, 3731.421629647409, 3736.6076561961145, 3739.9439008414897, 3750.4186851038135, 7100.609466479394, 7104.360607545243, 7104.467164962649, 7112.608806515691, 7122.145342558926, 6917.308269173143, 6992.720291188397, 7019.438444924496, 7031.226565077837, 7070.292970702889, 7032.472564557678, 7077.504574679826, 7086.326798954195, 7086.574805511686, 7097.680604372816, 6790.524663273523, 6791.45668346541, 6806.9659651703405, 6814.182298124257, 6826.112605361272, 6665.833354166185, 6727.831804204934, 6756.425703815231, 6764.154480689914, 6895.5173137881875, 7276.126864776261, 7280.381167600814, 7284.053073100463, 7297.452691048299, 7305.634718263959, 4681.976590117028, 4703.294505824154, 4740.928886066643, 4753.215719406259, 4763.380760501252, 6811.318868113149, 6885.173779146334, 6903.792886213421, 6917.342852429011, 6962.860742785218, 6669.7665581704405, 6692.564983276072, 6749.5612785168805, 6797.66011699423, 6812.216595091628, 6740.359665831738, 6750.459963202834, 6755.932440675727, 6779.457643388616, 6786.728530858711, 6453.257875344396, 6596.241432235162, 6619.205695316593, 6628.171478565179, 6658.83352916181, 6782.423494002867, 6785.898211526733, 6797.320267973361, 6801.557898736566, 6807.625580593115, 6573.94816829305, 6605.5376123670885, 6610.0084987250375, 6613.503987200883, 6616.2391324996315], "unit": "score", "name": "prototype.html", "value": 5029.782420341529}, {"lowerIsBetter": false, "replicates": [728.6866647341641, 751.3726038757637, 752.4394326226961, 802.8193656427304, 837.5686521441459, 11354.318740875553, 11536.423178841045, 11554.133439992003, 11588.768224635502, 11649.708757281072, 12246.387680615979, 12250.754984900297, 12319.322437265946, 12339.691507712312, 12343.01255899528, 652.4128284543901, 657.2540166910567, 772.5364781131333, 789.171370061436, 795.3637090327744, 773.0916173496148, 786.8426314737047, 793.7221972309675, 793.7579038393287, 793.809485723428, 808.720991258015, 818.9140140285274, 821.3470291118546, 821.6754382019099, 822.0300045945781, 814.2183503836325, 815.3517953227199, 817.2807929022451, 819.1644522586987, 821.1049955548451, 603.6951339573532, 603.846019265089, 605.05913304811, 606.6208619612742, 607.1318015238207, 11954.581589644407, 11969.281843089442, 11983.700407489796, 11990.04079673624, 12006.219595726338, 11793.94103029488, 11841.0, 11848.34834084125, 12031.51873925042, 12447.004239660895, 9756.707298781048, 10342.844857327145, 10435.165186785114, 10446.0, 10537.578496860117, 3927.7446965947406, 3927.8036098194975, 3978.8806335809973, 4019.015341241385, 4088.325426304656, 41328.0, 42170.78914605438, 42187.36718949218, 42327.0, 42371.788141059405, 9194.080591940752, 9310.255179585753, 9430.0, 9811.901880981242, 9826.852597211047, 16373.590660233589, 16444.506664800076, 16476.917615412087, 16500.17499125039, 16502.42241521565, 7086.964565177141, 7294.234105418961, 7323.9267607323245, 7324.63376831167, 7329.303716146957, 3874.651281384689, 3908.159745654698, 3965.20695860829, 4035.051762835731, 4036.3541833307117, 3007.173027417434, 3057.92355191122, 3070.8771649134233, 3074.123874695701, 3075.384923015406, 532.6298222735239, 544.9373322067934, 546.6856557479465, 547.4744245524341, 554.4981791478718, 447.60163454525497, 486.6812237984126, 488.4626910398533, 494.14759539794284, 557.4258513730864, 7614.390848732088, 7693.384529237647, 8024.479438764064, 8038.115807261197, 8050.637721302555, 539.1669870050781, 576.6396002498439, 649.8602800397937, 659.5679829711546, 696.6485019063001, 3692.1877187018813, 4140.275451795924, 4169.958300416957, 4207.158568286355, 4329.480462344476, 52063.0, 52983.20525192125, 53286.46713532892, 53406.19890701643, 53526.46473535293, 46925.061498769835, 47644.0, 48382.06471741162, 48532.27201591979, 48692.51307486951, 42763.0, 43978.780106099905, 44321.0, 44328.556714432445, 44474.110517789464, 8209.58952052383, 8347.874781878156, 8422.073571907207, 8450.66197352099, 8654.610542525475, 33046.83476582602, 33216.667833322324, 33727.325453491285, 34220.14449638779, 34306.14234644154, 40073.59926400699, 41326.0, 41910.580894190665, 42774.0, 42818.57181428146, 9786.314957952874, 10229.897701022894, 10257.58969641206, 10938.507767150339, 11214.943925280322, 10307.639232626821, 10378.481075946022, 10437.947810260901, 10695.197860160364, 10696.62561810333, 9899.257555683209, 10012.39925604466, 10093.5457904393, 10161.390316581028, 10486.318389304672, 10544.26190166681, 10641.521131548943, 10925.125989920629, 10999.945000274947, 11059.50232239535, 9667.371620844622, 9708.2718796092, 9814.33019331718, 9949.701508954742, 9973.700788976343, 7772.650230739743, 7969.72105976288, 8069.919300806917, 8091.1099779025435, 8482.915170848213, 8382.858308011524, 8726.69456569017, 8862.158094980967, 8965.910340896768, 9282.257419406566], "unit": "score", "name": "yui.html", "value": 5895.461981714112}], "name": "dromaeo_css", "value": 6796.335166036372}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 106.0, 113.0, 111.0, 112.0, 123.0, 111.0, 112.0, 114.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.7}, {"lowerIsBetter": true, "replicates": [149.0, 133.0, 155.0, 167.0, 130.0, 154.0, 149.0, 128.0, 168.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 146.2}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 162.0, 161.0, 161.0, 163.0, 161.0, 165.0, 168.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.8}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 74.0, 72.0, 75.0, 73.0, 145.0, 76.0, 72.0, 73.0], "unit": "score", "name": "audio-fft", "value": 80.6}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 138.0, 97.0, 97.0, 96.0, 138.0, 96.0, 96.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 109.2}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 113.0, 113.0, 111.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.5}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 148.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 97.0, 97.0, 97.0, 98.0, 96.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.8}, {"lowerIsBetter": true, "replicates": [61.0, 61.0, 65.0, 61.0, 62.0, 63.0, 65.0, 60.0, 57.0, 60.0], "unit": "score", "name": "json-parse-financial", "value": 61.5}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 68.0, 68.0, 67.0, 68.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 86.0, 88.0, 87.0, 86.0, 87.0, 88.0, 87.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.6}, {"lowerIsBetter": true, "replicates": [124.0, 131.0, 122.0, 125.0, 123.0, 124.0, 123.0, 127.0, 121.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.2}, {"lowerIsBetter": true, "replicates": [141.0, 151.0, 156.0, 156.0, 158.0, 153.0, 153.0, 155.0, 170.0, 156.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 154.9}, {"lowerIsBetter": true, "replicates": [68.0, 71.0, 68.0, 68.0, 80.0, 68.0, 66.0, 68.0, 74.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.9}], "name": "kraken", "value": 1531.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.01075268817203], "unit": "score", "name": "Richards", "value": 210.11750400000008}, {"lowerIsBetter": false, "replicates": [189.07165815844206], "unit": "score", "name": "DeltaBlue", "value": 349.698102}, {"lowerIsBetter": false, "replicates": [279.79854504756577], "unit": "score", "name": "Encrypt", "value": 951.330894}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1083.4236186348862], "unit": "score", "name": "RayTrace", "value": 683.0098469999997}, {"lowerIsBetter": false, "replicates": [706.2146892655368], "unit": "score", "name": "Earley", "value": 943.711608}, {"lowerIsBetter": false, "replicates": [12419.753086419752], "unit": "score", "name": "Boyer", "value": 53.66153379721673}, {"lowerIsBetter": false, "replicates": [42416.666666666664], "unit": "score", "name": "RegExp", "value": 21.47705304518664}, {"lowerIsBetter": false, "replicates": [607.90273556231], "unit": "score", "name": "Splay", "value": 134.052695}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 20243.704248218342}]} 11:09:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20243.70"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1531.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6796.34"}}} 11:09:36 INFO - Return code: 0 11:09:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:09:36 INFO - # TBPL SUCCESS # 11:09:36 INFO - Running post-action listener: _resource_record_post_action 11:09:36 INFO - Running post-run listener: _resource_record_post_run 11:09:37 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 0; Write bytes: 564342784; Read time: 0; Write time: 1615552 11:09:37 INFO - install - Wall time: 16s; CPU: 18.0%; Read bytes: 0; Write bytes: 255332352; Read time: 0; Write time: 757192 11:09:37 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 0; Write bytes: 308133888; Read time: 0; Write time: 858316 11:09:37 INFO - Running post-run listener: _upload_blobber_files 11:09:37 INFO - Blob upload gear active. 11:09:37 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:09:37 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 11:09:37 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'] 11:09:37 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 11:09:38 INFO - (blobuploader) - INFO - Open directory for files ... 11:09:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:09:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:09:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:09:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:09:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:09:39 INFO - (blobuploader) - INFO - Done attempting. 11:09:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:09:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:09:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:09:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:09:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:09:40 INFO - (blobuploader) - INFO - Done attempting. 11:09:40 INFO - (blobuploader) - INFO - Iteration through files over. 11:09:40 INFO - Return code: 0 11:09:40 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:09:40 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:09:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f82407bf37a42e9a790e8ce6c0b109ded6d0b3e936efc05514395643acb1586f97fa22ff6dec4fff6bc015cefbaeebb22a29e404e8faaac91932b2b89fa51a3c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/25a27b22c8b48fe5cc544220e4f252ad3fbfbd717e680e1ed14276ea591ad265b9ef75ab23fd23b416aeeb64ce0f399eb1b5cad40bb16d911d4a691a673016a4"} 11:09:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:09:40 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:09:40 INFO - Contents: 11:09:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f82407bf37a42e9a790e8ce6c0b109ded6d0b3e936efc05514395643acb1586f97fa22ff6dec4fff6bc015cefbaeebb22a29e404e8faaac91932b2b89fa51a3c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/25a27b22c8b48fe5cc544220e4f252ad3fbfbd717e680e1ed14276ea591ad265b9ef75ab23fd23b416aeeb64ce0f399eb1b5cad40bb16d911d4a691a673016a4"} 11:09:40 INFO - Copying logs to upload dir... 11:09:40 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1274.228546 ========= master_lag: 0.63 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-08 11:09:40.424402) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-08 11:09:40.428119) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1452278550.739751-76097925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f82407bf37a42e9a790e8ce6c0b109ded6d0b3e936efc05514395643acb1586f97fa22ff6dec4fff6bc015cefbaeebb22a29e404e8faaac91932b2b89fa51a3c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/25a27b22c8b48fe5cc544220e4f252ad3fbfbd717e680e1ed14276ea591ad265b9ef75ab23fd23b416aeeb64ce0f399eb1b5cad40bb16d911d4a691a673016a4"} build_url:https://queue.taskcluster.net/v1/task/JoVNINrqRRezQG5raw0M6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011108 build_url: 'https://queue.taskcluster.net/v1/task/JoVNINrqRRezQG5raw0M6A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f82407bf37a42e9a790e8ce6c0b109ded6d0b3e936efc05514395643acb1586f97fa22ff6dec4fff6bc015cefbaeebb22a29e404e8faaac91932b2b89fa51a3c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/25a27b22c8b48fe5cc544220e4f252ad3fbfbd717e680e1ed14276ea591ad265b9ef75ab23fd23b416aeeb64ce0f399eb1b5cad40bb16d911d4a691a673016a4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-08 11:09:40.456479) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 11:09:40.456818) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1452278550.739751-76097925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004326 ========= master_lag: 0.47 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 11:09:40.930631) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-08 11:09:40.933113) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-08 11:09:40.933566) ========= ========= Total master_lag: 1.24 =========