builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-054 starttime: 1450313385.71 results: success (0) buildid: 20151216143013 builduid: f1b4d2d0ce144db3aaf22dc1fd9016ed revision: 1cf6f364d319a2932f1fc9fac255d9d24b495075 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:45.714836) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:45.715818) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:45.716226) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1450313244.823337-530355925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005043 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:45.780964) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:45.784424) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:45.842012) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:45.842349) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1450313244.823337-530355925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.027944 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:45.896278) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:45.896613) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:45.896964) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:45.897232) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1450313244.823337-530355925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-16 16:49:45-- 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% 17.4M=0.001s 2015-12-16 16:49:46 (17.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.287181 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:46.198871) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:46.199171) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1450313244.823337-530355925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.115734 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:46.327851) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:46.328190) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1cf6f364d319a2932f1fc9fac255d9d24b495075 --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 1cf6f364d319a2932f1fc9fac255d9d24b495075 --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=752f8c75933e5bfb3b8f10bb000001ce-1450313244.823337-530355925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-16 16:49:46,328 truncating revision to first 12 chars 2015-12-16 16:49:46,328 Setting DEBUG logging. 2015-12-16 16:49:46,328 attempt 1/10 2015-12-16 16:49:46,328 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1cf6f364d319?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-16 16:49:46,579 unpacking tar archive at: fx-team-1cf6f364d319/testing/mozharness/ program finished with exit code 0 elapsedTime=0.522439 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:46.868123) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:46.868407) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:46.877750) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:46.878065) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 16:49:46.878571) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-16 16:49:46.878851) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --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', '--system-bits', '64', '--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=752f8c75933e5bfb3b8f10bb000001ce-1450313244.823337-530355925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:49:47 INFO - MultiFileLogger online at 20151216 16:49:47 in /builds/slave/test-pgo 16:49:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:49:47 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:49:47 INFO - {'append_to_log': False, 16:49:47 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:49:47 INFO - 'blob_upload_branch': 'Fx-Team', 16:49:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:49:47 INFO - 'branch': 'Fx-Team', 16:49:47 INFO - 'buildbot_json_path': 'buildprops.json', 16:49:47 INFO - 'config_files': ('talos/linux_config.py',), 16:49:47 INFO - 'default_actions': ('clobber', 16:49:47 INFO - 'read-buildbot-config', 16:49:47 INFO - 'download-and-extract', 16:49:47 INFO - 'populate-webroot', 16:49:47 INFO - 'create-virtualenv', 16:49:47 INFO - 'install', 16:49:47 INFO - 'run-tests'), 16:49:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:49:47 INFO - 'download_minidump_stackwalk': True, 16:49:47 INFO - 'download_symbols': 'ondemand', 16:49:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:49:47 INFO - 'tooltool.py': '/tools/tooltool.py', 16:49:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:49:47 INFO - '/tools/misc-python/virtualenv.py')}, 16:49:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:49:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:49:47 INFO - 'installer_path': 'installer.exe', 16:49:47 INFO - 'log_level': 'info', 16:49:47 INFO - 'log_name': 'talos', 16:49:47 INFO - 'log_to_console': True, 16:49:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:49:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:49:47 INFO - 'opt_config_files': (), 16:49:47 INFO - 'pip_index': False, 16:49:47 INFO - 'sps_profile': False, 16:49:47 INFO - 'sps_profile_interval': 0, 16:49:47 INFO - 'suite': 'dromaeojs-e10s', 16:49:47 INFO - 'system_bits': '64', 16:49:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:49:47 INFO - 'title': 'talos-linux64-ix-054', 16:49:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:49:47 INFO - 'use_talos_json': True, 16:49:47 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:49:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:49:47 INFO - 'work_dir': 'build'} 16:49:47 INFO - ##### 16:49:47 INFO - ##### Running clobber step. 16:49:47 INFO - ##### 16:49:47 INFO - Running pre-action listener: _resource_record_pre_action 16:49:47 INFO - Running main action method: clobber 16:49:47 INFO - rmtree: /builds/slave/test-pgo/build 16:49:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:49:52 INFO - Running post-action listener: _resource_record_post_action 16:49:52 INFO - ##### 16:49:52 INFO - ##### Running read-buildbot-config step. 16:49:52 INFO - ##### 16:49:52 INFO - Running pre-action listener: _resource_record_pre_action 16:49:52 INFO - Running main action method: read_buildbot_config 16:49:52 INFO - Using buildbot properties: 16:49:52 INFO - { 16:49:52 INFO - "project": "", 16:49:52 INFO - "product": "firefox", 16:49:52 INFO - "script_repo_revision": "production", 16:49:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 16:49:52 INFO - "repository": "", 16:49:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 16:49:52 INFO - "buildid": "20151216143013", 16:49:52 INFO - "pgo_build": "True", 16:49:52 INFO - "basedir": "/builds/slave/test-pgo", 16:49:52 INFO - "buildnumber": 147, 16:49:52 INFO - "slavename": "talos-linux64-ix-054", 16:49:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:49:52 INFO - "platform": "ubuntu64_hw", 16:49:52 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 16:49:52 INFO - "branch": "fx-team", 16:49:52 INFO - "repo_path": "integration/fx-team", 16:49:52 INFO - "revision": "1cf6f364d319a2932f1fc9fac255d9d24b495075", 16:49:52 INFO - "stage_platform": "linux64-pgo", 16:49:52 INFO - "builduid": "f1b4d2d0ce144db3aaf22dc1fd9016ed", 16:49:52 INFO - "slavebuilddir": "test" 16:49:52 INFO - } 16:49:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 16:49:52 INFO - Running post-action listener: _resource_record_post_action 16:49:52 INFO - ##### 16:49:52 INFO - ##### Running download-and-extract step. 16:49:52 INFO - ##### 16:49:52 INFO - Running pre-action listener: _resource_record_pre_action 16:49:52 INFO - Running main action method: download_and_extract 16:49:52 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:52 INFO - https://queue.taskcluster.net/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:49:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/test_packages.json 16:49:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/test_packages.json 16:49:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:49:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:49:52 INFO - Downloaded 1302 bytes. 16:49:52 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:49:52 INFO - Using the following test package requirements: 16:49:52 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:49:52 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:49:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:49:52 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:49:52 INFO - u'jsshell-linux-x86_64.zip'], 16:49:52 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:49:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:49:52 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:49:52 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:49:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:49:52 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:49:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:49:52 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:49:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:49:52 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:49:52 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:49:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:49:52 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:52 INFO - https://queue.taskcluster.net/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:49:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:49:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:49:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/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 16:49:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/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 16:49:56 INFO - Downloaded 23119090 bytes. 16:49:56 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 16:49:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:49:56 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 16:49:57 INFO - Return code: 0 16:49:57 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 16:49: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')]} 16:49:57 INFO - https://queue.taskcluster.net/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:49:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:49:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:49:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/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 16:49:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/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 16:49:58 INFO - Downloaded 23119090 bytes. 16:49:58 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 16:49:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:49:58 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 16:50:00 INFO - Return code: 0 16:50:00 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')]} 16:50:00 INFO - https://queue.taskcluster.net/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:50:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:50:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:50:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/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 16:50:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/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 16:50:01 INFO - Downloaded 11132052 bytes. 16:50:01 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 16:50:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:50:01 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 16:50:01 INFO - Return code: 0 16:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:01 INFO - https://queue.taskcluster.net/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:50:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:50:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:50:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/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 16:50:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8CL7JG91RuinZPq9IQrkGw/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 16:50:03 INFO - Downloaded 59284684 bytes. 16:50:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:50:03 INFO - mkdir: /builds/slave/test-pgo/properties 16:50:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:50:03 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:50:03 INFO - Contents: 16:50:03 INFO - build_url:https://queue.taskcluster.net/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:50:03 INFO - Running post-action listener: _resource_record_post_action 16:50:03 INFO - Running post-action listener: set_extra_try_arguments 16:50:03 INFO - ##### 16:50:03 INFO - ##### Running populate-webroot step. 16:50:03 INFO - ##### 16:50:03 INFO - Running pre-action listener: _resource_record_pre_action 16:50:03 INFO - Running main action method: populate_webroot 16:50:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:50:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:50:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:50:03 INFO - '--tppagecycles', 16:50:03 INFO - '7'], 16:50:03 INFO - 'tests': ['tsvgm']}}, 16:50:03 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:50:03 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:50:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:50:03 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:50:03 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:50:03 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:50:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:50:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:03 INFO - 'talos_options': ['--e10s'], 16:50:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:50:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:03 INFO - 'tests': ['damp', 'tps']}, 16:50:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:03 INFO - 'talos_options': ['--e10s'], 16:50:03 INFO - 'tests': ['damp', 'tps']}, 16:50:03 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:50:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:50:03 INFO - 'other': {'tests': ['a11yr', 16:50:03 INFO - 'ts_paint', 16:50:03 INFO - 'tpaint', 16:50:03 INFO - 'sessionrestore', 16:50:03 INFO - 'sessionrestore_no_auto_restore']}, 16:50:03 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:50:03 INFO - 'tests': ['a11yr', 16:50:03 INFO - 'ts_paint', 16:50:03 INFO - 'tpaint', 16:50:03 INFO - 'sessionrestore', 16:50:03 INFO - 'sessionrestore_no_auto_restore']}, 16:50:03 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:50:03 INFO - 'tests': ['a11yr', 16:50:03 INFO - 'ts_paint', 16:50:03 INFO - 'tpaint', 16:50:03 INFO - 'sessionrestore', 16:50:03 INFO - 'sessionrestore_no_auto_restore']}, 16:50:03 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:50:03 INFO - 'tests': ['a11yr', 16:50:03 INFO - 'ts_paint', 16:50:03 INFO - 'tpaint', 16:50:03 INFO - 'sessionrestore', 16:50:03 INFO - 'sessionrestore_no_auto_restore']}, 16:50:03 INFO - 'other_l64': {'tests': ['a11yr', 16:50:03 INFO - 'ts_paint', 16:50:03 INFO - 'tpaint', 16:50:03 INFO - 'sessionrestore', 16:50:03 INFO - 'sessionrestore_no_auto_restore']}, 16:50:03 INFO - 'other_nol64': {'tests': ['a11yr', 16:50:03 INFO - 'ts_paint', 16:50:03 INFO - 'tpaint', 16:50:03 INFO - 'sessionrestore', 16:50:03 INFO - 'sessionrestore_no_auto_restore']}, 16:50:03 INFO - 'svgr': {'tests': ['tsvgx', 16:50:03 INFO - 'tsvgr_opacity', 16:50:03 INFO - 'tart', 16:50:03 INFO - 'tscrollx', 16:50:03 INFO - 'cart']}, 16:50:03 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:50:03 INFO - 'tests': ['tsvgx', 16:50:03 INFO - 'tsvgr_opacity', 16:50:03 INFO - 'tart', 16:50:03 INFO - 'tscrollx', 16:50:03 INFO - 'cart']}, 16:50:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:03 INFO - 'tests': ['tp5o']}, 16:50:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:03 INFO - 'talos_options': ['--e10s'], 16:50:03 INFO - 'tests': ['tp5o']}, 16:50:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:03 INFO - 'talos_options': ['--xperf_path', 16:50:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:50:03 INFO - 'tests': ['tp5n']}, 16:50:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:03 INFO - 'talos_options': ['--e10s', 16:50:03 INFO - '--xperf_path', 16:50:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:50:03 INFO - 'tests': ['tp5n']}}, 16:50:03 INFO - 'talos.zip': {'path': '', 16:50:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:50:03 INFO - Running post-action listener: _resource_record_post_action 16:50:03 INFO - ##### 16:50:03 INFO - ##### Running create-virtualenv step. 16:50:03 INFO - ##### 16:50:03 INFO - Running pre-action listener: _resource_record_pre_action 16:50:03 INFO - Running main action method: create_virtualenv 16:50:03 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:50:03 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 16:50:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:50:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:50:03 INFO - Using real prefix '/usr' 16:50:03 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:50:04 INFO - Installing distribute.............................................................................................................................................................................................done. 16:50:06 INFO - Installing pip.................done. 16:50:06 INFO - Return code: 0 16:50:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:50:06 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')]} 16:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:06 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')]} 16:50:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:06 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 0x7f93b69e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba9350>, '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 0x1baa250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baa6e0>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1450313244.823337-530355925', '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 16:50:06 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 16:50:06 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 16:50:06 INFO - Using env: {'DISPLAY': ':0', 16:50:06 INFO - 'HOME': '/home/cltbld', 16:50:06 INFO - 'LANG': 'en_US.UTF-8', 16:50:06 INFO - 'LANGUAGE': 'en_US:en', 16:50:06 INFO - 'LOGNAME': 'cltbld', 16:50:06 INFO - 'MAIL': '/var/mail/cltbld', 16:50:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:06 INFO - 'MOZ_NO_REMOTE': '1', 16:50:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:06 INFO - 'NO_EM_RESTART': '1', 16:50:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:06 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:06 INFO - 'SHELL': '/bin/bash', 16:50:06 INFO - 'SHLVL': '1', 16:50:06 INFO - 'TERM': 'linux', 16:50:06 INFO - 'TMOUT': '86400', 16:50:06 INFO - 'USER': 'cltbld', 16:50:06 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450313244.823337-530355925', 16:50:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:06 INFO - '_': '/tools/buildbot/bin/python'} 16:50:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:06 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 16:50:06 INFO - Cleaning up... 16:50:06 INFO - Return code: 0 16:50:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:50:06 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')]} 16:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:06 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')]} 16:50:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:06 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 0x7f93b69e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba9350>, '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 0x1baa250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baa6e0>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1450313244.823337-530355925', '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 16:50:06 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 16:50:06 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 16:50:06 INFO - Using env: {'DISPLAY': ':0', 16:50:06 INFO - 'HOME': '/home/cltbld', 16:50:06 INFO - 'LANG': 'en_US.UTF-8', 16:50:06 INFO - 'LANGUAGE': 'en_US:en', 16:50:06 INFO - 'LOGNAME': 'cltbld', 16:50:06 INFO - 'MAIL': '/var/mail/cltbld', 16:50:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:06 INFO - 'MOZ_NO_REMOTE': '1', 16:50:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:06 INFO - 'NO_EM_RESTART': '1', 16:50:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:06 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:06 INFO - 'SHELL': '/bin/bash', 16:50:06 INFO - 'SHLVL': '1', 16:50:06 INFO - 'TERM': 'linux', 16:50:06 INFO - 'TMOUT': '86400', 16:50:06 INFO - 'USER': 'cltbld', 16:50:06 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450313244.823337-530355925', 16:50:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:06 INFO - '_': '/tools/buildbot/bin/python'} 16:50:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:06 INFO - Downloading/unpacking psutil>=0.7.1 16:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:08 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 16:50:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:50:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:50:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:50:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:50:08 INFO - Installing collected packages: psutil 16:50:08 INFO - Running setup.py install for psutil 16:50:08 INFO - building 'psutil._psutil_linux' extension 16:50:08 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 16:50:09 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 16:50:09 INFO - building 'psutil._psutil_posix' extension 16:50:09 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 16:50:09 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 16:50:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:50:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:50:09 INFO - Successfully installed psutil 16:50:09 INFO - Cleaning up... 16:50:09 INFO - Return code: 0 16:50:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:50:09 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')]} 16:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:09 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')]} 16:50:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:09 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 0x7f93b69e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba9350>, '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 0x1baa250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baa6e0>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1450313244.823337-530355925', '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 16:50:09 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 16:50:09 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 16:50:10 INFO - Using env: {'DISPLAY': ':0', 16:50:10 INFO - 'HOME': '/home/cltbld', 16:50:10 INFO - 'LANG': 'en_US.UTF-8', 16:50:10 INFO - 'LANGUAGE': 'en_US:en', 16:50:10 INFO - 'LOGNAME': 'cltbld', 16:50:10 INFO - 'MAIL': '/var/mail/cltbld', 16:50:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:10 INFO - 'MOZ_NO_REMOTE': '1', 16:50:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:10 INFO - 'NO_EM_RESTART': '1', 16:50:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:10 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:10 INFO - 'SHELL': '/bin/bash', 16:50:10 INFO - 'SHLVL': '1', 16:50:10 INFO - 'TERM': 'linux', 16:50:10 INFO - 'TMOUT': '86400', 16:50:10 INFO - 'USER': 'cltbld', 16:50:10 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450313244.823337-530355925', 16:50:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:10 INFO - '_': '/tools/buildbot/bin/python'} 16:50:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:50:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:50:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:50:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:50:12 INFO - Installing collected packages: mozsystemmonitor 16:50:12 INFO - Running setup.py install for mozsystemmonitor 16:50:12 INFO - Successfully installed mozsystemmonitor 16:50:12 INFO - Cleaning up... 16:50:12 INFO - Return code: 0 16:50:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:50:12 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')]} 16:50:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:12 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')]} 16:50:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:12 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 0x7f93b69e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba9350>, '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 0x1baa250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baa6e0>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1450313244.823337-530355925', '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 16:50:12 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 16:50:12 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 16:50:12 INFO - Using env: {'DISPLAY': ':0', 16:50:12 INFO - 'HOME': '/home/cltbld', 16:50:12 INFO - 'LANG': 'en_US.UTF-8', 16:50:12 INFO - 'LANGUAGE': 'en_US:en', 16:50:12 INFO - 'LOGNAME': 'cltbld', 16:50:12 INFO - 'MAIL': '/var/mail/cltbld', 16:50:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:12 INFO - 'MOZ_NO_REMOTE': '1', 16:50:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:12 INFO - 'NO_EM_RESTART': '1', 16:50:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:12 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:12 INFO - 'SHELL': '/bin/bash', 16:50:12 INFO - 'SHLVL': '1', 16:50:12 INFO - 'TERM': 'linux', 16:50:12 INFO - 'TMOUT': '86400', 16:50:12 INFO - 'USER': 'cltbld', 16:50:12 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450313244.823337-530355925', 16:50:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:12 INFO - '_': '/tools/buildbot/bin/python'} 16:50:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:12 INFO - Downloading/unpacking blobuploader==1.2.4 16:50:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:50:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:50:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:50:14 INFO - Downloading blobuploader-1.2.4.tar.gz 16:50:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:50:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:50:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:50:14 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 16:50:14 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 16:50:14 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 16:50:14 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 16:50:14 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 16:50:14 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 16:50:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:50:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:50:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:50:14 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 16:50:14 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 16:50:14 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 16:50:14 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 16:50:14 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 16:50:14 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 16:50:14 INFO - Downloading docopt-0.6.1.tar.gz 16:50:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:50:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:50:14 INFO - Installing collected packages: blobuploader, requests, docopt 16:50:14 INFO - Running setup.py install for blobuploader 16:50:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:50:15 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:50:15 INFO - Running setup.py install for requests 16:50:15 INFO - Running setup.py install for docopt 16:50:15 INFO - Successfully installed blobuploader requests docopt 16:50:15 INFO - Cleaning up... 16:50:15 INFO - Return code: 0 16:50:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:50:15 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')]} 16:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:15 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')]} 16:50:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:15 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 0x7f93b69e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba9350>, '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 0x1baa250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baa6e0>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1450313244.823337-530355925', '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 16:50:15 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 16:50:15 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 16:50:15 INFO - Using env: {'DISPLAY': ':0', 16:50:15 INFO - 'HOME': '/home/cltbld', 16:50:15 INFO - 'LANG': 'en_US.UTF-8', 16:50:15 INFO - 'LANGUAGE': 'en_US:en', 16:50:15 INFO - 'LOGNAME': 'cltbld', 16:50:15 INFO - 'MAIL': '/var/mail/cltbld', 16:50:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:15 INFO - 'MOZ_NO_REMOTE': '1', 16:50:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:15 INFO - 'NO_EM_RESTART': '1', 16:50:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:15 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:15 INFO - 'SHELL': '/bin/bash', 16:50:15 INFO - 'SHLVL': '1', 16:50:15 INFO - 'TERM': 'linux', 16:50:15 INFO - 'TMOUT': '86400', 16:50:15 INFO - 'USER': 'cltbld', 16:50:15 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450313244.823337-530355925', 16:50:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:15 INFO - '_': '/tools/buildbot/bin/python'} 16:50:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:50:15 INFO - Running setup.py (path:/tmp/pip-Rm02q_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:50:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:50:15 INFO - Running setup.py (path:/tmp/pip-37URg3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:50:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:50:15 INFO - Running setup.py (path:/tmp/pip-CWBttl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:50:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:50:15 INFO - Running setup.py (path:/tmp/pip-lVROVg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:50:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:50:16 INFO - Running setup.py (path:/tmp/pip-tvnrAH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:50:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:50:16 INFO - Running setup.py (path:/tmp/pip-dQAEnq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:50:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:50:16 INFO - Running setup.py (path:/tmp/pip-0t6ONP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:50:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:50:16 INFO - Running setup.py (path:/tmp/pip-6PU9E4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:50:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:50:16 INFO - Running setup.py (path:/tmp/pip-u1T4tS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:50:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:50:16 INFO - Running setup.py (path:/tmp/pip-T147bK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:50:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:50:16 INFO - Running setup.py (path:/tmp/pip-1W7NMD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:50:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:50:16 INFO - Running setup.py (path:/tmp/pip-VSrkaM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:50:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:50:16 INFO - Running setup.py (path:/tmp/pip-RQMQ2f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:50:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:50:16 INFO - Running setup.py (path:/tmp/pip-z0Lb4D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:50:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:50:16 INFO - Running setup.py (path:/tmp/pip-d65d5f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:50:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:50:16 INFO - Running setup.py (path:/tmp/pip-6Nsr7z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:50:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:50:16 INFO - Running setup.py (path:/tmp/pip-82rDIo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:50:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:50:16 INFO - Running setup.py install for manifestparser 16:50:17 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:50:17 INFO - Running setup.py install for mozcrash 16:50:17 INFO - Running setup.py install for mozdebug 16:50:17 INFO - Running setup.py install for mozdevice 16:50:17 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:50:17 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:50:17 INFO - Running setup.py install for mozfile 16:50:17 INFO - Running setup.py install for mozhttpd 16:50:17 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:50:17 INFO - Running setup.py install for mozinfo 16:50:17 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:50:17 INFO - Running setup.py install for mozInstall 16:50:17 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:50:17 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:50:17 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:50:17 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:50:17 INFO - Running setup.py install for mozleak 16:50:17 INFO - Running setup.py install for mozlog 16:50:17 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:50:17 INFO - Running setup.py install for moznetwork 16:50:18 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:50:18 INFO - Running setup.py install for mozprocess 16:50:18 INFO - Running setup.py install for mozprofile 16:50:18 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:50:18 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:50:18 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:50:18 INFO - Running setup.py install for mozrunner 16:50:18 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:50:18 INFO - Running setup.py install for mozscreenshot 16:50:18 INFO - Running setup.py install for moztest 16:50:18 INFO - Running setup.py install for mozversion 16:50:18 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:50:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:50:18 INFO - Cleaning up... 16:50:18 INFO - Return code: 0 16:50:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:50: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')]} 16:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50: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')]} 16:50:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:18 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 0x7f93b69e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba9350>, '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 0x1baa250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baa6e0>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1450313244.823337-530355925', '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 16:50:18 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 16:50:18 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 16:50:18 INFO - Using env: {'DISPLAY': ':0', 16:50:18 INFO - 'HOME': '/home/cltbld', 16:50:18 INFO - 'LANG': 'en_US.UTF-8', 16:50:18 INFO - 'LANGUAGE': 'en_US:en', 16:50:18 INFO - 'LOGNAME': 'cltbld', 16:50:18 INFO - 'MAIL': '/var/mail/cltbld', 16:50:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:18 INFO - 'MOZ_NO_REMOTE': '1', 16:50:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:18 INFO - 'NO_EM_RESTART': '1', 16:50:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:18 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:18 INFO - 'SHELL': '/bin/bash', 16:50:18 INFO - 'SHLVL': '1', 16:50:18 INFO - 'TERM': 'linux', 16:50:18 INFO - 'TMOUT': '86400', 16:50:18 INFO - 'USER': 'cltbld', 16:50:18 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450313244.823337-530355925', 16:50:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:18 INFO - '_': '/tools/buildbot/bin/python'} 16:50:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:50:18 INFO - Running setup.py (path:/tmp/pip-qEhNts-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:50:19 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)) 16:50:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:50:19 INFO - Running setup.py (path:/tmp/pip-7XAX27-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:50:19 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)) 16:50:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:50:19 INFO - Running setup.py (path:/tmp/pip-SnPnCt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:50:19 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)) 16:50:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:50:19 INFO - Running setup.py (path:/tmp/pip-lu7Ha2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:50:19 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)) 16:50:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:50:19 INFO - Running setup.py (path:/tmp/pip-hVT5FR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:50:19 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)) 16:50:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:50:19 INFO - Running setup.py (path:/tmp/pip-8w5mWa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:50:19 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)) 16:50:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:50:19 INFO - Running setup.py (path:/tmp/pip-co8KwR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:50:19 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)) 16:50:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:50:19 INFO - Running setup.py (path:/tmp/pip-VPFXQf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:50:19 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)) 16:50:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:50:19 INFO - Running setup.py (path:/tmp/pip-_5Cpcs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:50:19 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)) 16:50:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:50:19 INFO - Running setup.py (path:/tmp/pip-S4bdws-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:50:19 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)) 16:50:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:50:19 INFO - Running setup.py (path:/tmp/pip-29n37q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:50:19 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)) 16:50:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:50:19 INFO - Running setup.py (path:/tmp/pip-HMjUod-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:50:19 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)) 16:50:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:50:19 INFO - Running setup.py (path:/tmp/pip-rEU1JU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:50:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 16:50:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:50:19 INFO - Running setup.py (path:/tmp/pip-71KBLt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:50:19 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)) 16:50:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:50:19 INFO - Running setup.py (path:/tmp/pip-fPgVf6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:50:20 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)) 16:50:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:50:20 INFO - Running setup.py (path:/tmp/pip-7S_aZg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:50:20 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)) 16:50:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:50:20 INFO - Running setup.py (path:/tmp/pip-9a5k_q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:50:20 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)) 16:50:20 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)) 16:50:20 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)) 16:50:20 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)) 16:50:20 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)) 16:50:20 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)) 16:50:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:50:20 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 16:50:20 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 16:50:20 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 16:50:20 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 16:50:20 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 16:50:20 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 16:50:21 INFO - Downloading blessings-1.5.1.tar.gz 16:50:21 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 16:50:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:50:21 INFO - Installing collected packages: blessings 16:50:21 INFO - Running setup.py install for blessings 16:50:22 INFO - Successfully installed blessings 16:50:22 INFO - Cleaning up... 16:50:22 INFO - Return code: 0 16:50:22 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:50:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:50:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:50:22 INFO - Reading from file tmpfile_stdout 16:50:22 INFO - Current package versions: 16:50:22 INFO - argparse == 1.2.1 16:50:22 INFO - blessings == 1.5.1 16:50:22 INFO - blobuploader == 1.2.4 16:50:22 INFO - docopt == 0.6.1 16:50:22 INFO - manifestparser == 1.1 16:50:22 INFO - mozInstall == 1.12 16:50:22 INFO - mozcrash == 0.16 16:50:22 INFO - mozdebug == 0.1 16:50:22 INFO - mozdevice == 0.47 16:50:22 INFO - mozfile == 1.2 16:50:22 INFO - mozhttpd == 0.7 16:50:22 INFO - mozinfo == 0.9 16:50:22 INFO - mozleak == 0.1 16:50:22 INFO - mozlog == 3.1 16:50:22 INFO - moznetwork == 0.27 16:50:22 INFO - mozprocess == 0.22 16:50:22 INFO - mozprofile == 0.27 16:50:22 INFO - mozrunner == 6.11 16:50:22 INFO - mozscreenshot == 0.1 16:50:22 INFO - mozsystemmonitor == 0.0 16:50:22 INFO - moztest == 0.7 16:50:22 INFO - mozversion == 1.4 16:50:22 INFO - psutil == 3.1.1 16:50:22 INFO - requests == 1.2.3 16:50:22 INFO - wsgiref == 0.1.2 16:50:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:50:22 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')]} 16:50:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:22 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')]} 16:50:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:22 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 0x7f93b69e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba9350>, '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 0x1baa250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baa6e0>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1450313244.823337-530355925', '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 16:50:22 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 16:50:22 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 16:50:22 INFO - Using env: {'DISPLAY': ':0', 16:50:22 INFO - 'HOME': '/home/cltbld', 16:50:22 INFO - 'LANG': 'en_US.UTF-8', 16:50:22 INFO - 'LANGUAGE': 'en_US:en', 16:50:22 INFO - 'LOGNAME': 'cltbld', 16:50:22 INFO - 'MAIL': '/var/mail/cltbld', 16:50:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:22 INFO - 'MOZ_NO_REMOTE': '1', 16:50:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:22 INFO - 'NO_EM_RESTART': '1', 16:50:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:22 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:22 INFO - 'SHELL': '/bin/bash', 16:50:22 INFO - 'SHLVL': '1', 16:50:22 INFO - 'TERM': 'linux', 16:50:22 INFO - 'TMOUT': '86400', 16:50:22 INFO - 'USER': 'cltbld', 16:50:22 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450313244.823337-530355925', 16:50:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:22 INFO - '_': '/tools/buildbot/bin/python'} 16:50:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:22 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 1)) 16:50:22 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 2)) 16:50:22 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 3)) 16:50:22 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 4)) 16:50:22 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 5)) 16:50:22 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 6)) 16:50:22 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 7)) 16:50:22 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 8)) 16:50:22 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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:50:22 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 3)) 16:50:22 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.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:50:22 INFO - Cleaning up... 16:50:22 INFO - Return code: 0 16:50:22 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:50:22 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')]} 16:50:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:22 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')]} 16:50:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:22 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 0x7f93b69e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba9350>, '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 0x1baa250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baa6e0>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1450313244.823337-530355925', '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 16:50:22 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 16:50:22 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 16:50:22 INFO - Using env: {'DISPLAY': ':0', 16:50:22 INFO - 'HOME': '/home/cltbld', 16:50:22 INFO - 'LANG': 'en_US.UTF-8', 16:50:22 INFO - 'LANGUAGE': 'en_US:en', 16:50:22 INFO - 'LOGNAME': 'cltbld', 16:50:22 INFO - 'MAIL': '/var/mail/cltbld', 16:50:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:22 INFO - 'MOZ_NO_REMOTE': '1', 16:50:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:22 INFO - 'NO_EM_RESTART': '1', 16:50:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:22 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:22 INFO - 'SHELL': '/bin/bash', 16:50:22 INFO - 'SHLVL': '1', 16:50:22 INFO - 'TERM': 'linux', 16:50:22 INFO - 'TMOUT': '86400', 16:50:22 INFO - 'USER': 'cltbld', 16:50:22 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450313244.823337-530355925', 16:50:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:22 INFO - '_': '/tools/buildbot/bin/python'} 16:50:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:22 INFO - Downloading/unpacking jsonschema 16:50:22 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 16:50:22 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 16:50:22 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 16:50:22 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 16:50:22 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 16:50:22 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 16:50:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:50:24 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 16:50:24 INFO - Downloading/unpacking functools32 (from jsonschema) 16:50:24 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 16:50:24 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 16:50:24 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 16:50:24 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 16:50:24 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 16:50:24 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 16:50:24 INFO - Downloading functools32-3.2.3-2.tar.gz 16:50:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 16:50:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:50:24 INFO - warning: no files found matching '*.txt' 16:50:24 INFO - no previously-included directories found matching 'build' 16:50:24 INFO - no previously-included directories found matching 'dist' 16:50:24 INFO - no previously-included directories found matching '.git*' 16:50:24 INFO - Installing collected packages: jsonschema, functools32 16:50:24 INFO - Running setup.py install for functools32 16:50:24 INFO - warning: no files found matching '*.txt' 16:50:24 INFO - no previously-included directories found matching 'build' 16:50:24 INFO - no previously-included directories found matching 'dist' 16:50:24 INFO - no previously-included directories found matching '.git*' 16:50:24 INFO - Successfully installed jsonschema functools32 16:50:24 INFO - Cleaning up... 16:50:24 INFO - Return code: 0 16:50:24 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:50:24 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')]} 16:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:24 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')]} 16:50:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:24 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 0x7f93b69e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba9350>, '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 0x1baa250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baa6e0>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1450313244.823337-530355925', '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 16:50:24 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 16:50:24 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 16:50:24 INFO - Using env: {'DISPLAY': ':0', 16:50:24 INFO - 'HOME': '/home/cltbld', 16:50:24 INFO - 'LANG': 'en_US.UTF-8', 16:50:24 INFO - 'LANGUAGE': 'en_US:en', 16:50:24 INFO - 'LOGNAME': 'cltbld', 16:50:24 INFO - 'MAIL': '/var/mail/cltbld', 16:50:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:24 INFO - 'MOZ_NO_REMOTE': '1', 16:50:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:24 INFO - 'NO_EM_RESTART': '1', 16:50:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:24 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:24 INFO - 'SHELL': '/bin/bash', 16:50:24 INFO - 'SHLVL': '1', 16:50:24 INFO - 'TERM': 'linux', 16:50:24 INFO - 'TMOUT': '86400', 16:50:24 INFO - 'USER': 'cltbld', 16:50:24 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450313244.823337-530355925', 16:50:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:24 INFO - '_': '/tools/buildbot/bin/python'} 16:50:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:25 INFO - Downloading/unpacking flake8 16:50:25 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 16:50:25 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 16:50:25 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 16:50:25 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 16:50:25 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 16:50:25 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 16:50:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:50:26 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 16:50:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:50:26 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 16:50:26 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 16:50:26 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 16:50:26 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 16:50:26 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 16:50:26 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 16:50:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:50:27 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 16:50:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:50:27 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 16:50:27 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 16:50:27 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 16:50:27 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 16:50:27 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 16:50:27 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 16:50:27 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 16:50:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:50:27 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 16:50:27 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 16:50:27 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 16:50:27 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 16:50:27 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 16:50:27 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 16:50:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 16:50:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:50:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:50:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:50:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:50:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:50:27 INFO - no previously-included directories found matching 'docs/_build' 16:50:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:50:27 INFO - Running setup.py install for pep8 16:50:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:50:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:50:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:50:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:50:27 INFO - no previously-included directories found matching 'docs/_build' 16:50:27 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:50:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:50:27 INFO - Cleaning up... 16:50:27 INFO - Return code: 0 16:50:27 INFO - Running post-action listener: _resource_record_post_action 16:50:27 INFO - Running post-action listener: _start_resource_monitoring 16:50:27 INFO - Starting resource monitoring. 16:50:27 INFO - ##### 16:50:27 INFO - ##### Running install step. 16:50:27 INFO - ##### 16:50:27 INFO - Running pre-action listener: _resource_record_pre_action 16:50:27 INFO - Running main action method: install 16:50:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:50:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:50:27 INFO - Reading from file tmpfile_stdout 16:50:27 INFO - Detecting whether we're running mozinstall >=1.0... 16:50:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:50:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:50:28 INFO - Reading from file tmpfile_stdout 16:50:28 INFO - Output received: 16:50:28 INFO - Usage: mozinstall [options] installer 16:50:28 INFO - Options: 16:50:28 INFO - -h, --help show this help message and exit 16:50:28 INFO - -d DEST, --destination=DEST 16:50:28 INFO - Directory to install application into. [default: 16:50:28 INFO - "/builds/slave/test-pgo"] 16:50:28 INFO - --app=APP Application being installed. [default: firefox] 16:50:28 INFO - mkdir: /builds/slave/test-pgo/build/application 16:50:28 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'] 16:50:28 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 16:50:42 INFO - Reading from file tmpfile_stdout 16:50:42 INFO - Output received: 16:50:42 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:50:42 INFO - Running post-action listener: _resource_record_post_action 16:50:42 INFO - ##### 16:50:42 INFO - ##### Running run-tests step. 16:50:42 INFO - ##### 16:50:42 INFO - Running pre-action listener: _resource_record_pre_action 16:50:42 INFO - Running main action method: run_tests 16:50:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:50:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:50:42 INFO - Python 2.7.3 16:50:42 INFO - Return code: 0 16:50:42 INFO - grabbing minidump binary from tooltool 16:50: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')]} 16:50:42 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 0x1ba9350>, '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 0x1baa250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1baa6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:50:42 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 16:50:42 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 16:50:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:50:43 INFO - Return code: 0 16:50:43 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:50:43 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:50:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:50:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:50:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:50:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:50:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:50:44 INFO - Return code: 0 16:50:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 16:50:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost 16:50:44 INFO - Using env: {'DISPLAY': ':0', 16:50:44 INFO - 'HOME': '/home/cltbld', 16:50:44 INFO - 'LANG': 'en_US.UTF-8', 16:50:44 INFO - 'LANGUAGE': 'en_US:en', 16:50:44 INFO - 'LOGNAME': 'cltbld', 16:50:44 INFO - 'MAIL': '/var/mail/cltbld', 16:50:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:50:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:50:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:44 INFO - 'MOZ_NO_REMOTE': '1', 16:50:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:50:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:44 INFO - 'NO_EM_RESTART': '1', 16:50:44 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:50:44 INFO - 'PWD': '/builds/slave/test-pgo', 16:50:44 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:50:44 INFO - 'SHELL': '/bin/bash', 16:50:44 INFO - 'SHLVL': '1', 16:50:44 INFO - 'TERM': 'linux', 16:50:44 INFO - 'TMOUT': '86400', 16:50:44 INFO - 'USER': 'cltbld', 16:50:44 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450313244.823337-530355925', 16:50:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:44 INFO - '_': '/tools/buildbot/bin/python'} 16:50:44 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost'] with output_timeout 3600 16:50:44 INFO - mozversion INFO | application_buildid: 20151216143013 16:50:44 INFO - mozversion INFO | application_changeset: 1cf6f364d319a2932f1fc9fac255d9d24b495075 16:50:44 INFO - mozversion INFO | application_display_name: Nightly 16:50:44 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:50:44 INFO - mozversion INFO | application_name: Firefox 16:50:44 INFO - mozversion INFO | application_remotingname: firefox 16:50:44 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 16:50:44 INFO - mozversion INFO | application_vendor: Mozilla 16:50:44 INFO - mozversion INFO | application_version: 46.0a1 16:50:44 INFO - mozversion INFO | platform_buildid: 20151216143013 16:50:44 INFO - mozversion INFO | platform_changeset: 1cf6f364d319a2932f1fc9fac255d9d24b495075 16:50:44 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 16:50:44 INFO - mozversion INFO | platform_version: 46.0a1 16:50:44 INFO - 2015-12-16 16:50:44,493 DEBUG : using testdate: 1450313444 16:50:44 INFO - 2015-12-16 16:50:44,493 DEBUG : actual date: 1450313444 16:50:44 INFO - 2015-12-16 16:50:44,501 INFO : starting webserver on 'localhost:59519' 16:50:44 INFO - 2015-12-16 16:50:44,502 INFO : Starting test suite talos-linux64-ix-054.e 16:50:44 INFO - 2015-12-16 16:50:44,502 INFO : Starting test dromaeo_css 16:50:44 INFO - 2015-12-16 16:50:44,502 DEBUG : operating with platform_type : linux_ 16:50:44 INFO - 2015-12-16 16:50:44,502 INFO : Initialising browser for dromaeo_css test... 16:50:44 INFO - 2015-12-16 16:50:44,530 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGqWAQc/profile http://localhost:59519/getInfo.html 16:50:50 INFO - 2015-12-16 16:50:50,200 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:50:50 INFO - 2015-12-16 16:50:50,200 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:50:50 INFO - 2015-12-16 16:50:50,200 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:50:50 INFO - 2015-12-16 16:50:50,201 DEBUG : BROWSER_OUTPUT: __metrics 16:50:50 INFO - 2015-12-16 16:50:50,289 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:50:51 INFO - 2015-12-16 16:50:51,157 INFO : Browser initialized. 16:50:51 INFO - 2015-12-16 16:50:51,157 INFO : Running cycle 1/1 for dromaeo_css test... 16:50:51 INFO - 2015-12-16 16:50:51,158 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGqWAQc/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:51:03 INFO - 2015-12-16 16:51:03,045 DEBUG : BROWSER_OUTPUT: RSS: Main: 143523840 16:51:03 INFO - 2015-12-16 16:51:03,045 DEBUG : BROWSER_OUTPUT: 16:51:52 INFO - 2015-12-16 16:51:52,647 DEBUG : BROWSER_OUTPUT: 1450313512645 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] 16:54:01 INFO - 2015-12-16 16:54:01,663 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59519/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59519/tests/dromaeo/cssquery-ext.html) 16:54:02 INFO - 2015-12-16 16:54:02,988 DEBUG : BROWSER_OUTPUT: RSS: Main: 150183936 16:54:02 INFO - 2015-12-16 16:54:02,988 DEBUG : BROWSER_OUTPUT: 16:57:05 INFO - 2015-12-16 16:57:05,030 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59519/tests/dromaeo/cssquery-ext.html (next: http://localhost:59519/tests/dromaeo/cssquery-jquery.html) 16:57:05 INFO - 2015-12-16 16:57:05,615 DEBUG : BROWSER_OUTPUT: RSS: Main: 146776064 16:57:05 INFO - 2015-12-16 16:57:05,616 DEBUG : BROWSER_OUTPUT: 17:00:07 INFO - 2015-12-16 17:00:07,316 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59519/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59519/tests/dromaeo/cssquery-mootools.html) 17:00:07 INFO - 2015-12-16 17:00:07,897 DEBUG : BROWSER_OUTPUT: RSS: Main: 145215488 17:00:07 INFO - 2015-12-16 17:00:07,897 DEBUG : BROWSER_OUTPUT: 17:03:09 INFO - 2015-12-16 17:03:09,493 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59519/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59519/tests/dromaeo/cssquery-prototype.html) 17:03:10 INFO - 2015-12-16 17:03:10,079 DEBUG : BROWSER_OUTPUT: RSS: Main: 144510976 17:03:10 INFO - 2015-12-16 17:03:10,079 DEBUG : BROWSER_OUTPUT: 17:06:12 INFO - 2015-12-16 17:06:12,335 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59519/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59519/tests/dromaeo/cssquery-yui.html) 17:06:12 INFO - 2015-12-16 17:06:12,920 DEBUG : BROWSER_OUTPUT: RSS: Main: 145272832 17:06:12 INFO - 2015-12-16 17:06:12,921 DEBUG : BROWSER_OUTPUT: 17:09:15 INFO - 2015-12-16 17:09:15,173 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59519/tests/dromaeo/cssquery-yui.html (next: http://localhost:59519/tests/dromaeo/cssquery-dojo.html) 17:09:15 INFO - 2015-12-16 17:09:15,431 DEBUG : BROWSER_OUTPUT: RSS: Main: 148017152 17:09:15 INFO - 2015-12-16 17:09:15,431 DEBUG : BROWSER_OUTPUT: 17:09:15 INFO - 2015-12-16 17:09:15,431 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:09:15 INFO - 2015-12-16 17:09:15,431 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:09:15 INFO - 2015-12-16 17:09:15,431 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:09:15 INFO - 2015-12-16 17:09:15,431 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:09:15 INFO - 2015-12-16 17:09:15,431 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3202.855871485783;3206.6793320667934;3245.6267529234146;3271.280318329968;3275.033865009822;5285.392179899312;5433.510984011438;5448.182772584114;5448.700321482317;5461.044317244487;5403.486668766461;5451.318585176853;5489.094299440588;5617.634853734515;5634.32388113427;4965.726885021322;4985.825496107637;5077.136886729247;5085.974570127144;5094.955534115516;4884.169691152495;4936.136176169174;5009.874753131165;5052;5068.873278168038;4780.617550595944;4838.250071238964;4907.4356449008465;4988.3764529434;5067.1385864402955;5008.69947803133;5009.123403404426;5019.874503137451;5029.396472423333;5034.773435195425;5022.974885125551;5026.4973502649445;5029.647924645276;5030.547250747413;5037.899242015139;5069.340985671876;5147.202183661539;5238.633295669305;5243.895122097537;5378.0857254266475;5875.941240587582;5909.2022576951995;5919.644821310735;5919.881602367972;5923.5853490255695;5919.319278283009;5921.230240068763;5929.229200203989;5945.435183657545;5956.7319470623925;5205.973970130163;5280.128778751501;5424.810131645373;5474.233607294982;5496.725163741877;6009.038553831366;6012.789552365646;6030.909536356959;6036.9698151508965;6045.486133678686;5794.768209271666;5800.622959507618;5801.7099145042575;5826.592138550261;5843.328017277982;5576.637518561281;5672.4894759471845;5687.118496633028;5789.363170051291;5823.5341172706085;5793.102069179284;5817.563682723728;5822.7088645567555;5827.24245848037;5835.35811060783;5678.4605462480995;5811.302643682785;5812.564057695689;5847.94152058474;5852.707364631751;4422.115576884636;4450.109978004347;4471.418715566955;4499.460064792246;4518.322251662277;3999.4000899864673;4003.7197396181987;4005.178938317638;4025.6376926076796;4057.472528571267;5300.31095957523;5433.945660543423;5539.5014448699;5554.389017208104;5557.944420555824;5829.183914252008;5894.263217097863;5908.20239267702;5916.9941110011405;5952;5660.745266463019;5688.715564221772;5691.715414229272;5694.686792226385;5694.772209111589;4924.901501970012;5024.799008039638;5034.219695947134;5202.531772140525;5223.268742376071;5882.676452795137;5927.347991720907;5985.042393217064;6001.219841420588;6025.487833534111;5878.059510478303;5882;5887.587868849139;5895.174675545512;5903.173555702291;5692.857678558069;5742.224799651994;5780.364159942487;5993.31076926159;6004.249468816398;5856.150858125633;5869.325027621878;5883.499902508334;5895.9115613266695;5901.970490147522;5893.233879595625;5940.762369505344;5957.821265362046;5964.015937370459;5967.1944287522365;5592.664440133605;5689.601727879009;5689.743961521659;5709.51469125129;5841.211436456024;5625;5670.5180059695385;5774.855628609318;5814.534837212928;5863.325717542367;5465.863353416196;5568.526675232651;5570.805021824217;5572.164175373564;5578.330600327987;5679.6024278301775;5714.342850572071;5752.28096487939;5760.251167348218;5793.536517078708;5618.69097199658;5649.802256920988;5655;5657.688827114548;5683.687397193194 17:09:15 INFO - 2015-12-16 17:09:15,431 DEBUG : BROWSER_OUTPUT: |1;ext.html;549.4478049560191;602.8372339468341;606.172574435895;608.8477880529867;611.8072807065776;36800;37061.44407833885;37274.068148296305;37426.43860342097;37428.06429839252;40524.39213411801;41150.7942460288;41191.58808411923;41356.793216033955;41394.58605413945;8718.520481373522;8811.030786613468;8886.777830554256;8889.555522223895;8911.509866957314;8662.783430414227;8707.95646021769;8708.869366959501;8714.085021072791;8714.346424018224;8634;8830.20528152466;8842.071582483812;8842.823143537125;8855.291576673852;8732.912670873306;8767.56162191891;8774.210321071134;8775.473471591726;8819.911800882006;8598.140185981414;8711.303095752324;8728.214460698568;8732.43239189457;8776.078511756237;38139.42790858139;38544.42183367252;38583.22833543314;38746.61253387486;38965.80517097425;3062.770292228092;3084.9511166203597;3118.3451475190236;3125.9531107033413;3413.5391722117442;29268.41463170725;29478.11565653034;30064.54903176454;30095.398092038256;30464.390712185632;3564.846323131253;3609.9458508122398;3637.290728307981;3691.8154092295545;3811.428285757131;260259;261810;262750;262820;264453;39563;40034;53677.1948420774;53850;53950.73024634852;37833.243335133695;37998.810005949796;37999.24001520009;38002.42996355057;38024.23951520954;12329.198602090835;12408.255504669749;12427.565035223724;12455.314957677234;12500.937495312648;9723.270754693427;9813.116819486138;9826.754331141636;9833.606655733834;9834.213262938947;13377.862881655168;13820.96342774296;13826.101303415246;13878.514252001132;13883.305834708224;5665.575081868877;5730.598858079894;5742.196092547047;5756.280464941882;5790.10253410722;1009.7122320138725;1014.7818219082933;1044.6709286574705;1099.6920862158609;1126.1778901402022;27783.16650500448;27978.30241877166;28268.151955441368;28296.71703282982;28560.858305586367;982.9886425631163;1025.9025392587691;1064.499685147979;1111.6053800900563;1121.8429419881222;14750;14794.067222200209;14871.853354025967;14880.627984300263;14945.40218391274;308332;311002;312316;314895;315755;48865.26702099471;48923;49180;49310.506894931306;49342.75328623334;1281.6155153453926;1323.6823162441137;1327.81824176483;1328.2495390104752;1329.734053189366;27013.86493067522;27994.86002569974;28255.71744282613;31835.681643184198;32228;46541.53458465372;47420.814479638284;47749.522504775894;48056.759716201195;48169.759151204016;284168;288182;289095;289824;290098;40404.1919161621;43225;43437.782811085744;44126;44290.778546108355;40482.39276410797;41316;47284.52715472801;47960;49002;34445;35231;35565;35750.106247344025;40241.79879100703;30619;31047;31266.687333126378;31402.685973139975;31691.366172676877;38910.61089389183;39169.41245881257;39739.60260397359;39748.40377394284;40168.19663606653;29536.852315739143;30256.84871575628;32047;32155.35689286248;32321.838390807894;24469.143579974614;24733.87633061823;24775.380615484035;24783;25072.874635626704 17:09:15 INFO - 2015-12-16 17:09:15,432 DEBUG : BROWSER_OUTPUT: |2;jquery.html;351.9085037890148;354.7658545360063;355.98011696489533;364.3678218291264;365.10549154571305;16114.194290285483;16688.749668754965;17264;17581.648367032652;17841.64316713668;14824.184669843155;14998.925005374958;15736.685266294668;16462.341506339733;16500.504984850475;4903.239997800347;5013.495951214639;5048.57087147591;5054.140796064659;5055.9241611375855;4957.818955493424;4985.127602669519;5027.723475208862;5032.11937910866;5034.169362055275;3641.362761516737;3739.6447337503027;5355.384130824966;5381.81163659272;5490.450954904518;5487.945120548783;5493.285872836545;5496.148097044925;5514.558835293167;5520.309961254843;5227.869303267449;5251.396089449724;5261.815836445744;5407.5133238008375;5426.240326354314;12770.297633630147;12804.80792788109;13328.067035307435;19972.80027199724;20266.594668106554;1976.575036367188;1990.532224927141;2205.3604454708116;2249.4151520604596;2313.5141620259596;9120.680776172801;9315.813683726356;9473.242140628734;10982.505787239594;12892.097553171188;1571.1201727032899;1617.6441182939734;1629.3482606957193;1633.0446688687132;1646.7484711619136;61917.38082619161;65543.3445665542;66742.3325766741;69727;69739.65130174368;15720;16114.274857631435;16291.266892989845;16357.263923123488;16361.34554617802;23191.652125218134;23346.64980025267;23382.7661723384;23581.646275305884;23765.287041388787;8553.358498112666;8565;8565.48607083577;8605.268552173135;8615.181557752003;7180.8922866157045;7193.676284567103;7229.783106506813;7265;7275.236100209402;7877.369810415153;7926.445148839641;7934.166912474223;7973.122956474783;7986.960065199637;3054.9083527494213;3065.4941934580543;3111.144435280271;3172.5558421820965;3204.8557814898386;424.4227850123829;428.45586105645657;461.61916418954496;807.5881300536769;964.1467301438138;9958.601655933682;10208.43853588045;10276.280660353703;10370.896291037145;10631.043206111488;434.2574198121248;439.13928699748215;443.61848810023355;459.07496394764576;470.84697473320625;5471.534919531805;5631.380548139701;5738.655680659173;9743.171830394354;9987.101160895554;535663;539924;541396;548419;548701;83471.58264208761;86078.56960715282;86256.56871715601;86935.56532217299;86983.56508217545;1128.1595211567435;1145.0553293532869;1146.3236690352733;1146.5757669662278;1151.1308961734005;15926.681466370375;15978.840211597735;16030.438934637232;16120.67758644844;16331.101789401697;36262.63737362698;36623.63376366202;37443;37494.625053749114;37602.81198594099;45988;46283.53716462792;47885.76057119692;48221;48870.26694599655;9075.183233508751;9080.273578113867;9625.71122866315;9719.85420218683;9843.60625574969;10774.461276935965;10787.514561844579;10861.782764344827;10925.289856159325;10950.06924411434;12973.935130324287;14250.572482825532;14513.346899389342;14784.186869721838;14919.030263032868;14124.929375353058;14348.282585870873;14527.418903243752;14635.34140963638;15387.38450461969;13672.384742686405;13942.721145577234;14624.926875365554;14662.926685366505;14850.331735071732;9217.76955576116;9327.113924177193;9515.191208747334;9548.809023819345;9604.75988100303;9747.658831940847;9811.754706132404;11087.611933582286;13876.171789840662;13994.230317332644 17:09:15 INFO - 2015-12-16 17:09:15,432 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1484.9925750371247;1537.3773621683215;1602.0547876752714;1677.1446562253254;1791.2566284991728;6897.965510172442;6960.373566379025;7371.631418429077;7784.9221507784905;7790.6104694765245;7379.1513975892785;7628.580428076453;7634.236576342363;7710.306072453492;7739.458237923348;2218.4897473581045;2223.9555208895813;2248.3592176229777;2250.2124256510174;2251.6397376419777;2258.7063681721434;2271.284545368212;2287.9771202288016;2296.322584837477;2339.2748248043076;2195.9890200548975;2196.901139448729;2229.308914236592;2230.721159855018;2231.230225572175;2201.7908298711595;2240.0591751464426;2260.6495993121093;2261.683364328995;2262.9207977720785;2243.102758896438;2281.2927992322434;2284.1548627007946;2286.0284379138966;2289.39331077263;7651.655675494616;7736.7292144774665;7788.883166752503;7789.415793815429;7816.179301173352;4609.608183304423;4639.768011599406;4665.09030739006;4667.953320466786;4668.6731928765;2924.6782853886057;2982.3587928595457;2991.895283665083;2996.745276651487;3001.189678786737;910.4673765846921;924.5931790012373;927.5918595817886;983.5426526665135;983.5623147699276;10634.521446534847;10638.308509946906;10642.308249963728;10757.892421075767;10812.891871081267;4135.731177473454;4145.3781932709735;4164;4181.289180839264;4209.052963083282;9094.545272736337;9120.954395227982;9160.496172710566;9161.49611771359;9162.22121119699;4617.007343421181;4652.999605084923;4674.135284972291;4678.719276843401;4682;4142.212979533939;4144.109016561393;4264.850730224427;4283.22901877665;4290.785460726951;3441.6214216436174;3452.2405070884365;3473.5484387029524;3496.3531746626445;3499.7900125992523;1049.732318258839;1057.9206559507913;1063.5320458998017;1066.173715370594;1074.425182527344;1048.2138396202847;1054.7152268887357;1058.5818601652459;1217.7077501399776;1339.8660133986718;7034.050403195605;7082.681279342442;7092.255313192144;7138.072050633385;7383.15093764224;1051.6003918510917;1056.7569459024467;1068.513826209073;1068.8682161267407;1158.4902642837126;5621.7751289948765;5781.508571771446;5856.385079566669;5868.735906884115;5870.618409803349;9243.39917905334;9285.210757085588;9364.859527107099;9384.624615015324;9394.154526092685;9071.909280907239;9225.72322830316;9236.261099112055;9337.112974267433;9340.159385655325;7250.274972502813;7277.19950805411;7287.234840341794;7294.343509084208;7337.339639432476;7057.153141623038;7098.858022839618;7130.037444944866;7130.18002929649;7178.3898368637165;8186.918130818615;8285.4200205985;8401.95799021001;8468.872966905377;8537.487750734976;8362.958185209034;8410.158984101541;8428.704995325133;8440.577971101298;8567.443116197428;6474.870502590016;6492.285848556749;6562.737490500326;6795.864082718417;6845.657717114224;7416.443766717625;7438.665260063419;7519.849603008019;7521.699132034876;7561.621918903923;6773.356531129535;7009.088818453569;7061.435085193275;7092.326229008236;7120.6795694194925;6684.598924064571;6746.898796518154;6757.695903684445;6775.390214880487;6943.652817359213;7008.684609192496;7026.402755765817;7100.751473698602;7104.076470058859;7132.393746531603;6455.225372955088;6457.644829534421;6458.806235812933;6475.935240647534;6507.316731743288;6473.967630161819;6506.902396464152;6520;6529.67351632426;6534.869302613826 17:09:15 INFO - 2015-12-16 17:09:15,432 DEBUG : BROWSER_OUTPUT: |4;prototype.html;316.4793914011451;323.32586557028594;325.1594627886913;328.3498672628196;328.7945034353529;6327.209098862642;6345.58753681011;6367.458766004896;6377.107204991305;6517.706703198355;6276.278228003781;6292.213473315824;6303.936960630393;6320.115183874262;6320.968395158029;4761.214399624067;4769.403824521934;4770.093682200388;4770.165221086313;4774.355462012636;4783.593394561466;4786.329913812069;4789.880252993686;4791.616670666356;4793.7363445010515;4643.674942754009;4720.929186062212;4730.195866702668;4733.171694953387;4737.668363214576;4711.599514041293;4714.104320179189;4722.598579120779;4722.787474563635;4725.40932383452;4067.9796601016806;4068.7355321903983;4068.8575899843363;4074.30736774749;4074.796260186979;6043.244594425697;6044.637321760709;6051.939480605181;6068.544859135538;6090.878182436327;5348.384935732402;5485.533729632986;5488.368837583689;5499.230107784913;5517.917231241535;6645.76739814109;6699.665016749143;6705.362990515893;6710.83222919426;6729.192496900354;4490.57339552742;4491.752953587551;4494.9325760113625;4495.43807024122;4497.168023915586;6634.730179979921;6715.496337774637;6768.593884366954;6786.76246331376;6801;4502.122086193161;4502.347159661831;4502.662300327489;4510.932336014962;4515.458145022619;4560.065186636732;4570.520095390003;4571.679982401267;4571.839985600488;4586.197415452282;5299.072662284085;5358.46415358461;5359.544438722674;5366.141417373279;5367.409584945653;6426.550141490145;6543.1166792483355;6566.8358291043105;6571.0471981562405;6596.670166491656;1593.5219434169703;1624;1634.6730653869274;1636.4845073801714;1637.7297745872036;1054.7257712994524;1065.2756125834353;1070.1118072000222;1071.4803320389606;1080.8378743188584;6337.176167098248;6345.111684364193;6388.936110638927;6405.19935008124;6407.167068281186;6837.179538455417;6856.828579285558;6877.071595334666;6895.793126206222;6903.896441553381;6362.141110949962;6393.808185754435;6395.488360931115;6396;6410.038494225903;3800.220954704279;3829.8468061277795;3835.8082095895093;3837.5586807516934;3850.537935447764;7195.856082878313;7257.237990010973;7258.383037441877;7264.200937896827;7264.382527485223;6914.101166848278;7115.466340024519;7222.674979625929;7227;7251.3836323912;7201.567905925661;7226.349628533352;7233.095863017123;7250.492465527363;7254.056972593635;6973.79078627642;6979.267176946348;6987.580745155307;7009.614471203929;7035.718571257297;6765.526413151032;6915.204751453647;6930.099087118642;6930.549514281555;6932.6533673315125;7124.430045596237;7187.676554554953;7212.963935180291;7216.89174662391;7233.927660723325;4607.861764147081;4622.907541849077;4644.790984405642;4647.651426142985;4649.86050418488;6862.9313706862295;6931.306869313028;6952.478564107813;6996.265392133956;7046.682899269443;6710.66446677674;6746.021826835179;6763.830904227237;6766.4248538874745;6812.557183783237;6731.798046058626;6759.087523184307;6765.695543700447;6776.830579235559;6807.285235050248;6482.124913136666;6605.801825945229;6618.172728408949;6629.502787290876;6635.2037755469655;6823.93176068233;6824.692888820115;6835.043093966948;6860.382565569123;6867;6571.737130514726;6578.506612004023;6652.900206497004;6663.666816659051;6668.866622667617 17:09:15 INFO - 2015-12-16 17:09:15,432 DEBUG : BROWSER_OUTPUT: |5;yui.html;819.9016118065833;827.1810907201871;829.8132920092976;842.49029337251;854.987175192372;13086.083974121804;13188.604341869735;13199;13361;13543.932280338597;11068.225224234307;11553.711157221052;12467.750644987094;12590.433430495626;12594.559190428337;819.1644522586957;828.2587084559316;828.7928017995501;829.4401279136589;830.3896635972555;812.5490352854164;817.8037271054964;821.8233079887823;822.1901427094307;823.7899335669396;853.2065179383171;862.1766213266316;865.3293697384546;865.5931712095305;868.4615538366222;853.4751128056232;855.1320409784074;855.7304449098546;855.9743207703779;856.2764464027887;632.3644737039292;634.2642534659818;637.4613451633362;638.7700427846019;639.3702203329716;12449.564265250763;12483.251004939733;12565.308908010056;12599.496020159182;12619.495220191182;9936.950315248378;10042.297039207258;10497.462533890777;10665.9466702666;11183.32900026001;8864.290856731446;8874.112588741138;8881.333899957464;8930.285577153812;9018.729438116867;3326.617438994522;3329.1344250495044;3337.7997320160866;3400.846961886721;3414.3000684859544;44031.779841100586;44358.33462498065;45259.32111018337;45809.56428267893;47167.764161179315;8539.74380768578;9421.24630029596;9452.054794520493;9573.521323933775;9771.804563908825;16054.67890642204;17910.820891790914;17938;17943.192556334998;17950.371736989404;6868.210155832044;7080.079589653312;7129.4652901031595;7205.603691796897;7344.339009489172;4154.522229943595;4180.581941805856;4183.226103170862;4201.264778663722;4223.13425747721;3046.8628911699025;3085.0898984799537;3101.286704058079;3103.007037747944;3108.036508682316;538.1577830694949;540.6161625246119;545.7980547197483;550.2708910693348;560.0115795620733;583.8394441528528;610.3225419784036;614.1928070097221;633.4520639646672;674.275154209227;7197.352238298578;7572.621368931532;7577.962110189524;7639.732609358646;7693.538387696756;559.6634052829421;579.0330148651761;603.5473394953784;629.5026928726346;664.9368310010541;3660.2679464107287;3738.0841693785196;3791.1280405506886;3834.309824231665;3844.942325865114;57190.7140464295;57214.71392643094;58106;58778;58895;52098.47901520936;52653.210201847;52980;54282;54410.45589544133;46824.531754682015;47742;48641.513584864406;50747;52852.73573632184;7806.4925779824125;7840.098388685375;7931.5637639930355;8108.310793582612;8140.906455546854;35337.64662353446;35934;35983;36588;36631.81684091563;42036.159276814906;42529;44723.55276447194;47135.528644713115;47291.763541182074;10522.31604945676;10644.946775266075;10658.73353166177;10681.51933162994;10719;10775.245732798629;10914.23600347968;10918.727031824268;10961.123110151328;11426.085913126764;10056.195504359488;10214.08073273409;10344.224183186441;10359;10400.635977740743;10352.792944141225;10545.314554554236;10587.894121058998;10741.010726133944;10841.349519028883;9723.222142228746;9785.510724463606;9791.657291994747;9793;9793.608255669693;9046.592903319499;9396.906030939877;9461;9478.620855165991;9527.952360238154;8467.872981905153;8506.659733610586;9072;9076.41003334781;9221.400608960395 17:09:15 INFO - 2015-12-16 17:09:15,432 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:09:15 INFO - 2015-12-16 17:09:15,432 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:09:15 INFO - 2015-12-16 17:09:15,432 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,305 17:09:15 INFO - 2015-12-16 17:09:15,432 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:09:15 INFO - 2015-12-16 17:09:15,432 DEBUG : BROWSER_OUTPUT: __startTimestamp1450314555424__endTimestamp 17:09:15 INFO - 2015-12-16 17:09:15,432 DEBUG : BROWSER_OUTPUT: 17:09:15 INFO - 2015-12-16 17:09:15,432 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:09:15 INFO - 2015-12-16 17:09:15,432 DEBUG : BROWSER_OUTPUT: Number of tests: 6 17:09:15 INFO - 2015-12-16 17:09:15,433 DEBUG : BROWSER_OUTPUT: 17:09:15 INFO - 2015-12-16 17:09:15,433 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5434.41 Median:5660.75 stddev:606.62 (10.7%) stddev-sans-first:582.67 17:09:15 INFO - 2015-12-16 17:09:15,433 DEBUG : BROWSER_OUTPUT: Values: 3202.9 3206.7 3245.6 3271.3 3275.0 5285.4 5433.5 5448.2 5448.7 5461.0 5403.5 5451.3 5489.1 5617.6 5634.3 4965.7 4985.8 5077.1 5086.0 5095.0 4884.2 4936.1 5009.9 5052.0 5068.9 4780.6 4838.3 4907.4 4988.4 5067.1 5008.7 5009.1 5019.9 5029.4 5034.8 5023.0 5026.5 5029.6 5030.5 5037.9 5069.3 5147.2 5238.6 5243.9 5378.1 5875.9 5909.2 5919.6 5919.9 5923.6 5919.3 5921.2 5929.2 5945.4 5956.7 5206.0 5280.1 5424.8 5474.2 5496.7 6009.0 6012.8 6030.9 6037.0 6045.5 5794.8 5800.6 5801.7 5826.6 5843.3 5576.6 5672.5 5687.1 5789.4 5823.5 5793.1 5817.6 5822.7 5827.2 5835.4 5678.5 5811.3 5812.6 5847.9 5852.7 4422.1 4450.1 4471.4 4499.5 4518.3 3999.4 4003.7 4005.2 4025.6 4057.5 5300.3 5433.9 5539.5 5554.4 5557.9 5829.2 5894.3 5908.2 5917.0 5952.0 5660.7 5688.7 5691.7 5694.7 5694.8 4924.9 5024.8 5034.2 5202.5 5223.3 5882.7 5927.3 5985.0 6001.2 6025.5 5878.1 5882.0 5887.6 5895.2 5903.2 5692.9 5742.2 5780.4 5993.3 6004.2 5856.2 5869.3 5883.5 5895.9 5902.0 5893.2 5940.8 5957.8 5964.0 5967.2 5592.7 5689.6 5689.7 5709.5 5841.2 5625.0 5670.5 5774.9 5814.5 5863.3 5465.9 5568.5 5570.8 5572.2 5578.3 5679.6 5714.3 5752.3 5760.3 5793.5 5618.7 5649.8 5655.0 5657.7 5683.7 17:09:15 INFO - 2015-12-16 17:09:15,433 DEBUG : BROWSER_OUTPUT: 17:09:15 INFO - 2015-12-16 17:09:15,433 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44807.82 Median:37427.25 stddev:75379.28 (201.4%) stddev-sans-first:75517.49 17:09:15 INFO - 2015-12-16 17:09:15,434 DEBUG : BROWSER_OUTPUT: Values: 549.4 602.8 606.2 608.8 611.8 36800.0 37061.4 37274.1 37426.4 37428.1 40524.4 41150.8 41191.6 41356.8 41394.6 8718.5 8811.0 8886.8 8889.6 8911.5 8662.8 8708.0 8708.9 8714.1 8714.3 8634.0 8830.2 8842.1 8842.8 8855.3 8732.9 8767.6 8774.2 8775.5 8819.9 8598.1 8711.3 8728.2 8732.4 8776.1 38139.4 38544.4 38583.2 38746.6 38965.8 3062.8 3085.0 3118.3 3126.0 3413.5 29268.4 29478.1 30064.5 30095.4 30464.4 3564.8 3609.9 3637.3 3691.8 3811.4 260259.0 261810.0 262750.0 262820.0 264453.0 39563.0 40034.0 53677.2 53850.0 53950.7 37833.2 37998.8 37999.2 38002.4 38024.2 12329.2 12408.3 12427.6 12455.3 12500.9 9723.3 9813.1 9826.8 9833.6 9834.2 13377.9 13821.0 13826.1 13878.5 13883.3 5665.6 5730.6 5742.2 5756.3 5790.1 1009.7 1014.8 1044.7 1099.7 1126.2 27783.2 27978.3 28268.2 28296.7 28560.9 983.0 1025.9 1064.5 1111.6 1121.8 14750.0 14794.1 14871.9 14880.6 14945.4 308332.0 311002.0 312316.0 314895.0 315755.0 48865.3 48923.0 49180.0 49310.5 49342.8 1281.6 1323.7 1327.8 1328.2 1329.7 27013.9 27994.9 28255.7 31835.7 32228.0 46541.5 47420.8 47749.5 48056.8 48169.8 284168.0 288182.0 289095.0 289824.0 290098.0 40404.2 43225.0 43437.8 44126.0 44290.8 40482.4 41316.0 47284.5 47960.0 49002.0 34445.0 35231.0 35565.0 35750.1 40241.8 30619.0 31047.0 31266.7 31402.7 31691.4 38910.6 39169.4 39739.6 39748.4 40168.2 29536.9 30256.8 32047.0 32155.4 32321.8 24469.1 24733.9 24775.4 24783.0 25072.9 17:09:15 INFO - 2015-12-16 17:09:15,434 DEBUG : BROWSER_OUTPUT: 17:09:15 INFO - 2015-12-16 17:09:15,434 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29328.13 Median:19013.62 stddev:88869.47 (467.4%) stddev-sans-first:89092.13 17:09:15 INFO - 2015-12-16 17:09:15,434 DEBUG : BROWSER_OUTPUT: Values: 351.9 354.8 356.0 364.4 365.1 16114.2 16688.7 17264.0 17581.6 17841.6 14824.2 14998.9 15736.7 16462.3 16500.5 4903.2 5013.5 5048.6 5054.1 5055.9 4957.8 4985.1 5027.7 5032.1 5034.2 3641.4 3739.6 5355.4 5381.8 5490.5 5487.9 5493.3 5496.1 5514.6 5520.3 5227.9 5251.4 5261.8 5407.5 5426.2 12770.3 12804.8 13328.1 19972.8 20266.6 1976.6 1990.5 2205.4 2249.4 2313.5 9120.7 9315.8 9473.2 10982.5 12892.1 1571.1 1617.6 1629.3 1633.0 1646.7 61917.4 65543.3 66742.3 69727.0 69739.7 15720.0 16114.3 16291.3 16357.3 16361.3 23191.7 23346.6 23382.8 23581.6 23765.3 8553.4 8565.0 8565.5 8605.3 8615.2 7180.9 7193.7 7229.8 7265.0 7275.2 7877.4 7926.4 7934.2 7973.1 7987.0 3054.9 3065.5 3111.1 3172.6 3204.9 424.4 428.5 461.6 807.6 964.1 9958.6 10208.4 10276.3 10370.9 10631.0 434.3 439.1 443.6 459.1 470.8 5471.5 5631.4 5738.7 9743.2 9987.1 535663.0 539924.0 541396.0 548419.0 548701.0 83471.6 86078.6 86256.6 86935.6 86983.6 1128.2 1145.1 1146.3 1146.6 1151.1 15926.7 15978.8 16030.4 16120.7 16331.1 36262.6 36623.6 37443.0 37494.6 37602.8 45988.0 46283.5 47885.8 48221.0 48870.3 9075.2 9080.3 9625.7 9719.9 9843.6 10774.5 10787.5 10861.8 10925.3 10950.1 12973.9 14250.6 14513.3 14784.2 14919.0 14124.9 14348.3 14527.4 14635.3 15387.4 13672.4 13942.7 14624.9 14662.9 14850.3 9217.8 9327.1 9515.2 9548.8 9604.8 9747.7 9811.8 11087.6 13876.2 13994.2 17:09:15 INFO - 2015-12-16 17:09:15,434 DEBUG : BROWSER_OUTPUT: 17:09:15 INFO - 2015-12-16 17:09:15,435 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5404.85 Median:6484.11 stddev:2812.48 (43.4%) stddev-sans-first:2804.93 17:09:15 INFO - 2015-12-16 17:09:15,435 DEBUG : BROWSER_OUTPUT: Values: 1485.0 1537.4 1602.1 1677.1 1791.3 6898.0 6960.4 7371.6 7784.9 7790.6 7379.2 7628.6 7634.2 7710.3 7739.5 2218.5 2224.0 2248.4 2250.2 2251.6 2258.7 2271.3 2288.0 2296.3 2339.3 2196.0 2196.9 2229.3 2230.7 2231.2 2201.8 2240.1 2260.6 2261.7 2262.9 2243.1 2281.3 2284.2 2286.0 2289.4 7651.7 7736.7 7788.9 7789.4 7816.2 4609.6 4639.8 4665.1 4668.0 4668.7 2924.7 2982.4 2991.9 2996.7 3001.2 910.5 924.6 927.6 983.5 983.6 10634.5 10638.3 10642.3 10757.9 10812.9 4135.7 4145.4 4164.0 4181.3 4209.1 9094.5 9121.0 9160.5 9161.5 9162.2 4617.0 4653.0 4674.1 4678.7 4682.0 4142.2 4144.1 4264.9 4283.2 4290.8 3441.6 3452.2 3473.5 3496.4 3499.8 1049.7 1057.9 1063.5 1066.2 1074.4 1048.2 1054.7 1058.6 1217.7 1339.9 7034.1 7082.7 7092.3 7138.1 7383.2 1051.6 1056.8 1068.5 1068.9 1158.5 5621.8 5781.5 5856.4 5868.7 5870.6 9243.4 9285.2 9364.9 9384.6 9394.2 9071.9 9225.7 9236.3 9337.1 9340.2 7250.3 7277.2 7287.2 7294.3 7337.3 7057.2 7098.9 7130.0 7130.2 7178.4 8186.9 8285.4 8402.0 8468.9 8537.5 8363.0 8410.2 8428.7 8440.6 8567.4 6474.9 6492.3 6562.7 6795.9 6845.7 7416.4 7438.7 7519.8 7521.7 7561.6 6773.4 7009.1 7061.4 7092.3 7120.7 6684.6 6746.9 6757.7 6775.4 6943.7 7008.7 7026.4 7100.8 7104.1 7132.4 6455.2 6457.6 6458.8 6475.9 6507.3 6474.0 6506.9 6520.0 6529.7 6534.9 17:09:15 INFO - 2015-12-16 17:09:15,435 DEBUG : BROWSER_OUTPUT: 17:09:15 INFO - 2015-12-16 17:09:15,436 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5571.44 Median:6372.28 stddev:1726.52 (27.1%) stddev-sans-first:1685.71 17:09:15 INFO - 2015-12-16 17:09:15,436 DEBUG : BROWSER_OUTPUT: Values: 316.5 323.3 325.2 328.3 328.8 6327.2 6345.6 6367.5 6377.1 6517.7 6276.3 6292.2 6303.9 6320.1 6321.0 4761.2 4769.4 4770.1 4770.2 4774.4 4783.6 4786.3 4789.9 4791.6 4793.7 4643.7 4720.9 4730.2 4733.2 4737.7 4711.6 4714.1 4722.6 4722.8 4725.4 4068.0 4068.7 4068.9 4074.3 4074.8 6043.2 6044.6 6051.9 6068.5 6090.9 5348.4 5485.5 5488.4 5499.2 5517.9 6645.8 6699.7 6705.4 6710.8 6729.2 4490.6 4491.8 4494.9 4495.4 4497.2 6634.7 6715.5 6768.6 6786.8 6801.0 4502.1 4502.3 4502.7 4510.9 4515.5 4560.1 4570.5 4571.7 4571.8 4586.2 5299.1 5358.5 5359.5 5366.1 5367.4 6426.6 6543.1 6566.8 6571.0 6596.7 1593.5 1624.0 1634.7 1636.5 1637.7 1054.7 1065.3 1070.1 1071.5 1080.8 6337.2 6345.1 6388.9 6405.2 6407.2 6837.2 6856.8 6877.1 6895.8 6903.9 6362.1 6393.8 6395.5 6396.0 6410.0 3800.2 3829.8 3835.8 3837.6 3850.5 7195.9 7257.2 7258.4 7264.2 7264.4 6914.1 7115.5 7222.7 7227.0 7251.4 7201.6 7226.3 7233.1 7250.5 7254.1 6973.8 6979.3 6987.6 7009.6 7035.7 6765.5 6915.2 6930.1 6930.5 6932.7 7124.4 7187.7 7213.0 7216.9 7233.9 4607.9 4622.9 4644.8 4647.7 4649.9 6862.9 6931.3 6952.5 6996.3 7046.7 6710.7 6746.0 6763.8 6766.4 6812.6 6731.8 6759.1 6765.7 6776.8 6807.3 6482.1 6605.8 6618.2 6629.5 6635.2 6823.9 6824.7 6835.0 6860.4 6867.0 6571.7 6578.5 6652.9 6663.7 6668.9 17:09:15 INFO - 2015-12-16 17:09:15,436 DEBUG : BROWSER_OUTPUT: 17:09:15 INFO - 2015-12-16 17:09:15,436 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13478.51 Median:27478.13 stddev:16276.62 (59.2%) stddev-sans-first:16294.53 17:09:15 INFO - 2015-12-16 17:09:15,437 DEBUG : BROWSER_OUTPUT: Values: 819.9 827.2 829.8 842.5 855.0 13086.1 13188.6 13199.0 13361.0 13543.9 11068.2 11553.7 12467.8 12590.4 12594.6 819.2 828.3 828.8 829.4 830.4 812.5 817.8 821.8 822.2 823.8 853.2 862.2 865.3 865.6 868.5 853.5 855.1 855.7 856.0 856.3 632.4 634.3 637.5 638.8 639.4 12449.6 12483.3 12565.3 12599.5 12619.5 9937.0 10042.3 10497.5 10665.9 11183.3 8864.3 8874.1 8881.3 8930.3 9018.7 3326.6 3329.1 3337.8 3400.8 3414.3 44031.8 44358.3 45259.3 45809.6 47167.8 8539.7 9421.2 9452.1 9573.5 9771.8 16054.7 17910.8 17938.0 17943.2 17950.4 6868.2 7080.1 7129.5 7205.6 7344.3 4154.5 4180.6 4183.2 4201.3 4223.1 3046.9 3085.1 3101.3 3103.0 3108.0 538.2 540.6 545.8 550.3 560.0 583.8 610.3 614.2 633.5 674.3 7197.4 7572.6 7578.0 7639.7 7693.5 559.7 579.0 603.5 629.5 664.9 3660.3 3738.1 3791.1 3834.3 3844.9 57190.7 57214.7 58106.0 58778.0 58895.0 52098.5 52653.2 52980.0 54282.0 54410.5 46824.5 47742.0 48641.5 50747.0 52852.7 7806.5 7840.1 7931.6 8108.3 8140.9 35337.6 35934.0 35983.0 36588.0 36631.8 42036.2 42529.0 44723.6 47135.5 47291.8 10522.3 10644.9 10658.7 10681.5 10719.0 10775.2 10914.2 10918.7 10961.1 11426.1 10056.2 10214.1 10344.2 10359.0 10400.6 10352.8 10545.3 10587.9 10741.0 10841.3 9723.2 9785.5 9791.7 9793.0 9793.6 9046.6 9396.9 9461.0 9478.6 9528.0 8467.9 8506.7 9072.0 9076.4 9221.4 17:09:15 INFO - 2015-12-16 17:09:15,437 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:09:15 INFO - 2015-12-16 17:09:15,437 DEBUG : BROWSER_OUTPUT: 17:09:16 INFO - 2015-12-16 17:09:16,109 INFO : Browser exited with error code: 0 17:09:16 INFO - 2015-12-16 17:09:16,130 INFO : Completed test dromaeo_css (00:18:31) 17:09:16 INFO - 2015-12-16 17:09:16,130 INFO : Starting test kraken 17:09:16 INFO - 2015-12-16 17:09:16,130 DEBUG : operating with platform_type : linux_ 17:09:16 INFO - 2015-12-16 17:09:16,130 INFO : Initialising browser for kraken test... 17:09:16 INFO - 2015-12-16 17:09:16,137 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpW7YHJL/profile http://localhost:59519/getInfo.html 17:09:20 INFO - 2015-12-16 17:09:20,899 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:09:20 INFO - 2015-12-16 17:09:20,899 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:09:20 INFO - 2015-12-16 17:09:20,900 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:09:20 INFO - 2015-12-16 17:09:20,900 DEBUG : BROWSER_OUTPUT: __metrics 17:09:20 INFO - 2015-12-16 17:09:20,996 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:09:21 INFO - 2015-12-16 17:09:21,865 INFO : Browser initialized. 17:09:21 INFO - 2015-12-16 17:09:21,866 INFO : Running cycle 1/1 for kraken test... 17:09:21 INFO - 2015-12-16 17:09:21,866 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpW7YHJL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:09:33 INFO - 2015-12-16 17:09:33,777 DEBUG : BROWSER_OUTPUT: RSS: Main: 143446016 17:09:33 INFO - 2015-12-16 17:09:33,777 DEBUG : BROWSER_OUTPUT: 17:09:36 INFO - 2015-12-16 17:09:36,298 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59519/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59519/tests/kraken/driver.html?testName=audio-beat-detection) 17:09:36 INFO - 2015-12-16 17:09:36,908 DEBUG : BROWSER_OUTPUT: RSS: Main: 145100800 17:09:36 INFO - 2015-12-16 17:09:36,909 DEBUG : BROWSER_OUTPUT: 17:09:39 INFO - 2015-12-16 17:09:39,566 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59519/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59519/tests/kraken/driver.html?testName=audio-dft) 17:09:40 INFO - 2015-12-16 17:09:40,168 DEBUG : BROWSER_OUTPUT: RSS: Main: 144424960 17:09:40 INFO - 2015-12-16 17:09:40,168 DEBUG : BROWSER_OUTPUT: 17:09:43 INFO - 2015-12-16 17:09:43,013 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59519/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59519/tests/kraken/driver.html?testName=audio-fft) 17:09:43 INFO - 2015-12-16 17:09:43,594 DEBUG : BROWSER_OUTPUT: RSS: Main: 138493952 17:09:43 INFO - 2015-12-16 17:09:43,595 DEBUG : BROWSER_OUTPUT: 17:09:45 INFO - 2015-12-16 17:09:45,834 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59519/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59519/tests/kraken/driver.html?testName=audio-oscillator) 17:09:46 INFO - 2015-12-16 17:09:46,439 DEBUG : BROWSER_OUTPUT: RSS: Main: 139644928 17:09:46 INFO - 2015-12-16 17:09:46,439 DEBUG : BROWSER_OUTPUT: 17:09:48 INFO - 2015-12-16 17:09:48,633 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59519/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59519/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:09:49 INFO - 2015-12-16 17:09:49,206 DEBUG : BROWSER_OUTPUT: RSS: Main: 139542528 17:09:49 INFO - 2015-12-16 17:09:49,206 DEBUG : BROWSER_OUTPUT: 17:09:52 INFO - 2015-12-16 17:09:52,178 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59519/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59519/tests/kraken/driver.html?testName=imaging-darkroom) 17:09:52 INFO - 2015-12-16 17:09:52,780 DEBUG : BROWSER_OUTPUT: RSS: Main: 140296192 17:09:52 INFO - 2015-12-16 17:09:52,780 DEBUG : BROWSER_OUTPUT: 17:09:56 INFO - 2015-12-16 17:09:56,216 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59519/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59519/tests/kraken/driver.html?testName=imaging-desaturate) 17:09:56 INFO - 2015-12-16 17:09:56,804 DEBUG : BROWSER_OUTPUT: RSS: Main: 141537280 17:09:56 INFO - 2015-12-16 17:09:56,804 DEBUG : BROWSER_OUTPUT: 17:09:59 INFO - 2015-12-16 17:09:59,622 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59519/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59519/tests/kraken/driver.html?testName=json-parse-financial) 17:10:00 INFO - 2015-12-16 17:10:00,208 DEBUG : BROWSER_OUTPUT: RSS: Main: 141410304 17:10:00 INFO - 2015-12-16 17:10:00,208 DEBUG : BROWSER_OUTPUT: 17:10:01 INFO - 2015-12-16 17:10:01,761 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59519/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59519/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:10:02 INFO - 2015-12-16 17:10:02,342 DEBUG : BROWSER_OUTPUT: RSS: Main: 142159872 17:10:02 INFO - 2015-12-16 17:10:02,342 DEBUG : BROWSER_OUTPUT: 17:10:04 INFO - 2015-12-16 17:10:04,153 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59519/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59519/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:10:04 INFO - 2015-12-16 17:10:04,774 DEBUG : BROWSER_OUTPUT: RSS: Main: 140410880 17:10:04 INFO - 2015-12-16 17:10:04,774 DEBUG : BROWSER_OUTPUT: 17:10:06 INFO - 2015-12-16 17:10:06,828 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59519/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59519/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:10:07 INFO - 2015-12-16 17:10:07,414 DEBUG : BROWSER_OUTPUT: RSS: Main: 141053952 17:10:07 INFO - 2015-12-16 17:10:07,414 DEBUG : BROWSER_OUTPUT: 17:10:09 INFO - 2015-12-16 17:10:09,850 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59519/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59519/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:10:10 INFO - 2015-12-16 17:10:10,452 DEBUG : BROWSER_OUTPUT: RSS: Main: 140800000 17:10:10 INFO - 2015-12-16 17:10:10,452 DEBUG : BROWSER_OUTPUT: 17:10:13 INFO - 2015-12-16 17:10:13,048 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59519/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59519/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:10:13 INFO - 2015-12-16 17:10:13,634 DEBUG : BROWSER_OUTPUT: RSS: Main: 140959744 17:10:13 INFO - 2015-12-16 17:10:13,634 DEBUG : BROWSER_OUTPUT: 17:10:15 INFO - 2015-12-16 17:10:15,364 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59519/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59519/tests/kraken/driver.html?testName=ai-astar) 17:10:15 INFO - 2015-12-16 17:10:15,607 DEBUG : BROWSER_OUTPUT: RSS: Main: 141938688 17:10:15 INFO - 2015-12-16 17:10:15,608 DEBUG : BROWSER_OUTPUT: 17:10:15 INFO - 2015-12-16 17:10:15,611 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:10:15 INFO - 2015-12-16 17:10:15,611 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:10:15 INFO - 2015-12-16 17:10:15,611 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:10:15 INFO - 2015-12-16 17:10:15,611 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:10:15 INFO - 2015-12-16 17:10:15,612 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;107;112;112;115;125;112;111;112;112 17:10:15 INFO - 2015-12-16 17:10:15,612 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;148;131;153;165;125;155;158;135;161;128 17:10:15 INFO - 2015-12-16 17:10:15,612 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;163;161;164;161;162;162;164;170;162 17:10:15 INFO - 2015-12-16 17:10:15,612 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;71;73;73;73;72;73;127;72;76 17:10:15 INFO - 2015-12-16 17:10:15,612 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;93;132;92;93;93;137;93;94;137 17:10:15 INFO - 2015-12-16 17:10:15,612 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;111;110;110;109;110;110;110 17:10:15 INFO - 2015-12-16 17:10:15,612 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;146;147;146;147;147;147;147;149;146 17:10:15 INFO - 2015-12-16 17:10:15,612 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;96;96;97;97;97;96;97;97 17:10:15 INFO - 2015-12-16 17:10:15,612 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;59;64;59;63;62;61;59;60;57 17:10:15 INFO - 2015-12-16 17:10:15,612 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;67;68;67;68;69;68;68;69;68 17:10:15 INFO - 2015-12-16 17:10:15,613 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;86;85;84;84;83;89;88;94;89 17:10:15 INFO - 2015-12-16 17:10:15,613 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;134;120;114;121;115;119;122;119;117 17:10:15 INFO - 2015-12-16 17:10:15,613 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;155;157;156;154;142;155;152;152;143 17:10:15 INFO - 2015-12-16 17:10:15,613 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;73;70;68;73;72;69;72;67;67;67 17:10:15 INFO - 2015-12-16 17:10:15,613 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:10:15 INFO - 2015-12-16 17:10:15,613 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:10:15 INFO - 2015-12-16 17:10:15,613 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,734 17:10:15 INFO - 2015-12-16 17:10:15,614 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:10:15 INFO - 2015-12-16 17:10:15,614 DEBUG : BROWSER_OUTPUT: __startTimestamp1450314615609__endTimestamp 17:10:15 INFO - 2015-12-16 17:10:15,614 DEBUG : BROWSER_OUTPUT: 17:10:15 INFO - 2015-12-16 17:10:15,617 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:10:15 INFO - 2015-12-16 17:10:15,617 DEBUG : BROWSER_OUTPUT: Number of tests: 14 17:10:15 INFO - 2015-12-16 17:10:15,618 DEBUG : BROWSER_OUTPUT: 17:10:15 INFO - 2015-12-16 17:10:15,618 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.20 Median:112.00 stddev:4.64 (4.1%) stddev-sans-first:4.91 17:10:15 INFO - 2015-12-16 17:10:15,618 DEBUG : BROWSER_OUTPUT: Values: 114.0 107.0 112.0 112.0 115.0 125.0 112.0 111.0 112.0 112.0 17:10:15 INFO - 2015-12-16 17:10:15,618 DEBUG : BROWSER_OUTPUT: 17:10:15 INFO - 2015-12-16 17:10:15,618 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.90 Median:154.00 stddev:14.81 (9.6%) stddev-sans-first:15.69 17:10:15 INFO - 2015-12-16 17:10:15,618 DEBUG : BROWSER_OUTPUT: Values: 148.0 131.0 153.0 165.0 125.0 155.0 158.0 135.0 161.0 128.0 17:10:15 INFO - 2015-12-16 17:10:15,619 DEBUG : BROWSER_OUTPUT: 17:10:15 INFO - 2015-12-16 17:10:15,619 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.10 Median:162.50 stddev:2.64 (1.6%) stddev-sans-first:2.77 17:10:15 INFO - 2015-12-16 17:10:15,619 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 161.0 164.0 161.0 162.0 162.0 164.0 170.0 162.0 17:10:15 INFO - 2015-12-16 17:10:15,619 DEBUG : BROWSER_OUTPUT: 17:10:15 INFO - 2015-12-16 17:10:15,619 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.30 Median:73.00 stddev:17.16 (23.5%) stddev-sans-first:18.09 17:10:15 INFO - 2015-12-16 17:10:15,619 DEBUG : BROWSER_OUTPUT: Values: 73.0 71.0 73.0 73.0 73.0 72.0 73.0 127.0 72.0 76.0 17:10:15 INFO - 2015-12-16 17:10:15,620 DEBUG : BROWSER_OUTPUT: 17:10:15 INFO - 2015-12-16 17:10:15,620 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.60 Median:93.00 stddev:20.57 (22.1%) stddev-sans-first:21.22 17:10:15 INFO - 2015-12-16 17:10:15,620 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 132.0 92.0 93.0 93.0 137.0 93.0 94.0 137.0 17:10:15 INFO - 2015-12-16 17:10:15,620 DEBUG : BROWSER_OUTPUT: 17:10:15 INFO - 2015-12-16 17:10:15,620 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 17:10:15 INFO - 2015-12-16 17:10:15,621 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 111.0 110.0 110.0 109.0 110.0 110.0 110.0 17:10:15 INFO - 2015-12-16 17:10:15,621 DEBUG : BROWSER_OUTPUT: 17:10:15 INFO - 2015-12-16 17:10:15,621 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 17:10:15 INFO - 2015-12-16 17:10:15,621 DEBUG : BROWSER_OUTPUT: Values: 148.0 146.0 147.0 146.0 147.0 147.0 147.0 147.0 149.0 146.0 17:10:15 INFO - 2015-12-16 17:10:15,621 DEBUG : BROWSER_OUTPUT: 17:10:15 INFO - 2015-12-16 17:10:15,621 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 17:10:15 INFO - 2015-12-16 17:10:15,621 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 96.0 96.0 97.0 97.0 97.0 96.0 97.0 97.0 17:10:15 INFO - 2015-12-16 17:10:15,621 DEBUG : BROWSER_OUTPUT: 17:10:15 INFO - 2015-12-16 17:10:15,621 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.30 Median:60.50 stddev:2.16 (3.6%) stddev-sans-first:2.24 17:10:15 INFO - 2015-12-16 17:10:15,621 DEBUG : BROWSER_OUTPUT: Values: 59.0 59.0 64.0 59.0 63.0 62.0 61.0 59.0 60.0 57.0 17:10:15 INFO - 2015-12-16 17:10:15,621 DEBUG : BROWSER_OUTPUT: 17:10:15 INFO - 2015-12-16 17:10:15,622 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 17:10:15 INFO - 2015-12-16 17:10:15,622 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 68.0 67.0 68.0 69.0 68.0 68.0 69.0 68.0 17:10:15 INFO - 2015-12-16 17:10:15,622 DEBUG : BROWSER_OUTPUT: 17:10:15 INFO - 2015-12-16 17:10:15,622 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:87.00 stddev:3.50 (4.0%) stddev-sans-first:3.48 17:10:15 INFO - 2015-12-16 17:10:15,622 DEBUG : BROWSER_OUTPUT: Values: 83.0 86.0 85.0 84.0 84.0 83.0 89.0 88.0 94.0 89.0 17:10:15 INFO - 2015-12-16 17:10:15,622 DEBUG : BROWSER_OUTPUT: 17:10:15 INFO - 2015-12-16 17:10:15,622 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.80 Median:120.50 stddev:5.92 (4.9%) stddev-sans-first:5.84 17:10:15 INFO - 2015-12-16 17:10:15,622 DEBUG : BROWSER_OUTPUT: Values: 127.0 134.0 120.0 114.0 121.0 115.0 119.0 122.0 119.0 117.0 17:10:15 INFO - 2015-12-16 17:10:15,622 DEBUG : BROWSER_OUTPUT: 17:10:15 INFO - 2015-12-16 17:10:15,622 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.70 Median:154.50 stddev:6.22 (4.0%) stddev-sans-first:5.52 17:10:15 INFO - 2015-12-16 17:10:15,622 DEBUG : BROWSER_OUTPUT: Values: 141.0 155.0 157.0 156.0 154.0 142.0 155.0 152.0 152.0 143.0 17:10:15 INFO - 2015-12-16 17:10:15,622 DEBUG : BROWSER_OUTPUT: 17:10:15 INFO - 2015-12-16 17:10:15,623 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:71.00 stddev:2.53 (3.6%) stddev-sans-first:2.40 17:10:15 INFO - 2015-12-16 17:10:15,623 DEBUG : BROWSER_OUTPUT: Values: 73.0 70.0 68.0 73.0 72.0 69.0 72.0 67.0 67.0 67.0 17:10:15 INFO - 2015-12-16 17:10:15,624 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:10:15 INFO - 2015-12-16 17:10:15,624 DEBUG : BROWSER_OUTPUT: 17:10:16 INFO - 2015-12-16 17:10:16,441 INFO : Browser exited with error code: 0 17:10:16 INFO - 2015-12-16 17:10:16,487 INFO : Completed test kraken (00:01:00) 17:10:16 INFO - 2015-12-16 17:10:16,487 INFO : Starting test v8_7 17:10:16 INFO - 2015-12-16 17:10:16,487 DEBUG : operating with platform_type : linux_ 17:10:16 INFO - 2015-12-16 17:10:16,487 INFO : Initialising browser for v8_7 test... 17:10:16 INFO - 2015-12-16 17:10:16,493 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdzxmYp/profile http://localhost:59519/getInfo.html 17:10:21 INFO - 2015-12-16 17:10:21,379 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:10:21 INFO - 2015-12-16 17:10:21,380 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:10:21 INFO - 2015-12-16 17:10:21,380 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:10:21 INFO - 2015-12-16 17:10:21,380 DEBUG : BROWSER_OUTPUT: __metrics 17:10:21 INFO - 2015-12-16 17:10:21,496 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:10:22 INFO - 2015-12-16 17:10:22,421 INFO : Browser initialized. 17:10:22 INFO - 2015-12-16 17:10:22,421 INFO : Running cycle 1/1 for v8_7 test... 17:10:22 INFO - 2015-12-16 17:10:22,422 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdzxmYp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:10:34 INFO - 2015-12-16 17:10:34,280 DEBUG : BROWSER_OUTPUT: RSS: Main: 143290368 17:10:34 INFO - 2015-12-16 17:10:34,280 DEBUG : BROWSER_OUTPUT: 17:10:55 INFO - 2015-12-16 17:10:55,713 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59519/tests/v8_7/run.html (next: http://localhost:59519/tests/v8_7/run.html) 17:10:55 INFO - 2015-12-16 17:10:55,963 DEBUG : BROWSER_OUTPUT: RSS: Main: 138747904 17:10:55 INFO - 2015-12-16 17:10:55,963 DEBUG : BROWSER_OUTPUT: 17:10:55 INFO - 2015-12-16 17:10:55,963 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:10:55 INFO - 2015-12-16 17:10:55,963 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:10:55 INFO - 2015-12-16 17:10:55,963 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:10:55 INFO - 2015-12-16 17:10:55,964 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:10:55 INFO - 2015-12-16 17:10:55,964 DEBUG : BROWSER_OUTPUT: |0;Richards;165.0709805216243 17:10:55 INFO - 2015-12-16 17:10:55,964 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.43037497644622 17:10:55 INFO - 2015-12-16 17:10:55,964 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.72027972027973 17:10:55 INFO - 2015-12-16 17:10:55,964 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5296.2962962962965 17:10:55 INFO - 2015-12-16 17:10:55,964 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1066.0980810234541 17:10:55 INFO - 2015-12-16 17:10:55,965 DEBUG : BROWSER_OUTPUT: |5;Earley;715 17:10:55 INFO - 2015-12-16 17:10:55,965 DEBUG : BROWSER_OUTPUT: |6;Boyer;12345.67901234568 17:10:55 INFO - 2015-12-16 17:10:55,965 DEBUG : BROWSER_OUTPUT: |7;RegExp;24780.48780487805 17:10:55 INFO - 2015-12-16 17:10:55,965 DEBUG : BROWSER_OUTPUT: |8;Splay;563.4831460674158 17:10:55 INFO - 2015-12-16 17:10:55,965 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 17:10:55 INFO - 2015-12-16 17:10:55,965 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:10:55 INFO - 2015-12-16 17:10:55,965 DEBUG : BROWSER_OUTPUT: __startTimestamp1450314655960__endTimestamp 17:10:55 INFO - 2015-12-16 17:10:55,965 DEBUG : BROWSER_OUTPUT: 17:10:55 INFO - 2015-12-16 17:10:55,965 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:10:55 INFO - 2015-12-16 17:10:55,965 DEBUG : BROWSER_OUTPUT: Number of tests: 10 17:10:55 INFO - 2015-12-16 17:10:55,965 DEBUG : BROWSER_OUTPUT: 17:10:55 INFO - 2015-12-16 17:10:55,965 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.07 Median:165.07 stddev:0.00 (0.0%) 17:10:55 INFO - 2015-12-16 17:10:55,966 DEBUG : BROWSER_OUTPUT: Values: 165.1 17:10:55 INFO - 2015-12-16 17:10:55,966 DEBUG : BROWSER_OUTPUT: 17:10:55 INFO - 2015-12-16 17:10:55,966 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.43 Median:188.43 stddev:0.00 (0.0%) 17:10:55 INFO - 2015-12-16 17:10:55,966 DEBUG : BROWSER_OUTPUT: Values: 188.4 17:10:55 INFO - 2015-12-16 17:10:55,966 DEBUG : BROWSER_OUTPUT: 17:10:55 INFO - 2015-12-16 17:10:55,966 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.72 Median:279.72 stddev:0.00 (0.0%) 17:10:55 INFO - 2015-12-16 17:10:55,966 DEBUG : BROWSER_OUTPUT: Values: 279.7 17:10:55 INFO - 2015-12-16 17:10:55,966 DEBUG : BROWSER_OUTPUT: 17:10:55 INFO - 2015-12-16 17:10:55,966 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5296.30 Median:5296.30 stddev:0.00 (0.0%) 17:10:55 INFO - 2015-12-16 17:10:55,966 DEBUG : BROWSER_OUTPUT: Values: 5296.3 17:10:55 INFO - 2015-12-16 17:10:55,966 DEBUG : BROWSER_OUTPUT: 17:10:55 INFO - 2015-12-16 17:10:55,966 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1066.10 Median:1066.10 stddev:0.00 (0.0%) 17:10:55 INFO - 2015-12-16 17:10:55,966 DEBUG : BROWSER_OUTPUT: Values: 1066.1 17:10:55 INFO - 2015-12-16 17:10:55,966 DEBUG : BROWSER_OUTPUT: 17:10:55 INFO - 2015-12-16 17:10:55,966 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:715.00 Median:715.00 stddev:0.00 (0.0%) 17:10:55 INFO - 2015-12-16 17:10:55,966 DEBUG : BROWSER_OUTPUT: Values: 715.0 17:10:55 INFO - 2015-12-16 17:10:55,967 DEBUG : BROWSER_OUTPUT: 17:10:55 INFO - 2015-12-16 17:10:55,967 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12345.68 Median:12345.68 stddev:0.00 (0.0%) 17:10:55 INFO - 2015-12-16 17:10:55,967 DEBUG : BROWSER_OUTPUT: Values: 12345.7 17:10:55 INFO - 2015-12-16 17:10:55,967 DEBUG : BROWSER_OUTPUT: 17:10:55 INFO - 2015-12-16 17:10:55,967 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24780.49 Median:24780.49 stddev:0.00 (0.0%) 17:10:55 INFO - 2015-12-16 17:10:55,967 DEBUG : BROWSER_OUTPUT: Values: 24780.5 17:10:55 INFO - 2015-12-16 17:10:55,967 DEBUG : BROWSER_OUTPUT: 17:10:55 INFO - 2015-12-16 17:10:55,967 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:563.48 Median:563.48 stddev:0.00 (0.0%) 17:10:55 INFO - 2015-12-16 17:10:55,968 DEBUG : BROWSER_OUTPUT: Values: 563.5 17:10:55 INFO - 2015-12-16 17:10:55,968 DEBUG : BROWSER_OUTPUT: 17:10:55 INFO - 2015-12-16 17:10:55,968 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 17:10:55 INFO - 2015-12-16 17:10:55,968 DEBUG : BROWSER_OUTPUT: Values: 4845.4 17:10:55 INFO - 2015-12-16 17:10:55,968 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:10:55 INFO - 2015-12-16 17:10:55,968 DEBUG : BROWSER_OUTPUT: 17:10:56 INFO - 2015-12-16 17:10:56,817 INFO : Browser exited with error code: 0 17:10:56 INFO - 2015-12-16 17:10:56,834 INFO : Completed test v8_7 (00:00:40) 17:10:56 INFO - 2015-12-16 17:10:56,994 INFO : Completed test suite (00:20:12) 17:10:56 INFO - 2015-12-16 17:10:56,994 DEBUG : Working with test: dromaeo_css 17:10:56 INFO - 2015-12-16 17:10:56,994 DEBUG : Generating results file: dromaeo_css 17:10:56 INFO - 2015-12-16 17:10:56,995 DEBUG : Working with test: kraken 17:10:56 INFO - 2015-12-16 17:10:56,995 DEBUG : Generating results file: kraken 17:10:56 INFO - 2015-12-16 17:10:56,995 INFO : javascript benchmark 17:10:56 INFO - 2015-12-16 17:10:56,995 DEBUG : Working with test: v8_7 17:10:56 INFO - 2015-12-16 17:10:56,996 DEBUG : Generating results file: v8_7 17:10:56 INFO - 2015-12-16 17:10:56,996 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:10:57 INFO - 2015-12-16 17:10:57,050 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 17:10:57 INFO - 2015-12-16 17:10:57,050 DEBUG : process_Request line: dromaeo_css 6936.51 graph.html#tests=[[72,64,43]] 17:10:57 INFO - 2015-12-16 17:10:57,050 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:10:57 INFO - 2015-12-16 17:10:57,081 DEBUG : process_Request line: kraken 1515.60 graph.html#tests=[[232,64,43]] 17:10:57 INFO - 2015-12-16 17:10:57,082 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:10:57 INFO - 2015-12-16 17:10:57,115 DEBUG : process_Request line: v8_7 21513.49 graph.html#tests=[[230,64,43]] 17:10:57 INFO - 2015-12-16 17:10:57,116 INFO : javascript benchmark 17:10:57 INFO - 2015-12-16 17:10:57,120 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3202.855871485783, 3206.6793320667934, 3245.6267529234146, 3271.280318329968, 3275.033865009822, 5285.392179899312, 5433.510984011438, 5448.182772584114, 5448.700321482317, 5461.044317244487, 5403.486668766461, 5451.318585176853, 5489.094299440588, 5617.634853734515, 5634.32388113427, 4965.726885021322, 4985.825496107637, 5077.136886729247, 5085.974570127144, 5094.955534115516, 4884.169691152495, 4936.136176169174, 5009.874753131165, 5052.0, 5068.873278168038, 4780.617550595944, 4838.250071238964, 4907.4356449008465, 4988.3764529434, 5067.1385864402955, 5008.69947803133, 5009.123403404426, 5019.874503137451, 5029.396472423333, 5034.773435195425, 5022.974885125551, 5026.4973502649445, 5029.647924645276, 5030.547250747413, 5037.899242015139, 5069.340985671876, 5147.202183661539, 5238.633295669305, 5243.895122097537, 5378.0857254266475, 5875.941240587582, 5909.2022576951995, 5919.644821310735, 5919.881602367972, 5923.5853490255695, 5919.319278283009, 5921.230240068763, 5929.229200203989, 5945.435183657545, 5956.7319470623925, 5205.973970130163, 5280.128778751501, 5424.810131645373, 5474.233607294982, 5496.725163741877, 6009.038553831366, 6012.789552365646, 6030.909536356959, 6036.9698151508965, 6045.486133678686, 5794.768209271666, 5800.622959507618, 5801.7099145042575, 5826.592138550261, 5843.328017277982, 5576.637518561281, 5672.4894759471845, 5687.118496633028, 5789.363170051291, 5823.5341172706085, 5793.102069179284, 5817.563682723728, 5822.7088645567555, 5827.24245848037, 5835.35811060783, 5678.4605462480995, 5811.302643682785, 5812.564057695689, 5847.94152058474, 5852.707364631751, 4422.115576884636, 4450.109978004347, 4471.418715566955, 4499.460064792246, 4518.322251662277, 3999.4000899864673, 4003.7197396181987, 4005.178938317638, 4025.6376926076796, 4057.472528571267, 5300.31095957523, 5433.945660543423, 5539.5014448699, 5554.389017208104, 5557.944420555824, 5829.183914252008, 5894.263217097863, 5908.20239267702, 5916.9941110011405, 5952.0, 5660.745266463019, 5688.715564221772, 5691.715414229272, 5694.686792226385, 5694.772209111589, 4924.901501970012, 5024.799008039638, 5034.219695947134, 5202.531772140525, 5223.268742376071, 5882.676452795137, 5927.347991720907, 5985.042393217064, 6001.219841420588, 6025.487833534111, 5878.059510478303, 5882.0, 5887.587868849139, 5895.174675545512, 5903.173555702291, 5692.857678558069, 5742.224799651994, 5780.364159942487, 5993.31076926159, 6004.249468816398, 5856.150858125633, 5869.325027621878, 5883.499902508334, 5895.9115613266695, 5901.970490147522, 5893.233879595625, 5940.762369505344, 5957.821265362046, 5964.015937370459, 5967.1944287522365, 5592.664440133605, 5689.601727879009, 5689.743961521659, 5709.51469125129, 5841.211436456024, 5625.0, 5670.5180059695385, 5774.855628609318, 5814.534837212928, 5863.325717542367, 5465.863353416196, 5568.526675232651, 5570.805021824217, 5572.164175373564, 5578.330600327987, 5679.6024278301775, 5714.342850572071, 5752.28096487939, 5760.251167348218, 5793.536517078708, 5618.69097199658, 5649.802256920988, 5655.0, 5657.688827114548, 5683.687397193194], "unit": "score", "name": "dojo.html", "value": 5394.745184956848}, {"lowerIsBetter": false, "replicates": [549.4478049560191, 602.8372339468341, 606.172574435895, 608.8477880529867, 611.8072807065776, 36800.0, 37061.44407833885, 37274.068148296305, 37426.43860342097, 37428.06429839252, 40524.39213411801, 41150.7942460288, 41191.58808411923, 41356.793216033955, 41394.58605413945, 8718.520481373522, 8811.030786613468, 8886.777830554256, 8889.555522223895, 8911.509866957314, 8662.783430414227, 8707.95646021769, 8708.869366959501, 8714.085021072791, 8714.346424018224, 8634.0, 8830.20528152466, 8842.071582483812, 8842.823143537125, 8855.291576673852, 8732.912670873306, 8767.56162191891, 8774.210321071134, 8775.473471591726, 8819.911800882006, 8598.140185981414, 8711.303095752324, 8728.214460698568, 8732.43239189457, 8776.078511756237, 38139.42790858139, 38544.42183367252, 38583.22833543314, 38746.61253387486, 38965.80517097425, 3062.770292228092, 3084.9511166203597, 3118.3451475190236, 3125.9531107033413, 3413.5391722117442, 29268.41463170725, 29478.11565653034, 30064.54903176454, 30095.398092038256, 30464.390712185632, 3564.846323131253, 3609.9458508122398, 3637.290728307981, 3691.8154092295545, 3811.428285757131, 260259.0, 261810.0, 262750.0, 262820.0, 264453.0, 39563.0, 40034.0, 53677.1948420774, 53850.0, 53950.73024634852, 37833.243335133695, 37998.810005949796, 37999.24001520009, 38002.42996355057, 38024.23951520954, 12329.198602090835, 12408.255504669749, 12427.565035223724, 12455.314957677234, 12500.937495312648, 9723.270754693427, 9813.116819486138, 9826.754331141636, 9833.606655733834, 9834.213262938947, 13377.862881655168, 13820.96342774296, 13826.101303415246, 13878.514252001132, 13883.305834708224, 5665.575081868877, 5730.598858079894, 5742.196092547047, 5756.280464941882, 5790.10253410722, 1009.7122320138725, 1014.7818219082933, 1044.6709286574705, 1099.6920862158609, 1126.1778901402022, 27783.16650500448, 27978.30241877166, 28268.151955441368, 28296.71703282982, 28560.858305586367, 982.9886425631163, 1025.9025392587691, 1064.499685147979, 1111.6053800900563, 1121.8429419881222, 14750.0, 14794.067222200209, 14871.853354025967, 14880.627984300263, 14945.40218391274, 308332.0, 311002.0, 312316.0, 314895.0, 315755.0, 48865.26702099471, 48923.0, 49180.0, 49310.506894931306, 49342.75328623334, 1281.6155153453926, 1323.6823162441137, 1327.81824176483, 1328.2495390104752, 1329.734053189366, 27013.86493067522, 27994.86002569974, 28255.71744282613, 31835.681643184198, 32228.0, 46541.53458465372, 47420.814479638284, 47749.522504775894, 48056.759716201195, 48169.759151204016, 284168.0, 288182.0, 289095.0, 289824.0, 290098.0, 40404.1919161621, 43225.0, 43437.782811085744, 44126.0, 44290.778546108355, 40482.39276410797, 41316.0, 47284.52715472801, 47960.0, 49002.0, 34445.0, 35231.0, 35565.0, 35750.106247344025, 40241.79879100703, 30619.0, 31047.0, 31266.687333126378, 31402.685973139975, 31691.366172676877, 38910.61089389183, 39169.41245881257, 39739.60260397359, 39748.40377394284, 40168.19663606653, 29536.852315739143, 30256.84871575628, 32047.0, 32155.35689286248, 32321.838390807894, 24469.143579974614, 24733.87633061823, 24775.380615484035, 24783.0, 25072.874635626704], "unit": "score", "name": "ext.html", "value": 17646.769428166062}, {"lowerIsBetter": false, "replicates": [351.9085037890148, 354.7658545360063, 355.98011696489533, 364.3678218291264, 365.10549154571305, 16114.194290285483, 16688.749668754965, 17264.0, 17581.648367032652, 17841.64316713668, 14824.184669843155, 14998.925005374958, 15736.685266294668, 16462.341506339733, 16500.504984850475, 4903.239997800347, 5013.495951214639, 5048.57087147591, 5054.140796064659, 5055.9241611375855, 4957.818955493424, 4985.127602669519, 5027.723475208862, 5032.11937910866, 5034.169362055275, 3641.362761516737, 3739.6447337503027, 5355.384130824966, 5381.81163659272, 5490.450954904518, 5487.945120548783, 5493.285872836545, 5496.148097044925, 5514.558835293167, 5520.309961254843, 5227.869303267449, 5251.396089449724, 5261.815836445744, 5407.5133238008375, 5426.240326354314, 12770.297633630147, 12804.80792788109, 13328.067035307435, 19972.80027199724, 20266.594668106554, 1976.575036367188, 1990.532224927141, 2205.3604454708116, 2249.4151520604596, 2313.5141620259596, 9120.680776172801, 9315.813683726356, 9473.242140628734, 10982.505787239594, 12892.097553171188, 1571.1201727032899, 1617.6441182939734, 1629.3482606957193, 1633.0446688687132, 1646.7484711619136, 61917.38082619161, 65543.3445665542, 66742.3325766741, 69727.0, 69739.65130174368, 15720.0, 16114.274857631435, 16291.266892989845, 16357.263923123488, 16361.34554617802, 23191.652125218134, 23346.64980025267, 23382.7661723384, 23581.646275305884, 23765.287041388787, 8553.358498112666, 8565.0, 8565.48607083577, 8605.268552173135, 8615.181557752003, 7180.8922866157045, 7193.676284567103, 7229.783106506813, 7265.0, 7275.236100209402, 7877.369810415153, 7926.445148839641, 7934.166912474223, 7973.122956474783, 7986.960065199637, 3054.9083527494213, 3065.4941934580543, 3111.144435280271, 3172.5558421820965, 3204.8557814898386, 424.4227850123829, 428.45586105645657, 461.61916418954496, 807.5881300536769, 964.1467301438138, 9958.601655933682, 10208.43853588045, 10276.280660353703, 10370.896291037145, 10631.043206111488, 434.2574198121248, 439.13928699748215, 443.61848810023355, 459.07496394764576, 470.84697473320625, 5471.534919531805, 5631.380548139701, 5738.655680659173, 9743.171830394354, 9987.101160895554, 535663.0, 539924.0, 541396.0, 548419.0, 548701.0, 83471.58264208761, 86078.56960715282, 86256.56871715601, 86935.56532217299, 86983.56508217545, 1128.1595211567435, 1145.0553293532869, 1146.3236690352733, 1146.5757669662278, 1151.1308961734005, 15926.681466370375, 15978.840211597735, 16030.438934637232, 16120.67758644844, 16331.101789401697, 36262.63737362698, 36623.63376366202, 37443.0, 37494.625053749114, 37602.81198594099, 45988.0, 46283.53716462792, 47885.76057119692, 48221.0, 48870.26694599655, 9075.183233508751, 9080.273578113867, 9625.71122866315, 9719.85420218683, 9843.60625574969, 10774.461276935965, 10787.514561844579, 10861.782764344827, 10925.289856159325, 10950.06924411434, 12973.935130324287, 14250.572482825532, 14513.346899389342, 14784.186869721838, 14919.030263032868, 14124.929375353058, 14348.282585870873, 14527.418903243752, 14635.34140963638, 15387.38450461969, 13672.384742686405, 13942.721145577234, 14624.926875365554, 14662.926685366505, 14850.331735071732, 9217.76955576116, 9327.113924177193, 9515.191208747334, 9548.809023819345, 9604.75988100303, 9747.658831940847, 9811.754706132404, 11087.611933582286, 13876.171789840662, 13994.230317332644], "unit": "score", "name": "jquery.html", "value": 8744.745611262113}, {"lowerIsBetter": false, "replicates": [1484.9925750371247, 1537.3773621683215, 1602.0547876752714, 1677.1446562253254, 1791.2566284991728, 6897.965510172442, 6960.373566379025, 7371.631418429077, 7784.9221507784905, 7790.6104694765245, 7379.1513975892785, 7628.580428076453, 7634.236576342363, 7710.306072453492, 7739.458237923348, 2218.4897473581045, 2223.9555208895813, 2248.3592176229777, 2250.2124256510174, 2251.6397376419777, 2258.7063681721434, 2271.284545368212, 2287.9771202288016, 2296.322584837477, 2339.2748248043076, 2195.9890200548975, 2196.901139448729, 2229.308914236592, 2230.721159855018, 2231.230225572175, 2201.7908298711595, 2240.0591751464426, 2260.6495993121093, 2261.683364328995, 2262.9207977720785, 2243.102758896438, 2281.2927992322434, 2284.1548627007946, 2286.0284379138966, 2289.39331077263, 7651.655675494616, 7736.7292144774665, 7788.883166752503, 7789.415793815429, 7816.179301173352, 4609.608183304423, 4639.768011599406, 4665.09030739006, 4667.953320466786, 4668.6731928765, 2924.6782853886057, 2982.3587928595457, 2991.895283665083, 2996.745276651487, 3001.189678786737, 910.4673765846921, 924.5931790012373, 927.5918595817886, 983.5426526665135, 983.5623147699276, 10634.521446534847, 10638.308509946906, 10642.308249963728, 10757.892421075767, 10812.891871081267, 4135.731177473454, 4145.3781932709735, 4164.0, 4181.289180839264, 4209.052963083282, 9094.545272736337, 9120.954395227982, 9160.496172710566, 9161.49611771359, 9162.22121119699, 4617.007343421181, 4652.999605084923, 4674.135284972291, 4678.719276843401, 4682.0, 4142.212979533939, 4144.109016561393, 4264.850730224427, 4283.22901877665, 4290.785460726951, 3441.6214216436174, 3452.2405070884365, 3473.5484387029524, 3496.3531746626445, 3499.7900125992523, 1049.732318258839, 1057.9206559507913, 1063.5320458998017, 1066.173715370594, 1074.425182527344, 1048.2138396202847, 1054.7152268887357, 1058.5818601652459, 1217.7077501399776, 1339.8660133986718, 7034.050403195605, 7082.681279342442, 7092.255313192144, 7138.072050633385, 7383.15093764224, 1051.6003918510917, 1056.7569459024467, 1068.513826209073, 1068.8682161267407, 1158.4902642837126, 5621.7751289948765, 5781.508571771446, 5856.385079566669, 5868.735906884115, 5870.618409803349, 9243.39917905334, 9285.210757085588, 9364.859527107099, 9384.624615015324, 9394.154526092685, 9071.909280907239, 9225.72322830316, 9236.261099112055, 9337.112974267433, 9340.159385655325, 7250.274972502813, 7277.19950805411, 7287.234840341794, 7294.343509084208, 7337.339639432476, 7057.153141623038, 7098.858022839618, 7130.037444944866, 7130.18002929649, 7178.3898368637165, 8186.918130818615, 8285.4200205985, 8401.95799021001, 8468.872966905377, 8537.487750734976, 8362.958185209034, 8410.158984101541, 8428.704995325133, 8440.577971101298, 8567.443116197428, 6474.870502590016, 6492.285848556749, 6562.737490500326, 6795.864082718417, 6845.657717114224, 7416.443766717625, 7438.665260063419, 7519.849603008019, 7521.699132034876, 7561.621918903923, 6773.356531129535, 7009.088818453569, 7061.435085193275, 7092.326229008236, 7120.6795694194925, 6684.598924064571, 6746.898796518154, 6757.695903684445, 6775.390214880487, 6943.652817359213, 7008.684609192496, 7026.402755765817, 7100.751473698602, 7104.076470058859, 7132.393746531603, 6455.225372955088, 6457.644829534421, 6458.806235812933, 6475.935240647534, 6507.316731743288, 6473.967630161819, 6506.902396464152, 6520.0, 6529.67351632426, 6534.869302613826], "unit": "score", "name": "mootools.html", "value": 4426.969002252936}, {"lowerIsBetter": false, "replicates": [316.4793914011451, 323.32586557028594, 325.1594627886913, 328.3498672628196, 328.7945034353529, 6327.209098862642, 6345.58753681011, 6367.458766004896, 6377.107204991305, 6517.706703198355, 6276.278228003781, 6292.213473315824, 6303.936960630393, 6320.115183874262, 6320.968395158029, 4761.214399624067, 4769.403824521934, 4770.093682200388, 4770.165221086313, 4774.355462012636, 4783.593394561466, 4786.329913812069, 4789.880252993686, 4791.616670666356, 4793.7363445010515, 4643.674942754009, 4720.929186062212, 4730.195866702668, 4733.171694953387, 4737.668363214576, 4711.599514041293, 4714.104320179189, 4722.598579120779, 4722.787474563635, 4725.40932383452, 4067.9796601016806, 4068.7355321903983, 4068.8575899843363, 4074.30736774749, 4074.796260186979, 6043.244594425697, 6044.637321760709, 6051.939480605181, 6068.544859135538, 6090.878182436327, 5348.384935732402, 5485.533729632986, 5488.368837583689, 5499.230107784913, 5517.917231241535, 6645.76739814109, 6699.665016749143, 6705.362990515893, 6710.83222919426, 6729.192496900354, 4490.57339552742, 4491.752953587551, 4494.9325760113625, 4495.43807024122, 4497.168023915586, 6634.730179979921, 6715.496337774637, 6768.593884366954, 6786.76246331376, 6801.0, 4502.122086193161, 4502.347159661831, 4502.662300327489, 4510.932336014962, 4515.458145022619, 4560.065186636732, 4570.520095390003, 4571.679982401267, 4571.839985600488, 4586.197415452282, 5299.072662284085, 5358.46415358461, 5359.544438722674, 5366.141417373279, 5367.409584945653, 6426.550141490145, 6543.1166792483355, 6566.8358291043105, 6571.0471981562405, 6596.670166491656, 1593.5219434169703, 1624.0, 1634.6730653869274, 1636.4845073801714, 1637.7297745872036, 1054.7257712994524, 1065.2756125834353, 1070.1118072000222, 1071.4803320389606, 1080.8378743188584, 6337.176167098248, 6345.111684364193, 6388.936110638927, 6405.19935008124, 6407.167068281186, 6837.179538455417, 6856.828579285558, 6877.071595334666, 6895.793126206222, 6903.896441553381, 6362.141110949962, 6393.808185754435, 6395.488360931115, 6396.0, 6410.038494225903, 3800.220954704279, 3829.8468061277795, 3835.8082095895093, 3837.5586807516934, 3850.537935447764, 7195.856082878313, 7257.237990010973, 7258.383037441877, 7264.200937896827, 7264.382527485223, 6914.101166848278, 7115.466340024519, 7222.674979625929, 7227.0, 7251.3836323912, 7201.567905925661, 7226.349628533352, 7233.095863017123, 7250.492465527363, 7254.056972593635, 6973.79078627642, 6979.267176946348, 6987.580745155307, 7009.614471203929, 7035.718571257297, 6765.526413151032, 6915.204751453647, 6930.099087118642, 6930.549514281555, 6932.6533673315125, 7124.430045596237, 7187.676554554953, 7212.963935180291, 7216.89174662391, 7233.927660723325, 4607.861764147081, 4622.907541849077, 4644.790984405642, 4647.651426142985, 4649.86050418488, 6862.9313706862295, 6931.306869313028, 6952.478564107813, 6996.265392133956, 7046.682899269443, 6710.66446677674, 6746.021826835179, 6763.830904227237, 6766.4248538874745, 6812.557183783237, 6731.798046058626, 6759.087523184307, 6765.695543700447, 6776.830579235559, 6807.285235050248, 6482.124913136666, 6605.801825945229, 6618.172728408949, 6629.502787290876, 6635.2037755469655, 6823.93176068233, 6824.692888820115, 6835.043093966948, 6860.382565569123, 6867.0, 6571.737130514726, 6578.506612004023, 6652.900206497004, 6663.666816659051, 6668.866622667617], "unit": "score", "name": "prototype.html", "value": 4995.0814850614315}, {"lowerIsBetter": false, "replicates": [819.9016118065833, 827.1810907201871, 829.8132920092976, 842.49029337251, 854.987175192372, 13086.083974121804, 13188.604341869735, 13199.0, 13361.0, 13543.932280338597, 11068.225224234307, 11553.711157221052, 12467.750644987094, 12590.433430495626, 12594.559190428337, 819.1644522586957, 828.2587084559316, 828.7928017995501, 829.4401279136589, 830.3896635972555, 812.5490352854164, 817.8037271054964, 821.8233079887823, 822.1901427094307, 823.7899335669396, 853.2065179383171, 862.1766213266316, 865.3293697384546, 865.5931712095305, 868.4615538366222, 853.4751128056232, 855.1320409784074, 855.7304449098546, 855.9743207703779, 856.2764464027887, 632.3644737039292, 634.2642534659818, 637.4613451633362, 638.7700427846019, 639.3702203329716, 12449.564265250763, 12483.251004939733, 12565.308908010056, 12599.496020159182, 12619.495220191182, 9936.950315248378, 10042.297039207258, 10497.462533890777, 10665.9466702666, 11183.32900026001, 8864.290856731446, 8874.112588741138, 8881.333899957464, 8930.285577153812, 9018.729438116867, 3326.617438994522, 3329.1344250495044, 3337.7997320160866, 3400.846961886721, 3414.3000684859544, 44031.779841100586, 44358.33462498065, 45259.32111018337, 45809.56428267893, 47167.764161179315, 8539.74380768578, 9421.24630029596, 9452.054794520493, 9573.521323933775, 9771.804563908825, 16054.67890642204, 17910.820891790914, 17938.0, 17943.192556334998, 17950.371736989404, 6868.210155832044, 7080.079589653312, 7129.4652901031595, 7205.603691796897, 7344.339009489172, 4154.522229943595, 4180.581941805856, 4183.226103170862, 4201.264778663722, 4223.13425747721, 3046.8628911699025, 3085.0898984799537, 3101.286704058079, 3103.007037747944, 3108.036508682316, 538.1577830694949, 540.6161625246119, 545.7980547197483, 550.2708910693348, 560.0115795620733, 583.8394441528528, 610.3225419784036, 614.1928070097221, 633.4520639646672, 674.275154209227, 7197.352238298578, 7572.621368931532, 7577.962110189524, 7639.732609358646, 7693.538387696756, 559.6634052829421, 579.0330148651761, 603.5473394953784, 629.5026928726346, 664.9368310010541, 3660.2679464107287, 3738.0841693785196, 3791.1280405506886, 3834.309824231665, 3844.942325865114, 57190.7140464295, 57214.71392643094, 58106.0, 58778.0, 58895.0, 52098.47901520936, 52653.210201847, 52980.0, 54282.0, 54410.45589544133, 46824.531754682015, 47742.0, 48641.513584864406, 50747.0, 52852.73573632184, 7806.4925779824125, 7840.098388685375, 7931.5637639930355, 8108.310793582612, 8140.906455546854, 35337.64662353446, 35934.0, 35983.0, 36588.0, 36631.81684091563, 42036.159276814906, 42529.0, 44723.55276447194, 47135.528644713115, 47291.763541182074, 10522.31604945676, 10644.946775266075, 10658.73353166177, 10681.51933162994, 10719.0, 10775.245732798629, 10914.23600347968, 10918.727031824268, 10961.123110151328, 11426.085913126764, 10056.195504359488, 10214.08073273409, 10344.224183186441, 10359.0, 10400.635977740743, 10352.792944141225, 10545.314554554236, 10587.894121058998, 10741.010726133944, 10841.349519028883, 9723.222142228746, 9785.510724463606, 9791.657291994747, 9793.0, 9793.608255669693, 9046.592903319499, 9396.906030939877, 9461.0, 9478.620855165991, 9527.952360238154, 8467.872981905153, 8506.659733610586, 9072.0, 9076.41003334781, 9221.400608960395], "unit": "score", "name": "yui.html", "value": 6050.2836786720645}], "name": "dromaeo_css", "value": 6936.504564817666}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 107.0, 112.0, 112.0, 115.0, 125.0, 112.0, 111.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 113.2}, {"lowerIsBetter": true, "replicates": [148.0, 131.0, 153.0, 165.0, 125.0, 155.0, 158.0, 135.0, 161.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 145.9}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 161.0, 164.0, 161.0, 162.0, 162.0, 164.0, 170.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.1}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 73.0, 73.0, 73.0, 72.0, 73.0, 127.0, 72.0, 76.0], "unit": "score", "name": "audio-fft", "value": 78.3}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 132.0, 92.0, 93.0, 93.0, 137.0, 93.0, 94.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 105.6}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 111.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 149.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 97.0, 97.0, 97.0, 96.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 64.0, 59.0, 63.0, 62.0, 61.0, 59.0, 60.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 60.3}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 67.0, 68.0, 69.0, 68.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [83.0, 86.0, 85.0, 84.0, 84.0, 83.0, 89.0, 88.0, 94.0, 89.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.5}, {"lowerIsBetter": true, "replicates": [127.0, 134.0, 120.0, 114.0, 121.0, 115.0, 119.0, 122.0, 119.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.8}, {"lowerIsBetter": true, "replicates": [141.0, 155.0, 157.0, 156.0, 154.0, 142.0, 155.0, 152.0, 152.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.7}, {"lowerIsBetter": true, "replicates": [73.0, 70.0, 68.0, 73.0, 72.0, 69.0, 72.0, 67.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.8}], "name": "kraken", "value": 1515.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.0709805216243], "unit": "score", "name": "Richards", "value": 213.85951599999999}, {"lowerIsBetter": false, "replicates": [188.43037497644622], "unit": "score", "name": "DeltaBlue", "value": 350.8882260000001}, {"lowerIsBetter": false, "replicates": [279.72027972027973], "unit": "score", "name": "Encrypt", "value": 951.5970750000004}, {"lowerIsBetter": false, "replicates": [5296.2962962962965], "unit": "score", "name": "Decrypt", "value": 50.25795104895107}, {"lowerIsBetter": false, "replicates": [1066.0980810234541], "unit": "score", "name": "RayTrace", "value": 694.109682}, {"lowerIsBetter": false, "replicates": [715.0], "unit": "score", "name": "Earley", "value": 932.1160839160838}, {"lowerIsBetter": false, "replicates": [12345.67901234568], "unit": "score", "name": "Boyer", "value": 53.98350299999995}, {"lowerIsBetter": false, "replicates": [24780.48780487805], "unit": "score", "name": "RegExp", "value": 36.7621899606299}, {"lowerIsBetter": false, "replicates": [563.4831460674158], "unit": "score", "name": "Splay", "value": 144.62011964107674}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 21513.48907060048}]} 17:10:57 INFO - RETURN: dromaeo_css: 6936.51 17:10:57 INFO - RETURN: kraken: 1515.60 17:10:57 INFO - RETURN: v8_7: 21513.49 17:10:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21513.49"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1515.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6936.51"}}} 17:10:57 INFO - Return code: 0 17:10:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:10:57 INFO - # TBPL SUCCESS # 17:10:57 INFO - Running post-action listener: _resource_record_post_action 17:10:57 INFO - Running post-run listener: _resource_record_post_run 17:10:58 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 10420224; Write bytes: 401301504; Read time: 3744; Write time: 397012 17:10:58 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 5816320; Read time: 0; Write time: 752 17:10:58 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 8658944; Write bytes: 309874688; Read time: 3480; Write time: 309196 17:10:58 INFO - Running post-run listener: _upload_blobber_files 17:10:58 INFO - Blob upload gear active. 17:10:58 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 17:10:58 INFO - Copying logs to upload dir... 17:10:58 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1271.527500 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-16 17:10:58.442478) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 17:10:58.445911) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1450313244.823337-530355925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009837 build_url: 'https://queue.taskcluster.net/v1/task/8CL7JG91RuinZPq9IQrkGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.07 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 17:10:58.525535) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 17:10:58.525953) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1450313244.823337-530355925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004413 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 17:10:58.543082) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 17:10:58.543558) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 17:10:58.544022) ========= ========= Total master_lag: 0.25 =========