builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1458325581.92 results: success (0) buildid: 20160318083055 builduid: 2e2430915cf14435ba89565894f38185 revision: 16654149f9a1c32cf75b15549d2505d3b08c4a26 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 11:26:21.921649) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 11:26:21.922177) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-18 11:26:21.922555) ========= 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=836cfdc75598d54cb747368e000001a9-1458325581.122532-384308191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005446 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-18 11:26:21.941984) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-18 11:26:21.942328) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-18 11:26:21.953105) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 11:26:21.953435) ========= 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=836cfdc75598d54cb747368e000001a9-1458325581.122532-384308191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004618 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 11:26:22.002127) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 11:26:22.002474) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 11:26:22.002904) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 11:26:22.003241) ========= 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=836cfdc75598d54cb747368e000001a9-1458325581.122532-384308191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-18 11:26:22-- 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% 218M=0s 2016-03-18 11:26:22 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100715 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 11:26:22.118032) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 11:26:22.118417) ========= 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=836cfdc75598d54cb747368e000001a9-1458325581.122532-384308191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019474 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 11:26:22.168156) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 11:26:22.168556) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 16654149f9a1c32cf75b15549d2505d3b08c4a26 --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 16654149f9a1c32cf75b15549d2505d3b08c4a26 --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=836cfdc75598d54cb747368e000001a9-1458325581.122532-384308191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-18 11:26:22,312 truncating revision to first 12 chars 2016-03-18 11:26:22,312 Setting DEBUG logging. 2016-03-18 11:26:22,312 attempt 1/10 2016-03-18 11:26:22,312 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/16654149f9a1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-18 11:26:22,564 unpacking tar archive at: fx-team-16654149f9a1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.546723 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 11:26:22.728992) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 11:26:22.729431) ========= echo 16654149f9a1c32cf75b15549d2505d3b08c4a26 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'16654149f9a1c32cf75b15549d2505d3b08c4a26'] 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=836cfdc75598d54cb747368e000001a9-1458325581.122532-384308191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16654149f9a1c32cf75b15549d2505d3b08c4a26 program finished with exit code 0 elapsedTime=0.003774 script_repo_revision: '16654149f9a1c32cf75b15549d2505d3b08c4a26' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 11:26:22.779073) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 11:26:22.779421) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 11:26:22.789369) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-03-18 11:26:22.789682) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1458325581.122532-384308191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:26:23 INFO - MultiFileLogger online at 20160318 11:26:23 in /builds/slave/test-pgo 11:26:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:26:23 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:26:23 INFO - {'append_to_log': False, 11:26:23 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:26:23 INFO - 'blob_upload_branch': 'Fx-Team', 11:26:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:26:23 INFO - 'branch': 'Fx-Team', 11:26:23 INFO - 'buildbot_json_path': 'buildprops.json', 11:26:23 INFO - 'config_files': ('talos/linux_config.py',), 11:26:23 INFO - 'default_actions': ('clobber', 11:26:23 INFO - 'read-buildbot-config', 11:26:23 INFO - 'download-and-extract', 11:26:23 INFO - 'populate-webroot', 11:26:23 INFO - 'create-virtualenv', 11:26:23 INFO - 'install', 11:26:23 INFO - 'run-tests'), 11:26:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:26:23 INFO - 'download_minidump_stackwalk': True, 11:26:23 INFO - 'download_symbols': 'ondemand', 11:26:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:26:23 INFO - 'tooltool.py': '/tools/tooltool.py', 11:26:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:26:23 INFO - '/tools/misc-python/virtualenv.py')}, 11:26:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:26:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:26:23 INFO - 'installer_path': 'installer.exe', 11:26:23 INFO - 'log_level': 'info', 11:26:23 INFO - 'log_name': 'talos', 11:26:23 INFO - 'log_to_console': True, 11:26:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:26:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:26:23 INFO - 'opt_config_files': (), 11:26:23 INFO - 'pip_index': False, 11:26:23 INFO - 'sps_profile': False, 11:26:23 INFO - 'sps_profile_interval': 0, 11:26:23 INFO - 'suite': 'dromaeojs', 11:26:23 INFO - 'system_bits': '32', 11:26:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:26:23 INFO - 'title': 'talos-linux64-ix-028', 11:26:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:26:23 INFO - 'use_talos_json': True, 11:26:23 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:26:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:26:23 INFO - 'work_dir': 'build'} 11:26:23 INFO - ##### 11:26:23 INFO - ##### Running clobber step. 11:26:23 INFO - ##### 11:26:23 INFO - Running pre-action listener: _resource_record_pre_action 11:26:23 INFO - Running main action method: clobber 11:26:23 INFO - rmtree: /builds/slave/test-pgo/build 11:26:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:26:23 INFO - Running post-action listener: _resource_record_post_action 11:26:23 INFO - ##### 11:26:23 INFO - ##### Running read-buildbot-config step. 11:26:23 INFO - ##### 11:26:23 INFO - Running pre-action listener: _resource_record_pre_action 11:26:23 INFO - Running main action method: read_buildbot_config 11:26:23 INFO - Using buildbot properties: 11:26:23 INFO - { 11:26:23 INFO - "project": "", 11:26:23 INFO - "product": "firefox", 11:26:23 INFO - "script_repo_revision": "production", 11:26:23 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:26:23 INFO - "repository": "", 11:26:23 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:26:23 INFO - "buildid": "20160318083055", 11:26:23 INFO - "pgo_build": "True", 11:26:23 INFO - "basedir": "/builds/slave/test-pgo", 11:26:23 INFO - "buildnumber": 728, 11:26:23 INFO - "slavename": "talos-linux64-ix-028", 11:26:23 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:26:23 INFO - "platform": "ubuntu64_hw", 11:26:23 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:26:23 INFO - "branch": "fx-team", 11:26:23 INFO - "repo_path": "integration/fx-team", 11:26:23 INFO - "revision": "16654149f9a1c32cf75b15549d2505d3b08c4a26", 11:26:23 INFO - "stage_platform": "linux64-pgo", 11:26:23 INFO - "builduid": "2e2430915cf14435ba89565894f38185", 11:26:23 INFO - "slavebuilddir": "test" 11:26:23 INFO - } 11:26:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/f8otThnQTHO9EXEy3jXN6w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 11:26:23 INFO - Running post-action listener: _resource_record_post_action 11:26:23 INFO - ##### 11:26:23 INFO - ##### Running download-and-extract step. 11:26:23 INFO - ##### 11:26:23 INFO - Running pre-action listener: _resource_record_pre_action 11:26:23 INFO - Running main action method: download_and_extract 11:26:23 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:23 INFO - https://queue.taskcluster.net/v1/task/f8otThnQTHO9EXEy3jXN6w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:26:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8otThnQTHO9EXEy3jXN6w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:26:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8otThnQTHO9EXEy3jXN6w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:26:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8otThnQTHO9EXEy3jXN6w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:26:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8otThnQTHO9EXEy3jXN6w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:26:24 INFO - Downloaded 1361 bytes. 11:26:24 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:26:24 INFO - Using the following test package requirements: 11:26:24 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:26:24 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:26:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:26:24 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:26:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:26:24 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:26:24 INFO - u'jsshell-linux-x86_64.zip'], 11:26:24 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:26:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:26:24 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:26:24 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:26:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:26:24 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:26:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:26:24 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:26:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:26:24 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:26:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:26:24 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:26: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')]} 11:26:24 INFO - https://queue.taskcluster.net/v1/task/f8otThnQTHO9EXEy3jXN6w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:26:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8otThnQTHO9EXEy3jXN6w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:26:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8otThnQTHO9EXEy3jXN6w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:26:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8otThnQTHO9EXEy3jXN6w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:26:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8otThnQTHO9EXEy3jXN6w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:26:25 INFO - Downloaded 23579895 bytes. 11:26:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 11:26:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 11:26:26 INFO - Return code: 0 11:26:26 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:26:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:26 INFO - https://queue.taskcluster.net/v1/task/f8otThnQTHO9EXEy3jXN6w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:26:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8otThnQTHO9EXEy3jXN6w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:26:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8otThnQTHO9EXEy3jXN6w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:26:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8otThnQTHO9EXEy3jXN6w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:26:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8otThnQTHO9EXEy3jXN6w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:26:27 INFO - Downloaded 23579895 bytes. 11:26:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 11:26:27 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 11:26:29 INFO - Return code: 0 11:26:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:29 INFO - https://queue.taskcluster.net/v1/task/f8otThnQTHO9EXEy3jXN6w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:26:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8otThnQTHO9EXEy3jXN6w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:26:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8otThnQTHO9EXEy3jXN6w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:26:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8otThnQTHO9EXEy3jXN6w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:26:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8otThnQTHO9EXEy3jXN6w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:26:30 INFO - Downloaded 10846565 bytes. 11:26:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 11:26:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 11:26:30 INFO - Return code: 0 11:26:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:30 INFO - https://queue.taskcluster.net/v1/task/f8otThnQTHO9EXEy3jXN6w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:26:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8otThnQTHO9EXEy3jXN6w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:26:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8otThnQTHO9EXEy3jXN6w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:26:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8otThnQTHO9EXEy3jXN6w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:26:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f8otThnQTHO9EXEy3jXN6w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:26:31 INFO - Downloaded 57682601 bytes. 11:26:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f8otThnQTHO9EXEy3jXN6w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:26:31 INFO - mkdir: /builds/slave/test-pgo/properties 11:26:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:26:31 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:26:31 INFO - Contents: 11:26:31 INFO - build_url:https://queue.taskcluster.net/v1/task/f8otThnQTHO9EXEy3jXN6w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:26:32 INFO - Running post-action listener: _resource_record_post_action 11:26:32 INFO - Running post-action listener: set_extra_try_arguments 11:26:32 INFO - ##### 11:26:32 INFO - ##### Running populate-webroot step. 11:26:32 INFO - ##### 11:26:32 INFO - Running pre-action listener: _resource_record_pre_action 11:26:32 INFO - Running main action method: populate_webroot 11:26:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:26:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:26:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:26:32 INFO - '--tppagecycles', 11:26:32 INFO - '7'], 11:26:32 INFO - 'tests': ['tsvgm']}}, 11:26:32 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:26:32 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:26:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:26:32 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:26:32 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:26:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:26:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:26:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:32 INFO - 'talos_options': ['--e10s'], 11:26:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:26:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:32 INFO - 'tests': ['damp', 'tps']}, 11:26:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:32 INFO - 'talos_options': ['--e10s'], 11:26:32 INFO - 'tests': ['damp', 'tps']}, 11:26:32 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:26:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:26:32 INFO - 'other': {'tests': ['a11yr', 11:26:32 INFO - 'ts_paint', 11:26:32 INFO - 'tpaint', 11:26:32 INFO - 'sessionrestore', 11:26:32 INFO - 'sessionrestore_no_auto_restore', 11:26:32 INFO - 'tabpaint']}, 11:26:32 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:26:32 INFO - 'tests': ['a11yr', 11:26:32 INFO - 'ts_paint', 11:26:32 INFO - 'tpaint', 11:26:32 INFO - 'sessionrestore', 11:26:32 INFO - 'sessionrestore_no_auto_restore', 11:26:32 INFO - 'tabpaint']}, 11:26:32 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:26:32 INFO - 'tests': ['a11yr', 11:26:32 INFO - 'ts_paint', 11:26:32 INFO - 'tpaint', 11:26:32 INFO - 'sessionrestore', 11:26:32 INFO - 'sessionrestore_no_auto_restore', 11:26:32 INFO - 'tabpaint']}, 11:26:32 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:26:32 INFO - 'tests': ['a11yr', 11:26:32 INFO - 'ts_paint', 11:26:32 INFO - 'tpaint', 11:26:32 INFO - 'sessionrestore', 11:26:32 INFO - 'sessionrestore_no_auto_restore', 11:26:32 INFO - 'tabpaint']}, 11:26:32 INFO - 'other_l64': {'tests': ['a11yr', 11:26:32 INFO - 'ts_paint', 11:26:32 INFO - 'tpaint', 11:26:32 INFO - 'sessionrestore', 11:26:32 INFO - 'sessionrestore_no_auto_restore', 11:26:32 INFO - 'tabpaint']}, 11:26:32 INFO - 'other_nol64': {'tests': ['a11yr', 11:26:32 INFO - 'ts_paint', 11:26:32 INFO - 'tpaint', 11:26:32 INFO - 'sessionrestore', 11:26:32 INFO - 'sessionrestore_no_auto_restore', 11:26:32 INFO - 'tabpaint']}, 11:26:32 INFO - 'svgr': {'tests': ['tsvgx', 11:26:32 INFO - 'tsvgr_opacity', 11:26:32 INFO - 'tart', 11:26:32 INFO - 'tscrollx', 11:26:32 INFO - 'cart']}, 11:26:32 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:26:32 INFO - 'tests': ['tsvgx', 11:26:32 INFO - 'tsvgr_opacity', 11:26:32 INFO - 'tart', 11:26:32 INFO - 'tscrollx', 11:26:32 INFO - 'cart']}, 11:26:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:32 INFO - 'tests': ['tp5o']}, 11:26:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:32 INFO - 'talos_options': ['--e10s'], 11:26:32 INFO - 'tests': ['tp5o']}, 11:26:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:32 INFO - 'talos_options': ['--xperf_path', 11:26:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:26:32 INFO - 'tests': ['tp5n']}, 11:26:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:32 INFO - 'talos_options': ['--e10s', 11:26:32 INFO - '--xperf_path', 11:26:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:26:32 INFO - 'tests': ['tp5n']}}, 11:26:32 INFO - 'talos.zip': {'path': '', 11:26:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:26:32 INFO - Running post-action listener: _resource_record_post_action 11:26:32 INFO - ##### 11:26:32 INFO - ##### Running create-virtualenv step. 11:26:32 INFO - ##### 11:26:32 INFO - Running pre-action listener: _resource_record_pre_action 11:26:32 INFO - Running main action method: create_virtualenv 11:26:32 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:26:32 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 11:26:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:26:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:26:32 INFO - Using real prefix '/usr' 11:26:32 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:26:33 INFO - Installing distribute.............................................................................................................................................................................................done. 11:26:35 INFO - Installing pip.................done. 11:26:35 INFO - Return code: 0 11:26:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:26:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:35 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f21ef442f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc16b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbc1d0>, '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 0x1dbf750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbfbe0>, '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': '836cfdc75598d54cb747368e000001a9-1458325581.122532-384308191', '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 11:26:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 11:26:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 11:26:35 INFO - Using env: {'DISPLAY': ':0', 11:26:35 INFO - 'HOME': '/home/cltbld', 11:26:35 INFO - 'LANG': 'en_US.UTF-8', 11:26:35 INFO - 'LANGUAGE': 'en_US:en', 11:26:35 INFO - 'LOGNAME': 'cltbld', 11:26:35 INFO - 'MAIL': '/var/mail/cltbld', 11:26:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:35 INFO - 'MOZ_NO_REMOTE': '1', 11:26:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:35 INFO - 'NO_EM_RESTART': '1', 11:26:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:26:35 INFO - 'PWD': '/builds/slave/test-pgo', 11:26:35 INFO - 'SHELL': '/bin/bash', 11:26:35 INFO - 'SHLVL': '1', 11:26:35 INFO - 'TERM': 'linux', 11:26:35 INFO - 'TMOUT': '86400', 11:26:35 INFO - 'USER': 'cltbld', 11:26:35 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1458325581.122532-384308191', 11:26:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:35 INFO - '_': '/tools/buildbot/bin/python'} 11:26:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:35 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:26:35 INFO - Cleaning up... 11:26:35 INFO - Return code: 0 11:26:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:26:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:35 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f21ef442f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc16b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbc1d0>, '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 0x1dbf750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbfbe0>, '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': '836cfdc75598d54cb747368e000001a9-1458325581.122532-384308191', '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 11:26:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 11:26:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 11:26:35 INFO - Using env: {'DISPLAY': ':0', 11:26:35 INFO - 'HOME': '/home/cltbld', 11:26:35 INFO - 'LANG': 'en_US.UTF-8', 11:26:35 INFO - 'LANGUAGE': 'en_US:en', 11:26:35 INFO - 'LOGNAME': 'cltbld', 11:26:35 INFO - 'MAIL': '/var/mail/cltbld', 11:26:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:35 INFO - 'MOZ_NO_REMOTE': '1', 11:26:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:35 INFO - 'NO_EM_RESTART': '1', 11:26:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:26:35 INFO - 'PWD': '/builds/slave/test-pgo', 11:26:35 INFO - 'SHELL': '/bin/bash', 11:26:35 INFO - 'SHLVL': '1', 11:26:35 INFO - 'TERM': 'linux', 11:26:35 INFO - 'TMOUT': '86400', 11:26:35 INFO - 'USER': 'cltbld', 11:26:35 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1458325581.122532-384308191', 11:26:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:35 INFO - '_': '/tools/buildbot/bin/python'} 11:26:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:35 INFO - Downloading/unpacking psutil>=0.7.1 11:26:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:26:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:26:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:26:37 INFO - Installing collected packages: psutil 11:26:37 INFO - Running setup.py install for psutil 11:26:37 INFO - building 'psutil._psutil_linux' extension 11:26:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:26:37 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 11:26:37 INFO - building 'psutil._psutil_posix' extension 11:26:37 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 11:26:37 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 11:26:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:26:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:26:37 INFO - Successfully installed psutil 11:26:37 INFO - Cleaning up... 11:26:37 INFO - Return code: 0 11:26:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:37 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f21ef442f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc16b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbc1d0>, '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 0x1dbf750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbfbe0>, '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': '836cfdc75598d54cb747368e000001a9-1458325581.122532-384308191', '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 11:26:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 11:26:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 11:26:37 INFO - Using env: {'DISPLAY': ':0', 11:26:37 INFO - 'HOME': '/home/cltbld', 11:26:37 INFO - 'LANG': 'en_US.UTF-8', 11:26:37 INFO - 'LANGUAGE': 'en_US:en', 11:26:37 INFO - 'LOGNAME': 'cltbld', 11:26:37 INFO - 'MAIL': '/var/mail/cltbld', 11:26:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:37 INFO - 'MOZ_NO_REMOTE': '1', 11:26:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:37 INFO - 'NO_EM_RESTART': '1', 11:26:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:26:37 INFO - 'PWD': '/builds/slave/test-pgo', 11:26:37 INFO - 'SHELL': '/bin/bash', 11:26:37 INFO - 'SHLVL': '1', 11:26:37 INFO - 'TERM': 'linux', 11:26:37 INFO - 'TMOUT': '86400', 11:26:37 INFO - 'USER': 'cltbld', 11:26:37 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1458325581.122532-384308191', 11:26:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:37 INFO - '_': '/tools/buildbot/bin/python'} 11:26:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:26:38 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 11:26:38 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 11:26:38 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 11:26:38 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 11:26:38 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 11:26:38 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 11:26:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:26:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:26:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:26:40 INFO - Installing collected packages: mozsystemmonitor 11:26:40 INFO - Running setup.py install for mozsystemmonitor 11:26:40 INFO - Successfully installed mozsystemmonitor 11:26:40 INFO - Cleaning up... 11:26:40 INFO - Return code: 0 11:26:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:26:40 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')]} 11:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:40 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')]} 11:26:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f21ef442f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc16b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbc1d0>, '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 0x1dbf750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbfbe0>, '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': '836cfdc75598d54cb747368e000001a9-1458325581.122532-384308191', '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 11:26:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 11:26:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 11:26:40 INFO - Using env: {'DISPLAY': ':0', 11:26:40 INFO - 'HOME': '/home/cltbld', 11:26:40 INFO - 'LANG': 'en_US.UTF-8', 11:26:40 INFO - 'LANGUAGE': 'en_US:en', 11:26:40 INFO - 'LOGNAME': 'cltbld', 11:26:40 INFO - 'MAIL': '/var/mail/cltbld', 11:26:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:40 INFO - 'MOZ_NO_REMOTE': '1', 11:26:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:40 INFO - 'NO_EM_RESTART': '1', 11:26:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:26:40 INFO - 'PWD': '/builds/slave/test-pgo', 11:26:40 INFO - 'SHELL': '/bin/bash', 11:26:40 INFO - 'SHLVL': '1', 11:26:40 INFO - 'TERM': 'linux', 11:26:40 INFO - 'TMOUT': '86400', 11:26:40 INFO - 'USER': 'cltbld', 11:26:40 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1458325581.122532-384308191', 11:26:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:40 INFO - '_': '/tools/buildbot/bin/python'} 11:26:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:40 INFO - Downloading/unpacking blobuploader==1.2.4 11:26:40 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 11:26:40 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 11:26:40 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 11:26:40 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 11:26:40 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 11:26:40 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 11:26:42 INFO - Downloading blobuploader-1.2.4.tar.gz 11:26:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:26:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:26:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:26:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:26:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:42 INFO - Downloading docopt-0.6.1.tar.gz 11:26:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:26:43 INFO - Installing collected packages: blobuploader, requests, docopt 11:26:43 INFO - Running setup.py install for blobuploader 11:26:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:26:43 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:26:43 INFO - Running setup.py install for requests 11:26:43 INFO - Running setup.py install for docopt 11:26:43 INFO - Successfully installed blobuploader requests docopt 11:26:43 INFO - Cleaning up... 11:26:43 INFO - Return code: 0 11:26:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:26:43 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')]} 11:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:43 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')]} 11:26:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7f21ef442f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc16b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbc1d0>, '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 0x1dbf750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbfbe0>, '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': '836cfdc75598d54cb747368e000001a9-1458325581.122532-384308191', '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 11:26:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 11:26:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --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 11:26:43 INFO - Using env: {'DISPLAY': ':0', 11:26:43 INFO - 'HOME': '/home/cltbld', 11:26:43 INFO - 'LANG': 'en_US.UTF-8', 11:26:43 INFO - 'LANGUAGE': 'en_US:en', 11:26:43 INFO - 'LOGNAME': 'cltbld', 11:26:43 INFO - 'MAIL': '/var/mail/cltbld', 11:26:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:43 INFO - 'MOZ_NO_REMOTE': '1', 11:26:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:43 INFO - 'NO_EM_RESTART': '1', 11:26:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:26:43 INFO - 'PWD': '/builds/slave/test-pgo', 11:26:43 INFO - 'SHELL': '/bin/bash', 11:26:43 INFO - 'SHLVL': '1', 11:26:43 INFO - 'TERM': 'linux', 11:26:43 INFO - 'TMOUT': '86400', 11:26:43 INFO - 'USER': 'cltbld', 11:26:43 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1458325581.122532-384308191', 11:26:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:43 INFO - '_': '/tools/buildbot/bin/python'} 11:26:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:26:43 INFO - Running setup.py (path:/tmp/pip-mUzANC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:26:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:26:43 INFO - Running setup.py (path:/tmp/pip-Q8AQRE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:26:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:26:43 INFO - Running setup.py (path:/tmp/pip-mvLJBQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:26:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:26:44 INFO - Running setup.py (path:/tmp/pip-ac2mEW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:26:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:26:44 INFO - Running setup.py (path:/tmp/pip-n1AsvV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:26:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:26:44 INFO - Running setup.py (path:/tmp/pip-0fH1j2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:26:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:26:44 INFO - Running setup.py (path:/tmp/pip-11go93-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:26:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:26:44 INFO - Running setup.py (path:/tmp/pip-TEM5pL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:26:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:26:44 INFO - Running setup.py (path:/tmp/pip-b5SQcI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:26:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:26:44 INFO - Running setup.py (path:/tmp/pip-joIuyR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:26:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:26:44 INFO - Running setup.py (path:/tmp/pip-sAtkEN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:26:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:26:44 INFO - Running setup.py (path:/tmp/pip-Qum0F9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:26:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:26:44 INFO - Running setup.py (path:/tmp/pip-vyGPtV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:26:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:26:44 INFO - Running setup.py (path:/tmp/pip-tr91V9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:26:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:26:44 INFO - Running setup.py (path:/tmp/pip-prSLUq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:26:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:26:44 INFO - Running setup.py (path:/tmp/pip-5F_fOv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:26:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:26:44 INFO - Running setup.py (path:/tmp/pip-gF0Phj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:26:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:26:45 INFO - Running setup.py install for manifestparser 11:26:45 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:26:45 INFO - Running setup.py install for mozcrash 11:26:45 INFO - Running setup.py install for mozdebug 11:26:45 INFO - Running setup.py install for mozdevice 11:26:45 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:26:45 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:26:45 INFO - Running setup.py install for mozfile 11:26:45 INFO - Running setup.py install for mozhttpd 11:26:45 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:26:45 INFO - Running setup.py install for mozinfo 11:26:45 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:26:45 INFO - Running setup.py install for mozInstall 11:26:45 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:26:45 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:26:45 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:26:45 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:26:45 INFO - Running setup.py install for mozleak 11:26:45 INFO - Running setup.py install for mozlog 11:26:46 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:26:46 INFO - Running setup.py install for moznetwork 11:26:46 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:26:46 INFO - Running setup.py install for mozprocess 11:26:46 INFO - Running setup.py install for mozprofile 11:26:46 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:26:46 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:26:46 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:26:46 INFO - Running setup.py install for mozrunner 11:26:46 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:26:46 INFO - Running setup.py install for mozscreenshot 11:26:46 INFO - Running setup.py install for moztest 11:26:46 INFO - Running setup.py install for mozversion 11:26:46 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:26:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:26:46 INFO - Cleaning up... 11:26:46 INFO - Return code: 0 11:26:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f21ef442f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc16b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbc1d0>, '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 0x1dbf750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbfbe0>, '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': '836cfdc75598d54cb747368e000001a9-1458325581.122532-384308191', '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 11:26:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 11:26:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 11:26:46 INFO - Using env: {'DISPLAY': ':0', 11:26:46 INFO - 'HOME': '/home/cltbld', 11:26:46 INFO - 'LANG': 'en_US.UTF-8', 11:26:46 INFO - 'LANGUAGE': 'en_US:en', 11:26:46 INFO - 'LOGNAME': 'cltbld', 11:26:46 INFO - 'MAIL': '/var/mail/cltbld', 11:26:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:46 INFO - 'MOZ_NO_REMOTE': '1', 11:26:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:46 INFO - 'NO_EM_RESTART': '1', 11:26:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:26:46 INFO - 'PWD': '/builds/slave/test-pgo', 11:26:46 INFO - 'SHELL': '/bin/bash', 11:26:46 INFO - 'SHLVL': '1', 11:26:46 INFO - 'TERM': 'linux', 11:26:46 INFO - 'TMOUT': '86400', 11:26:46 INFO - 'USER': 'cltbld', 11:26:46 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1458325581.122532-384308191', 11:26:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:46 INFO - '_': '/tools/buildbot/bin/python'} 11:26:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:26:47 INFO - Running setup.py (path:/tmp/pip-3ipJSL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:26:47 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)) 11:26:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:26:47 INFO - Running setup.py (path:/tmp/pip-4WrTxN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:26:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 11:26:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:26:47 INFO - Running setup.py (path:/tmp/pip-LY9y9R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:26:47 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)) 11:26:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:26:47 INFO - Running setup.py (path:/tmp/pip-302num-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:26:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:26:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:26:47 INFO - Running setup.py (path:/tmp/pip-XQtXyk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:26:47 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)) 11:26:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:26:47 INFO - Running setup.py (path:/tmp/pip-Sf9AqM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:26:47 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)) 11:26:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:26:47 INFO - Running setup.py (path:/tmp/pip-q9_Zsg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:26:47 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)) 11:26:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:26:47 INFO - Running setup.py (path:/tmp/pip-wTUxcL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:26:47 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)) 11:26:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:26:47 INFO - Running setup.py (path:/tmp/pip-UwsmXm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:26:47 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)) 11:26:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:26:47 INFO - Running setup.py (path:/tmp/pip-yvkKf_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:26:47 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)) 11:26:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:26:47 INFO - Running setup.py (path:/tmp/pip-TgPXat-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:26:47 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)) 11:26:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:26:47 INFO - Running setup.py (path:/tmp/pip-kv0cuW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:26:47 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)) 11:26:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:26:47 INFO - Running setup.py (path:/tmp/pip-ECPZBZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:26:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 11:26:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:26:48 INFO - Running setup.py (path:/tmp/pip-aSEcl7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:26:48 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)) 11:26:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:26:48 INFO - Running setup.py (path:/tmp/pip-kqwRQL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:26:48 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)) 11:26:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:26:48 INFO - Running setup.py (path:/tmp/pip-8uIoFb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:26:48 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)) 11:26:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:26:48 INFO - Running setup.py (path:/tmp/pip-sQwm65-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:26:48 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)) 11:26:48 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 11:26:48 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 11:26:48 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)) 11:26:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:26:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:26:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:26:48 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 11:26:48 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 11:26:48 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 11:26:48 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 11:26:48 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 11:26:48 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 11:26:50 INFO - Downloading blessings-1.6.tar.gz 11:26:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:26:50 INFO - Installing collected packages: blessings 11:26:50 INFO - Running setup.py install for blessings 11:26:50 INFO - Successfully installed blessings 11:26:50 INFO - Cleaning up... 11:26:50 INFO - Return code: 0 11:26:50 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:26:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:26:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:26:50 INFO - Reading from file tmpfile_stdout 11:26:50 INFO - Current package versions: 11:26:50 INFO - argparse == 1.2.1 11:26:50 INFO - blessings == 1.6 11:26:50 INFO - blobuploader == 1.2.4 11:26:50 INFO - docopt == 0.6.1 11:26:50 INFO - manifestparser == 1.1 11:26:50 INFO - mozInstall == 1.12 11:26:50 INFO - mozcrash == 0.17 11:26:50 INFO - mozdebug == 0.1 11:26:50 INFO - mozdevice == 0.48 11:26:50 INFO - mozfile == 1.2 11:26:50 INFO - mozhttpd == 0.7 11:26:50 INFO - mozinfo == 0.9 11:26:50 INFO - mozleak == 0.1 11:26:50 INFO - mozlog == 3.1 11:26:50 INFO - moznetwork == 0.27 11:26:50 INFO - mozprocess == 0.22 11:26:50 INFO - mozprofile == 0.28 11:26:50 INFO - mozrunner == 6.11 11:26:50 INFO - mozscreenshot == 0.1 11:26:50 INFO - mozsystemmonitor == 0.0 11:26:50 INFO - moztest == 0.7 11:26:50 INFO - mozversion == 1.4 11:26:50 INFO - psutil == 3.1.1 11:26:50 INFO - requests == 1.2.3 11:26:50 INFO - wsgiref == 0.1.2 11:26:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:26:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f21ef442f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc16b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbc1d0>, '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 0x1dbf750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbfbe0>, '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': '836cfdc75598d54cb747368e000001a9-1458325581.122532-384308191', '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 11:26:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 11:26:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 11:26:50 INFO - Using env: {'DISPLAY': ':0', 11:26:50 INFO - 'HOME': '/home/cltbld', 11:26:50 INFO - 'LANG': 'en_US.UTF-8', 11:26:50 INFO - 'LANGUAGE': 'en_US:en', 11:26:50 INFO - 'LOGNAME': 'cltbld', 11:26:50 INFO - 'MAIL': '/var/mail/cltbld', 11:26:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:50 INFO - 'MOZ_NO_REMOTE': '1', 11:26:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:50 INFO - 'NO_EM_RESTART': '1', 11:26:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:26:50 INFO - 'PWD': '/builds/slave/test-pgo', 11:26:50 INFO - 'SHELL': '/bin/bash', 11:26:50 INFO - 'SHLVL': '1', 11:26:50 INFO - 'TERM': 'linux', 11:26:50 INFO - 'TMOUT': '86400', 11:26:50 INFO - 'USER': 'cltbld', 11:26:50 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1458325581.122532-384308191', 11:26:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:50 INFO - '_': '/tools/buildbot/bin/python'} 11:26:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 11:26:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 11:26:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 11:26:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 11:26:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 11:26:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 11:26:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 11:26:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 11:26:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 11:26:50 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 11:26:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 11:26:50 INFO - Cleaning up... 11:26:50 INFO - Return code: 0 11:26:50 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:26:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f21ef442f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc16b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbc1d0>, '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 0x1dbf750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbfbe0>, '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': '836cfdc75598d54cb747368e000001a9-1458325581.122532-384308191', '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 11:26:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 11:26:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 11:26:50 INFO - Using env: {'DISPLAY': ':0', 11:26:50 INFO - 'HOME': '/home/cltbld', 11:26:50 INFO - 'LANG': 'en_US.UTF-8', 11:26:50 INFO - 'LANGUAGE': 'en_US:en', 11:26:50 INFO - 'LOGNAME': 'cltbld', 11:26:50 INFO - 'MAIL': '/var/mail/cltbld', 11:26:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:50 INFO - 'MOZ_NO_REMOTE': '1', 11:26:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:50 INFO - 'NO_EM_RESTART': '1', 11:26:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:26:50 INFO - 'PWD': '/builds/slave/test-pgo', 11:26:50 INFO - 'SHELL': '/bin/bash', 11:26:50 INFO - 'SHLVL': '1', 11:26:50 INFO - 'TERM': 'linux', 11:26:50 INFO - 'TMOUT': '86400', 11:26:50 INFO - 'USER': 'cltbld', 11:26:50 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1458325581.122532-384308191', 11:26:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:50 INFO - '_': '/tools/buildbot/bin/python'} 11:26:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:51 INFO - Downloading/unpacking jsonschema 11:26:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:26:52 INFO - Downloading/unpacking functools32 (from jsonschema) 11:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:53 INFO - Downloading functools32-3.2.3-2.tar.gz 11:26:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:26:53 INFO - warning: no files found matching '*.txt' 11:26:53 INFO - no previously-included directories found matching 'build' 11:26:53 INFO - no previously-included directories found matching 'dist' 11:26:53 INFO - no previously-included directories found matching '.git*' 11:26:53 INFO - Installing collected packages: jsonschema, functools32 11:26:53 INFO - Running setup.py install for functools32 11:26:53 INFO - warning: no files found matching '*.txt' 11:26:53 INFO - no previously-included directories found matching 'build' 11:26:53 INFO - no previously-included directories found matching 'dist' 11:26:53 INFO - no previously-included directories found matching '.git*' 11:26:53 INFO - Successfully installed jsonschema functools32 11:26:53 INFO - Cleaning up... 11:26:53 INFO - Return code: 0 11:26:53 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:26:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f21ef442f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc16b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbc1d0>, '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 0x1dbf750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbfbe0>, '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': '836cfdc75598d54cb747368e000001a9-1458325581.122532-384308191', '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 11:26:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 11:26:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 11:26:53 INFO - Using env: {'DISPLAY': ':0', 11:26:53 INFO - 'HOME': '/home/cltbld', 11:26:53 INFO - 'LANG': 'en_US.UTF-8', 11:26:53 INFO - 'LANGUAGE': 'en_US:en', 11:26:53 INFO - 'LOGNAME': 'cltbld', 11:26:53 INFO - 'MAIL': '/var/mail/cltbld', 11:26:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:53 INFO - 'MOZ_NO_REMOTE': '1', 11:26:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:53 INFO - 'NO_EM_RESTART': '1', 11:26:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:26:53 INFO - 'PWD': '/builds/slave/test-pgo', 11:26:53 INFO - 'SHELL': '/bin/bash', 11:26:53 INFO - 'SHLVL': '1', 11:26:53 INFO - 'TERM': 'linux', 11:26:53 INFO - 'TMOUT': '86400', 11:26:53 INFO - 'USER': 'cltbld', 11:26:53 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1458325581.122532-384308191', 11:26:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:53 INFO - '_': '/tools/buildbot/bin/python'} 11:26:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:53 INFO - Downloading/unpacking flake8 11:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:26:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:26:55 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 11:26:55 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 11:26:55 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 11:26:55 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 11:26:55 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 11:26:55 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 11:26:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:26:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:26:55 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 11:26:55 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 11:26:55 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 11:26:55 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 11:26:55 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 11:26:55 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 11:26:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:26:55 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 11:26:55 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 11:26:55 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 11:26:55 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 11:26:55 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 11:26:55 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 11:26:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:26:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:26:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:26:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:26:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:26:56 INFO - no previously-included directories found matching 'docs/_build' 11:26:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:26:56 INFO - Running setup.py install for pep8 11:26:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:26:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:26:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:26:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:26:56 INFO - no previously-included directories found matching 'docs/_build' 11:26:56 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:26:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:26:56 INFO - Cleaning up... 11:26:56 INFO - Return code: 0 11:26:56 INFO - Running post-action listener: _resource_record_post_action 11:26:56 INFO - Running post-action listener: _start_resource_monitoring 11:26:56 INFO - Starting resource monitoring. 11:26:56 INFO - ##### 11:26:56 INFO - ##### Running install step. 11:26:56 INFO - ##### 11:26:56 INFO - Running pre-action listener: _resource_record_pre_action 11:26:56 INFO - Running main action method: install 11:26:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:26:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:26:56 INFO - Reading from file tmpfile_stdout 11:26:56 INFO - Detecting whether we're running mozinstall >=1.0... 11:26:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:26:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:26:56 INFO - Reading from file tmpfile_stdout 11:26:56 INFO - Output received: 11:26:56 INFO - Usage: mozinstall [options] installer 11:26:56 INFO - Options: 11:26:56 INFO - -h, --help show this help message and exit 11:26:56 INFO - -d DEST, --destination=DEST 11:26:56 INFO - Directory to install application into. [default: 11:26:56 INFO - "/builds/slave/test-pgo"] 11:26:56 INFO - --app=APP Application being installed. [default: firefox] 11:26:56 INFO - mkdir: /builds/slave/test-pgo/build/application 11:26:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 11:26:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 11:27:13 INFO - Reading from file tmpfile_stdout 11:27:13 INFO - Output received: 11:27:13 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:27:13 INFO - Running post-action listener: _resource_record_post_action 11:27:13 INFO - ##### 11:27:13 INFO - ##### Running run-tests step. 11:27:13 INFO - ##### 11:27:13 INFO - Running pre-action listener: _resource_record_pre_action 11:27:13 INFO - Running main action method: run_tests 11:27:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:27:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:27:13 INFO - Python 2.7.3 11:27:13 INFO - Return code: 0 11:27:13 INFO - grabbing minidump binary from tooltool 11:27:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:13 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dbc1d0>, '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 0x1dbf750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbfbe0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:27:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 11:27:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:27:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:27:13 INFO - Return code: 0 11:27:13 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:27:13 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:27:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:27:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:27:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:27:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:27:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:27:14 INFO - Return code: 0 11:27:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f8otThnQTHO9EXEy3jXN6w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 11:27:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/f8otThnQTHO9EXEy3jXN6w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 11:27:14 INFO - Using env: {'DISPLAY': ':0', 11:27:14 INFO - 'HOME': '/home/cltbld', 11:27:14 INFO - 'LANG': 'en_US.UTF-8', 11:27:14 INFO - 'LANGUAGE': 'en_US:en', 11:27:14 INFO - 'LOGNAME': 'cltbld', 11:27:14 INFO - 'MAIL': '/var/mail/cltbld', 11:27:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:27:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:27:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:14 INFO - 'MOZ_NO_REMOTE': '1', 11:27:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:27:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:14 INFO - 'NO_EM_RESTART': '1', 11:27:14 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:27:14 INFO - 'PWD': '/builds/slave/test-pgo', 11:27:14 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:27:14 INFO - 'SHELL': '/bin/bash', 11:27:14 INFO - 'SHLVL': '1', 11:27:14 INFO - 'TERM': 'linux', 11:27:14 INFO - 'TMOUT': '86400', 11:27:14 INFO - 'USER': 'cltbld', 11:27:14 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1458325581.122532-384308191', 11:27:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:14 INFO - '_': '/tools/buildbot/bin/python'} 11:27:14 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f8otThnQTHO9EXEy3jXN6w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:27:14 INFO - mozversion application_buildid: 20160318083055 11:27:14 INFO - mozversion application_changeset: 16654149f9a1c32cf75b15549d2505d3b08c4a26 11:27:14 INFO - mozversion application_display_name: Nightly 11:27:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:27:14 INFO - mozversion application_name: Firefox 11:27:14 INFO - mozversion application_remotingname: firefox 11:27:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:27:14 INFO - mozversion application_vendor: Mozilla 11:27:14 INFO - mozversion application_version: 48.0a1 11:27:14 INFO - mozversion platform_buildid: 20160318083055 11:27:14 INFO - mozversion platform_changeset: 16654149f9a1c32cf75b15549d2505d3b08c4a26 11:27:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:27:14 INFO - mozversion platform_version: 48.0a1 11:27:14 INFO - using testdate: 1458325634 11:27:14 INFO - actual date: 1458325634 11:27:14 INFO - starting webserver on 'localhost:45822' 11:27:14 INFO - SUITE-START | Running 2 tests 11:27:14 INFO - TEST-START | dromaeo_css 11:27:14 INFO - operating with platform_type : linux_ 11:27:14 INFO - Initialising browser for dromaeo_css test... 11:27:14 INFO - TEST-INFO | started process 23759 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpl0WUJb/profile http://localhost:45822/getInfo.html) 11:27:19 INFO - PROCESS | 23759 | __metrics Screen width/height:1600/1200 11:27:19 INFO - PROCESS | 23759 | colorDepth:24 11:27:19 INFO - PROCESS | 23759 | Browser inner width/height: 1024/697 11:27:19 INFO - PROCESS | 23759 | __metrics 11:27:20 ERROR - PROCESS | 23759 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:27:20 INFO - PROCESS | 23759 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 11:27:20 INFO - TEST-INFO | 23759: exit 0 11:27:20 INFO - Browser initialized. 11:27:20 INFO - Running cycle 1/1 for dromaeo_css test... 11:27:20 INFO - TEST-INFO | started process 23855 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpl0WUJb/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:27:32 INFO - PROCESS | 23855 | RSS: Main: 153174016 11:27:32 INFO - PROCESS | 23855 | 11:28:23 INFO - PROCESS | 23855 | 1458325703465 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] 11:30:31 INFO - PROCESS | 23855 | Cycle 1(1): loaded http://localhost:45822/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45822/tests/dromaeo/cssquery-ext.html) 11:30:32 INFO - PROCESS | 23855 | RSS: Main: 254427136 11:30:32 INFO - PROCESS | 23855 | 11:33:34 INFO - PROCESS | 23855 | Cycle 1(1): loaded http://localhost:45822/tests/dromaeo/cssquery-ext.html (next: http://localhost:45822/tests/dromaeo/cssquery-jquery.html) 11:33:34 INFO - PROCESS | 23855 | RSS: Main: 228466688 11:33:34 INFO - PROCESS | 23855 | 11:36:36 INFO - PROCESS | 23855 | Cycle 1(1): loaded http://localhost:45822/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45822/tests/dromaeo/cssquery-mootools.html) 11:36:37 INFO - PROCESS | 23855 | RSS: Main: 226783232 11:36:37 INFO - PROCESS | 23855 | 11:39:39 INFO - PROCESS | 23855 | Cycle 1(1): loaded http://localhost:45822/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45822/tests/dromaeo/cssquery-prototype.html) 11:39:39 INFO - PROCESS | 23855 | RSS: Main: 218308608 11:39:39 INFO - PROCESS | 23855 | 11:42:42 INFO - PROCESS | 23855 | Cycle 1(1): loaded http://localhost:45822/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45822/tests/dromaeo/cssquery-yui.html) 11:42:42 INFO - PROCESS | 23855 | RSS: Main: 221093888 11:42:42 INFO - PROCESS | 23855 | 11:45:45 INFO - PROCESS | 23855 | Cycle 1(1): loaded http://localhost:45822/tests/dromaeo/cssquery-yui.html (next: http://localhost:45822/tests/dromaeo/cssquery-dojo.html) 11:45:45 INFO - PROCESS | 23855 | RSS: Main: 272568320 11:45:45 INFO - PROCESS | 23855 | 11:45:45 INFO - PROCESS | 23855 | __start_tp_report 11:45:45 INFO - PROCESS | 23855 | _x_x_mozilla_page_load 11:45:45 INFO - PROCESS | 23855 | _x_x_mozilla_page_load_details 11:45:45 INFO - PROCESS | 23855 | |i|pagename|runs| 11:45:45 INFO - PROCESS | 23855 | |0;dojo.html;3082.537619357096;3143.8113713177195;3186.856591453384;3197.680231976801;3224.838758062098;5329.307190065296;5399.62202645815;5433.429489903558;5461.481159289871;5518.2826232589705;5386.596005299599;5411.621186516945;5444.700541470217;5454.781808727646;5470.398256191816;4867.902641947159;4871.585915197213;4893.681910675812;4900.460949295574;4973.303737476738;4873.512648735116;4898.314236006961;4941.530554597308;4949.529794669518;4951.207806750921;4798.352222449959;4875.561199492045;4901.142300097468;4960.900781984358;4967.528084831935;4872.853814385574;4873.756312184377;4874.341963834872;4895.069936712013;4912.312276281288;4744.4069491313585;4828.37231159947;4840.636952228561;4854.368932038848;4907.337509436216;5280.392754833205;5338.225957236179;5348.705821179834;5352.5182733553775;5370.489803468664;5727.656340619576;5735.827925162252;5741.511971482429;5741.511971482429;5746.396628354046;5689.715514224314;5779.2775903012125;5780.595358324919;5784.16129661201;5789.421057894219;5421.024215641183;5468.043092458884;5473.425290344497;5495.2856128703015;5517.531009864167;5975.043992961106;5976.5218782497295;5979.19280897082;5986.940130598726;6019.458248757633;5511.173324001432;5685.971570142123;5729.226554415184;5741.942580574141;5742.799002034909;5798.768049277982;5799.33307669615;5801.593888427854;5810.1865738796605;5857.648541087548;5724.141378793214;5768.2501274834;5769.624974376652;5770.2498675171955;5777.855553611109;5676.233708449389;5718.79984200551;5783.971080144656;5799.681017544076;5912.438318359749;4422.336649502536;4422.447194100738;4425.601695847325;4455.042165934275;4466.955330446719;3917.0794863207125;3941.9605803941595;3942.1130245695063;3943.881683549498;3968.6626636735623;5362.436944120889;5390.4879036491475;5462.071447853875;5483.1227003680015;5524.033294173503;5848.327442344185;5854.092615644582;5870.5890587659305;5876.559258055663;5878.059510478389;5498.560115190775;5501.724913754297;5510.173473978935;5515.172724091338;5516.889662206733;4690.624750019991;4774.618030557547;4791.832285869978;4806.615470762331;4820.68665536739;5972.372900845348;5998.970005149947;6056.06131049688;6056.636601803906;6057.909131363033;5649.971750141223;5779.104238842986;5784.21913041734;5831.06702927538;5839.591228613956;5983.790567330123;6047.123167140828;6048.90926636092;6085.391460853879;6095;5661.094224923992;5692.089265717631;5694.686792226302;5699.772009119589;5708.200851880657;5618.550515958796;5725.971370143123;5787.768489260551;5793.15999180125;5825.330087040044;5714.571407144564;5723.198752174782;5728.656280623176;5732.742026608729;5774.711264436845;5671.17767923657;5673.517750991047;5678.233438485751;5679.204911312337;5682.6306290091015;5463.344398672185;5569.860753481195;5590.161475778503;5600.467955544217;5632.5212356950115;5665;5668.914966275427;5676.858078548069;5685.260916080883;5691.2032315475035;5528.944710552843;5564.693941833238;5564.860878478071;5578.414266501959;5607.271054762855 11:45:45 INFO - PROCESS | 23855 | |1;ext.html;554.2237129998356;566.4137617565821;589.4547543522241;609.8261995331329;616.3928530397559;31832;37547.43678844816;38209.235815283675;38252.61747382525;38522.80738596303;40898.79550602243;41351.58648413515;41373.17253654925;41389.37915931264;41412.37881431781;7495.812604684899;8511.574421278941;8712.172343627346;8719.302455803521;10004.349717268391;10196;10321.12270457012;10362.896371036268;10371.948140259288;10374.533146008447;10262.179025677928;10295.794084118314;10317.690469285933;10325.58697652093;10412.271141020132;10226.33528820628;10349.172066234683;10356.948215258952;10360.585576576928;10362.119219866321;9995.100440960276;10116.49417529128;10131.44277064761;10134.847977280348;10345.17238620916;40575.797121014504;41023.589764102275;41051;41067.58932410697;41085.794571026956;3537.204129070964;3595.227026189356;3620.348337299285;3638.563372395303;3722.404415293567;31441.213969650715;31610.841945790355;32054;32159.83920080408;32323.676763232303;4197.601227883346;4274;4313.352997050468;4326.156399502099;4342.1532801103795;314640;315092;315818;315861;316335;47147.29279060817;59075.704621476616;59177.40822591805;59420;59569.404305956385;46297.76851115723;46333.30500042502;46442.76778616085;46453.535464645596;46467.535324647;14851.108933464027;15026.624334391508;15044.774328385083;15049;15065.246737663074;11558.768824623461;11617.6514704559;11619.244749091282;11659.242149260272;11661.358625275521;15722.842771572366;15827.287772050286;15886.52340429789;15902.204889755465;15907.761383579256;6195.81412557624;6206.441420272197;6261.686915654199;6280.434760871543;6327.272363678236;1082.1775450657399;1082.7996820588216;1139.9455503659083;1154.0709728668503;1154.8902854228834;31133.066008019796;31295.53056704151;31684;31888.16313998928;32279.35441291161;1094.7482079121687;1111.9277246979082;1210.4250481021445;1226.9877301227052;1227.1287385955893;15865.286062127232;16478.42325518601;16500.83499164993;16538.601902724036;16703.749443758352;390769;392987;395219;395498;396294;55825.162622560696;55896;56419;56426.71786641041;56444;1366.2007725480507;1368.8152099466445;1378.1730961423066;1380.9792853107413;1412.9505467308595;27726.584101238095;29362.853185733933;29569.704302957554;29625.407491850474;30223;41553.1689366217;41785.582144178166;42334.57665423306;42357.788211058745;42412.575874240865;217683;218261;218899;219901;220796;32670;34240.486392704624;48616;49058.50941490539;49147.262791057445;46763.85591140952;46966.76516617395;47402;47862.76068619634;50225.497745023546;40367.59632403756;40662;41136.58863411328;41297;42431;40098.79950600345;40871.18257634771;41004.794976026125;41520.79239603903;41753.373699393924;41318.58681413268;42287.365689515296;42716.57283427126;42919.141617168105;42935.14129717451;36650.8167459161;37934.24131517409;38116.809415952746;38526;39939.60060399475;25213.369665757768;25680.486390271715;25723.742762572136;25790.226293211235;26134.477310454065 11:45:45 INFO - PROCESS | 23855 | |2;jquery.html;372.43761919501554;378.9223209242104;379.1204405778593;383.1991138520492;384.19127736115496;17562.736558951627;18317.45047648571;18368.265269389227;18586.256549737995;18608.627827443444;17860.82139178611;18346.816531834713;19071.427857164308;19072.71390929134;19076.427707168772;5462.0987537056335;5604.8038318658855;5634.9718251408685;5637.408072152426;5638.520725738296;4000.4999375078114;5626.887462250773;5904.114382842587;6288.717007734663;6312.431881130698;6186.164867742865;6189.783357582485;6195.163652906867;6212.409821066992;6218.564700470969;5982.820515384546;6233;6238.189035425366;6240.251169859646;6246.843828904291;3698.408254679265;5297.073012222845;5450.809221677262;5471.945280547184;5494.862628434281;21606.891965540228;21782.019809108628;21849.781502184935;23233.651495227587;23246.883765581064;2382.4996750682376;2412.216029790325;2620.829646073018;2743.7804975602103;2842.701516340796;13861.999690156506;14053.718925621533;14328.785068223984;14420.510770153369;14564.271786410636;2010.316492392579;2030;2044.877307361563;2044.9877310731283;2078.812906838392;67004.3299567003;71073;71583.64208178977;72964;73571.26428735751;10682.092022178202;10819.891801082045;11097.500612472297;11117.11063114965;11301.378424186585;14284.714305713827;14347.210903400204;14380.640483987774;14387.64030899215;14392.640183995483;7620.1998790127345;7837.804054898673;7871.960640196877;7989.201079892081;8003.639836207385;7465.29079737424;7500.662470188855;7542.962285188649;7600.771976840703;7617.162112167657;6542.869142617121;6681.9331806682285;6733.831654208586;6806.897896531457;6816.727330906808;1756.998510848804;1821.3534195360721;1860.702287633999;1893.6023435078787;1893.8674292799647;476.49729535339856;479.85364463838164;1020.0105897279627;1021.2238698589126;1081.9459027048615;11088.833667494993;11153.10775137987;11242.887571124347;11365.147613928822;11535.480903359368;462.49587949135605;955.9187469065207;984.9753756156153;1000.6341344065298;1060.8886066963012;9769.706908792748;10187.7453063674;10212.336198147097;10213.131883789812;10378.325408848401;474240;485003;491505;500068;500877;81168.59415703002;85324.14675853286;85576;85618.57190714132;86185.56907215549;1083.041508265191;1103.0183137008069;1118.7147277444199;1126.7408496045955;1133.9149563782585;15615.474794841826;15615.609609759847;15759.842401576296;15908.602284942968;15957.521274361789;36904.81547592245;37253.81373093117;37541;37924.81037594794;38082.238355232184;56547.434525654215;57104;57144;57238.7138064307;57468.71265643645;7580.9620951894885;8076.838463230585;8309.83380332378;8389.161083891562;8535.53054582004;12348.197367171106;12819.230846149261;12860.164089334163;13037.674058148623;13257.535986240435;11574.363410012531;11824.290542567473;11923.284602923852;11960.222585531912;11964.58123965657;11236.55053797839;11550.537978481103;11560.30638161713;11671.824922625998;11782;9512.81089863767;10987.890121098686;11443.713907152387;11688.415579220835;11928.463219154984;8307.335413167053;8430.367722420966;8453.788655283666;8458.619362128842;8472.729090636454;10972.526294266367;11877.46551405206;11952.76094478088;12022.699432514257;12089 11:45:45 INFO - PROCESS | 23855 | |3;mootools.html;1323.344944252595;1495.1104093064625;1498.220925118938;1688.5047950741962;1831.917563709632;7879.172686867875;8002.199780021995;8037.758867233978;8075.232852878975;8080.6767729290905;7908.683652653887;8028.3978701597325;8048.8390232195325;8070.394720395964;8071.313938315236;2054.137262349809;2309.9191528296515;2361.0673783855323;2382.8451150675237;2390.557746816836;2385.6183010718287;2399.0643648976825;2404.927852164429;2407.735149133594;2407.807375409972;2334.4630734930975;2396.293093537402;2397.904083836653;2401.435662619283;2403.098837935774;2311.133325003124;2344.0623750499767;2350.811935045192;2358.233574088428;2358.7995020423286;2342.426105604121;2350.788429041377;2362.7164740231283;2405.7714517120844;2410.3612542676206;8242.587870606445;8324.83350332996;8327.20891515305;8329.292010179142;8336.916630833675;5138.177891537373;5270.631055826094;5271.103912334912;5278.736063196825;5281.603879708999;3477.078574177845;3519.788812671248;3560.4659301104784;3641.089727568108;3649.799261040642;1119.8488204092425;1143.2625956258166;1143.3311512765042;1158.2239899267427;1197.3953153657435;11650.533978640844;11653.883461165364;11656.650300490914;11662.067034637208;11699.590514331958;4538.319252112209;4539.6368290536675;4662.813487460464;4667.789949452283;4672.112298663243;9960.352577082467;9971.451570163566;9988.05113514215;9992.750181245527;10009.69970900874;4502.212112880233;5151.4333423323405;5182.4299327073995;5187.377514698185;5200.375954885362;4519.096180763795;4593.356930029799;4596.241620132708;4615.746133962597;4641.814327426932;3974.6682453976605;4027.7381970171846;4028.436018957348;4061.593840615974;4084.264832330209;1284.319310765296;1299.051692264652;1299.3957809618385;1310.5871650430083;1312.4356526693423;809.461707964209;1400.4818217259476;1400.9719805603831;1407;1409.9647508812361;8075.071366792777;8094.838103237902;8095.838083238302;8097.635606397608;8101.594920253964;499.2511233150275;501.7516329416962;510.5481648740817;513.1584201908872;514.108022580822;6068.150458935753;6098.72555734993;6113.755449782047;6168.8766224675255;6262.937370626327;9919.950400247953;10189.796204075878;10274.897251027543;10282.588696452207;10308.433036182932;9838.06538378853;9917.65288214909;10035.197184225244;10107.595696172071;10173.84739228912;7749.961250193713;7805.726799562101;7818.8827167592535;7819.960900195462;7901.446898717149;7399.556026638419;7411.184769675439;7415.8146046349275;7535.54786712799;7548.245175482408;8983.371164018456;9136.6802161924;9148.771280717769;9229.215516681157;9230.400023998418;9214.493202873906;9361.906380936376;9458.385204961656;9467.810643787223;9530.618775248913;6283.37166283368;6971.75598854058;7171.4979951404985;7421.109466864011;7483.88774168377;7786.18245084258;7812.296893279405;7828.530288182727;7856.135825059353;7863.646135924012;6802.387785099365;6937.618430986142;6972.6862291196;7001.929980700332;7104.680289387094;6850.0752398425575;6899.413549848319;6923.584584924921;6948.9305106950305;7108.182559005781;7359.705611775469;7377.077865266841;7432.293932076444;7484.887726684213;7493.850122997401;6795.762148324785;6823.420009299265;6834.248232694499;6847.760328388483;6870.553414028072;6953.096097507494;6972;7024.121984751906;7045.11936007999;7052 11:45:45 INFO - PROCESS | 23855 | |4;prototype.html;345.6129135368387;350.9894703158903;352.96999755020823;355.60527814126317;356.5560876708498;6044.214252147221;6063.120847477113;6129.295131059935;6131.049687298465;6169.290531588868;5958.255218097738;5999.1301261317085;6004.699765011743;6008.459238668519;6011.458968692817;4374.9781251093855;4510.939929116655;4581;4636.559526844944;4647.163510568096;4605.286180642006;4615.238485649864;4622.14490319292;4623.86128416148;4645.8838529036875;4572.702774319659;4597.195490789099;4620.861374158764;4627.490975992638;4631.3516107744945;4368.497622773374;4475.843345482925;4560.293154561048;4573.382593349888;4626.097910907374;4062.8171732272117;4071.1857628474127;4076.144009757925;4076.2051399977017;4084.12191378852;5773.538116950634;5774.942250577525;5775.220345253421;5782.653040817564;5783.681897495636;5367.114426119724;5367.355917289911;5373.677579345252;5374.8925021499745;5399.973000134974;6288.496920246369;6293.905591416133;6296.68516574174;6298.937010629927;6311;4222.472190976128;4357.324614684729;4364.89087772805;4395.736255824629;4535.546445355471;6585.341465853424;6637.900431493483;6651.900221496681;6653.201615806086;6655.999999999952;4556.134334476439;4560.657950653715;4563.748993805372;4565.315202719618;4565.406497155415;4618.122556714214;4622.214223581999;4622.491525932145;4624.421947256593;4628.352030715702;5330.866728331823;5344.064788662046;5348.759305831247;5353.544948679406;5357.4106848246665;6290.591111577733;6383.6488993104895;6405.839854003687;6423.582467139714;6434.485241180694;1594.5057032320017;1611.6293252551745;1617.5309160343604;1619.5060506545617;1622.6998005369044;1001.1940387987594;1052.2476429353048;1066.6853278282924;1066.7919755647729;1083.5828206140693;6139.96930015356;6141.293751218667;6149.446549810449;6154.692265386802;6154.753809847556;6516.120323756327;6542.476601871839;6548.083268342436;6550.639714815731;6556.967215163989;6154.78458253959;6158.199434073542;6179.3202747697715;6222.3466536013975;6226.283977342573;3501.1772233525103;3530.646935306449;3531.876384326536;3533.293341331744;3537.5931767846514;6582.670866456754;6776.830579235559;6777.288384719632;6782.69477873487;6796.116504854337;6648.66756662165;6654.800355989328;6660.200775906922;6663.833404164838;6670.299618540081;6728.6635668216395;6738.393544581109;6742.49431292655;6742.5280230383405;6751.493637977172;6495.967520162369;6517.283098859217;6519.315471875385;6525.3800888915475;6546.214454265519;6360.840978975562;6423.96788016057;6436;6614.900776488453;6646.667666616747;6935.549189302679;6940.271271516418;6958;6958.965205173941;6973.47698922593;4535.546445355438;4543.54564543543;4569.086182763527;4569.977150114228;4575.65682573815;6566.474682025331;6606.405423511907;6634.402903738686;6639.634820084942;6648.867022659617;6310.432061114522;6427.164468619237;6439.935600643934;6440.194975628046;6450.903236451551;6320.893843577447;6360.49116070704;6390.616563006234;6391.360863913572;6404.327545607644;6238.532110091671;6284.151639528605;6286.4342209201395;6291.96854015727;6304.968475157595;6367.840803979938;6427.17204430068;6429.7428102875365;6433.195850518685;6435.259945106185;6004.0093384591055;6126;6248.500119990299;6270.4670103039925;6283.340249273943 11:45:45 INFO - PROCESS | 23855 | |5;yui.html;852.6193642208641;853.3258725606771;855.1662129423812;860.1914200651389;867.11554214701;13561.525346612858;13612.319384030796;13678.863211367883;13748.656283592914;14067.648308792286;13503.527376541822;13546.525871594496;13564.525241616546;13565.932170339134;13638.454461821515;653.6111013946718;797.2266901105918;808.6482380164617;811.4887620798888;824.3034635732796;824.7072289337259;825.2572684583893;826.3471857232779;827.6441130313963;828.457360428917;864.3258258558303;869.5739087846941;870.0820634230884;870.4777133719781;873.1268731268731;695.2005194026859;852.3735054734765;865.0916537635458;865.5715420866649;866.2593482572436;632.3739497897095;632.5129650169343;633.2116514938931;633.4647223096476;635.0505993539641;13906.652333691638;13963.65090872726;13978.510752123628;13992.370343334574;13998;13442.865571344259;13880.61193880614;13928.651783705489;13933;14730.410783568645;11642.534298628045;11664;11939.34333611651;11973.820392694117;12005.699857503545;3782.167923056923;3796.734228603999;3871.632194941476;3882.650561449455;3897.2984862724697;54546.727266363414;54598;54632.180517292276;54676.726616367065;54816;11298;11370.260933039326;11710.238834475731;11828.349440780668;11875.287482751062;19726.802731972784;19861.106250218774;19885.701714474293;19918.50203744918;19938.60122797536;8168.7957801055445;8740.431871928304;8743.081976392514;8903.19871211594;8938.24024957886;4903.754812259373;5041.092603331435;5047.4447810740785;5052.747362631853;5097.388313402415;3501.807400592992;3560.127768696686;3564.108972756811;3564.6791788739138;3565.322588708137;569.0695712509993;592.7540070870626;621.5773274173605;639.0892977507034;655.0305547789203;580.5645765675744;591.4920736078994;708.4544900426642;738.8710645198095;799.9320057795036;9323.25413966881;9454.290928180413;9753.658621948198;9771.413715177112;9778.706638800848;635.580516858871;781.5037451218403;791.9010123734533;806.7620052084649;812.9634166462523;4583.312503124558;4612.123696497655;4702.224133018014;4731.1720448921305;4759.881002974884;60497.69751151216;60882;61369.69315153396;61578.38421615816;61588;54566.72716636391;54814.72592637011;54941.1758823618;56030.43969560252;56656;48877;49087.509124909724;50294.24558631623;50305;51166;9321.021292764162;9390.812183756423;9688.176504997155;9920.503974801086;9996.500174991366;38772;39525.2094958105;39587.80206098951;40505.392419113145;40569.59430405776;48258.5174148254;48812;49048.50951490439;49671.25493117679;50195;11909.642710718692;12031.338276394883;12055.51777928873;12201.938990304992;12217.816732749194;13280.136791108547;13494.52769153075;13508.797368039292;13751.931240343734;14679.412823487368;12934.417951192407;12942.352882355655;13081.60755177308;13081.672958176121;13380.732385352434;12414.813777793159;12603.243805371707;12671;12735.80896286538;13226.801597975846;12219.69450763738;12321.260724356567;12365.876341236832;12691.492340306284;12720.300383478627;10792.514336854703;11065.446727663424;11093.16801239894;11143.442827858737;11414.828777568177;9781.60873565078;10877.347359158475;10930.562777489129;10948.288361256811;10949.945250273699 11:45:45 INFO - PROCESS | 23855 | __end_tp_report 11:45:45 INFO - PROCESS | 23855 | __start_cc_report 11:45:45 INFO - PROCESS | 23855 | _x_x_mozilla_cycle_collect,805 11:45:45 INFO - PROCESS | 23855 | __end_cc_report 11:45:45 INFO - PROCESS | 23855 | __startTimestamp1458326745567__endTimestamp 11:45:45 INFO - PROCESS | 23855 | 11:45:45 INFO - PROCESS | 23855 | ------- Summary: start ------- 11:45:45 INFO - PROCESS | 23855 | Number of tests: 6 11:45:45 INFO - PROCESS | 23855 | 11:45:45 INFO - PROCESS | 23855 | [#0] dojo.html Cycles:165 Average:5373.30 Median:5590.16 stddev:620.28 (11.1%) stddev-sans-first:595.58 11:45:45 INFO - PROCESS | 23855 | Values: 3082.5 3143.8 3186.9 3197.7 3224.8 5329.3 5399.6 5433.4 5461.5 5518.3 5386.6 5411.6 5444.7 5454.8 5470.4 4867.9 4871.6 4893.7 4900.5 4973.3 4873.5 4898.3 4941.5 4949.5 4951.2 4798.4 4875.6 4901.1 4960.9 4967.5 4872.9 4873.8 4874.3 4895.1 4912.3 4744.4 4828.4 4840.6 4854.4 4907.3 5280.4 5338.2 5348.7 5352.5 5370.5 5727.7 5735.8 5741.5 5741.5 5746.4 5689.7 5779.3 5780.6 5784.2 5789.4 5421.0 5468.0 5473.4 5495.3 5517.5 5975.0 5976.5 5979.2 5986.9 6019.5 5511.2 5686.0 5729.2 5741.9 5742.8 5798.8 5799.3 5801.6 5810.2 5857.6 5724.1 5768.3 5769.6 5770.2 5777.9 5676.2 5718.8 5784.0 5799.7 5912.4 4422.3 4422.4 4425.6 4455.0 4467.0 3917.1 3942.0 3942.1 3943.9 3968.7 5362.4 5390.5 5462.1 5483.1 5524.0 5848.3 5854.1 5870.6 5876.6 5878.1 5498.6 5501.7 5510.2 5515.2 5516.9 4690.6 4774.6 4791.8 4806.6 4820.7 5972.4 5999.0 6056.1 6056.6 6057.9 5650.0 5779.1 5784.2 5831.1 5839.6 5983.8 6047.1 6048.9 6085.4 6095.0 5661.1 5692.1 5694.7 5699.8 5708.2 5618.6 5726.0 5787.8 5793.2 5825.3 5714.6 5723.2 5728.7 5732.7 5774.7 5671.2 5673.5 5678.2 5679.2 5682.6 5463.3 5569.9 5590.2 5600.5 5632.5 5665.0 5668.9 5676.9 5685.3 5691.2 5528.9 5564.7 5564.9 5578.4 5607.3 11:45:45 INFO - PROCESS | 23855 | 11:45:45 INFO - PROCESS | 23855 | [#1] ext.html Cycles:180 Average:48575.34 Median:3629.46 stddev:83382.87 (2297.4%) stddev-sans-first:83538.83 11:45:45 INFO - PROCESS | 23855 | Values: 554.2 566.4 589.5 609.8 616.4 31832.0 37547.4 38209.2 38252.6 38522.8 40898.8 41351.6 41373.2 41389.4 41412.4 7495.8 8511.6 8712.2 8719.3 10004.3 10196.0 10321.1 10362.9 10371.9 10374.5 10262.2 10295.8 10317.7 10325.6 10412.3 10226.3 10349.2 10356.9 10360.6 10362.1 9995.1 10116.5 10131.4 10134.8 10345.2 40575.8 41023.6 41051.0 41067.6 41085.8 3537.2 3595.2 3620.3 3638.6 3722.4 31441.2 31610.8 32054.0 32159.8 32323.7 4197.6 4274.0 4313.4 4326.2 4342.2 314640.0 315092.0 315818.0 315861.0 316335.0 47147.3 59075.7 59177.4 59420.0 59569.4 46297.8 46333.3 46442.8 46453.5 46467.5 14851.1 15026.6 15044.8 15049.0 15065.2 11558.8 11617.7 11619.2 11659.2 11661.4 15722.8 15827.3 15886.5 15902.2 15907.8 6195.8 6206.4 6261.7 6280.4 6327.3 1082.2 1082.8 1139.9 1154.1 1154.9 31133.1 31295.5 31684.0 31888.2 32279.4 1094.7 1111.9 1210.4 1227.0 1227.1 15865.3 16478.4 16500.8 16538.6 16703.7 390769.0 392987.0 395219.0 395498.0 396294.0 55825.2 55896.0 56419.0 56426.7 56444.0 1366.2 1368.8 1378.2 1381.0 1413.0 27726.6 29362.9 29569.7 29625.4 30223.0 41553.2 41785.6 42334.6 42357.8 42412.6 217683.0 218261.0 218899.0 219901.0 220796.0 32670.0 34240.5 48616.0 49058.5 49147.3 46763.9 46966.8 47402.0 47862.8 50225.5 40367.6 40662.0 41136.6 41297.0 42431.0 40098.8 40871.2 41004.8 41520.8 41753.4 41318.6 42287.4 42716.6 42919.1 42935.1 36650.8 37934.2 38116.8 38526.0 39939.6 25213.4 25680.5 25723.7 25790.2 26134.5 11:45:45 INFO - PROCESS | 23855 | 11:45:45 INFO - PROCESS | 23855 | [#2] jquery.html Cycles:180 Average:28150.07 Median:2682.31 stddev:80557.79 (3003.3%) stddev-sans-first:80756.77 11:45:45 INFO - PROCESS | 23855 | Values: 372.4 378.9 379.1 383.2 384.2 17562.7 18317.5 18368.3 18586.3 18608.6 17860.8 18346.8 19071.4 19072.7 19076.4 5462.1 5604.8 5635.0 5637.4 5638.5 4000.5 5626.9 5904.1 6288.7 6312.4 6186.2 6189.8 6195.2 6212.4 6218.6 5982.8 6233.0 6238.2 6240.3 6246.8 3698.4 5297.1 5450.8 5471.9 5494.9 21606.9 21782.0 21849.8 23233.7 23246.9 2382.5 2412.2 2620.8 2743.8 2842.7 13862.0 14053.7 14328.8 14420.5 14564.3 2010.3 2030.0 2044.9 2045.0 2078.8 67004.3 71073.0 71583.6 72964.0 73571.3 10682.1 10819.9 11097.5 11117.1 11301.4 14284.7 14347.2 14380.6 14387.6 14392.6 7620.2 7837.8 7872.0 7989.2 8003.6 7465.3 7500.7 7543.0 7600.8 7617.2 6542.9 6681.9 6733.8 6806.9 6816.7 1757.0 1821.4 1860.7 1893.6 1893.9 476.5 479.9 1020.0 1021.2 1081.9 11088.8 11153.1 11242.9 11365.1 11535.5 462.5 955.9 985.0 1000.6 1060.9 9769.7 10187.7 10212.3 10213.1 10378.3 474240.0 485003.0 491505.0 500068.0 500877.0 81168.6 85324.1 85576.0 85618.6 86185.6 1083.0 1103.0 1118.7 1126.7 1133.9 15615.5 15615.6 15759.8 15908.6 15957.5 36904.8 37253.8 37541.0 37924.8 38082.2 56547.4 57104.0 57144.0 57238.7 57468.7 7581.0 8076.8 8309.8 8389.2 8535.5 12348.2 12819.2 12860.2 13037.7 13257.5 11574.4 11824.3 11923.3 11960.2 11964.6 11236.6 11550.5 11560.3 11671.8 11782.0 9512.8 10987.9 11443.7 11688.4 11928.5 8307.3 8430.4 8453.8 8458.6 8472.7 10972.5 11877.5 11952.8 12022.7 12089.0 11:45:45 INFO - PROCESS | 23855 | 11:45:45 INFO - PROCESS | 23855 | [#3] mootools.html Cycles:180 Average:5807.97 Median:5280.17 stddev:3057.73 (57.9%) stddev-sans-first:3047.72 11:45:45 INFO - PROCESS | 23855 | Values: 1323.3 1495.1 1498.2 1688.5 1831.9 7879.2 8002.2 8037.8 8075.2 8080.7 7908.7 8028.4 8048.8 8070.4 8071.3 2054.1 2309.9 2361.1 2382.8 2390.6 2385.6 2399.1 2404.9 2407.7 2407.8 2334.5 2396.3 2397.9 2401.4 2403.1 2311.1 2344.1 2350.8 2358.2 2358.8 2342.4 2350.8 2362.7 2405.8 2410.4 8242.6 8324.8 8327.2 8329.3 8336.9 5138.2 5270.6 5271.1 5278.7 5281.6 3477.1 3519.8 3560.5 3641.1 3649.8 1119.8 1143.3 1143.3 1158.2 1197.4 11650.5 11653.9 11656.7 11662.1 11699.6 4538.3 4539.6 4662.8 4667.8 4672.1 9960.4 9971.5 9988.1 9992.8 10009.7 4502.2 5151.4 5182.4 5187.4 5200.4 4519.1 4593.4 4596.2 4615.7 4641.8 3974.7 4027.7 4028.4 4061.6 4084.3 1284.3 1299.1 1299.4 1310.6 1312.4 809.5 1400.5 1401.0 1407.0 1410.0 8075.1 8094.8 8095.8 8097.6 8101.6 499.3 501.8 510.5 513.2 514.1 6068.2 6098.7 6113.8 6168.9 6262.9 9920.0 10189.8 10274.9 10282.6 10308.4 9838.1 9917.7 10035.2 10107.6 10173.8 7750.0 7805.7 7818.9 7820.0 7901.4 7399.6 7411.2 7415.8 7535.5 7548.2 8983.4 9136.7 9148.8 9229.2 9230.4 9214.5 9361.9 9458.4 9467.8 9530.6 6283.4 6971.8 7171.5 7421.1 7483.9 7786.2 7812.3 7828.5 7856.1 7863.6 6802.4 6937.6 6972.7 7001.9 7104.7 6850.1 6899.4 6923.6 6948.9 7108.2 7359.7 7377.1 7432.3 7484.9 7493.9 6795.8 6823.4 6834.2 6847.8 6870.6 6953.1 6972.0 7024.1 7045.1 7052.0 11:45:45 INFO - PROCESS | 23855 | 11:45:45 INFO - PROCESS | 23855 | [#4] prototype.html Cycles:180 Average:5340.46 Median:6135.51 stddev:1607.08 (26.2%) stddev-sans-first:1567.25 11:45:45 INFO - PROCESS | 23855 | Values: 345.6 351.0 353.0 355.6 356.6 6044.2 6063.1 6129.3 6131.0 6169.3 5958.3 5999.1 6004.7 6008.5 6011.5 4375.0 4510.9 4581.0 4636.6 4647.2 4605.3 4615.2 4622.1 4623.9 4645.9 4572.7 4597.2 4620.9 4627.5 4631.4 4368.5 4475.8 4560.3 4573.4 4626.1 4062.8 4071.2 4076.1 4076.2 4084.1 5773.5 5774.9 5775.2 5782.7 5783.7 5367.1 5367.4 5373.7 5374.9 5400.0 6288.5 6293.9 6296.7 6298.9 6311.0 4222.5 4357.3 4364.9 4395.7 4535.5 6585.3 6637.9 6651.9 6653.2 6656.0 4556.1 4560.7 4563.7 4565.3 4565.4 4618.1 4622.2 4622.5 4624.4 4628.4 5330.9 5344.1 5348.8 5353.5 5357.4 6290.6 6383.6 6405.8 6423.6 6434.5 1594.5 1611.6 1617.5 1619.5 1622.7 1001.2 1052.2 1066.7 1066.8 1083.6 6140.0 6141.3 6149.4 6154.7 6154.8 6516.1 6542.5 6548.1 6550.6 6557.0 6154.8 6158.2 6179.3 6222.3 6226.3 3501.2 3530.6 3531.9 3533.3 3537.6 6582.7 6776.8 6777.3 6782.7 6796.1 6648.7 6654.8 6660.2 6663.8 6670.3 6728.7 6738.4 6742.5 6742.5 6751.5 6496.0 6517.3 6519.3 6525.4 6546.2 6360.8 6424.0 6436.0 6614.9 6646.7 6935.5 6940.3 6958.0 6959.0 6973.5 4535.5 4543.5 4569.1 4570.0 4575.7 6566.5 6606.4 6634.4 6639.6 6648.9 6310.4 6427.2 6439.9 6440.2 6450.9 6320.9 6360.5 6390.6 6391.4 6404.3 6238.5 6284.2 6286.4 6292.0 6305.0 6367.8 6427.2 6429.7 6433.2 6435.3 6004.0 6126.0 6248.5 6270.5 6283.3 11:45:45 INFO - PROCESS | 23855 | 11:45:45 INFO - PROCESS | 23855 | [#5] yui.html Cycles:180 Average:15183.22 Median:48844.50 stddev:17399.65 (35.6%) stddev-sans-first:17415.18 11:45:45 INFO - PROCESS | 23855 | Values: 852.6 853.3 855.2 860.2 867.1 13561.5 13612.3 13678.9 13748.7 14067.6 13503.5 13546.5 13564.5 13565.9 13638.5 653.6 797.2 808.6 811.5 824.3 824.7 825.3 826.3 827.6 828.5 864.3 869.6 870.1 870.5 873.1 695.2 852.4 865.1 865.6 866.3 632.4 632.5 633.2 633.5 635.1 13906.7 13963.7 13978.5 13992.4 13998.0 13442.9 13880.6 13928.7 13933.0 14730.4 11642.5 11664.0 11939.3 11973.8 12005.7 3782.2 3796.7 3871.6 3882.7 3897.3 54546.7 54598.0 54632.2 54676.7 54816.0 11298.0 11370.3 11710.2 11828.3 11875.3 19726.8 19861.1 19885.7 19918.5 19938.6 8168.8 8740.4 8743.1 8903.2 8938.2 4903.8 5041.1 5047.4 5052.7 5097.4 3501.8 3560.1 3564.1 3564.7 3565.3 569.1 592.8 621.6 639.1 655.0 580.6 591.5 708.5 738.9 799.9 9323.3 9454.3 9753.7 9771.4 9778.7 635.6 781.5 791.9 806.8 813.0 4583.3 4612.1 4702.2 4731.2 4759.9 60497.7 60882.0 61369.7 61578.4 61588.0 54566.7 54814.7 54941.2 56030.4 56656.0 48877.0 49087.5 50294.2 50305.0 51166.0 9321.0 9390.8 9688.2 9920.5 9996.5 38772.0 39525.2 39587.8 40505.4 40569.6 48258.5 48812.0 49048.5 49671.3 50195.0 11909.6 12031.3 12055.5 12201.9 12217.8 13280.1 13494.5 13508.8 13751.9 14679.4 12934.4 12942.4 13081.6 13081.7 13380.7 12414.8 12603.2 12671.0 12735.8 13226.8 12219.7 12321.3 12365.9 12691.5 12720.3 10792.5 11065.4 11093.2 11143.4 11414.8 9781.6 10877.3 10930.6 10948.3 10949.9 11:45:45 INFO - PROCESS | 23855 | -------- Summary: end -------- 11:45:45 INFO - PROCESS | 23855 | 11:45:46 INFO - TEST-INFO | 23855: exit 0 11:45:46 INFO - TEST-OK | dromaeo_css | took 1111869ms 11:45:46 INFO - TEST-START | kraken 11:45:46 INFO - operating with platform_type : linux_ 11:45:46 INFO - Initialising browser for kraken test... 11:45:46 INFO - TEST-INFO | started process 24040 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwIc9YB/profile http://localhost:45822/getInfo.html) 11:45:50 INFO - PROCESS | 24040 | __metrics Screen width/height:1600/1200 11:45:50 INFO - PROCESS | 24040 | colorDepth:24 11:45:50 INFO - PROCESS | 24040 | Browser inner width/height: 1024/697 11:45:50 INFO - PROCESS | 24040 | __metrics 11:45:51 ERROR - PROCESS | 24040 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:45:51 INFO - PROCESS | 24040 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 11:45:52 INFO - TEST-INFO | 24040: exit 0 11:45:52 INFO - Browser initialized. 11:45:52 INFO - Running cycle 1/1 for kraken test... 11:45:52 INFO - TEST-INFO | started process 24120 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwIc9YB/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:46:03 INFO - PROCESS | 24120 | RSS: Main: 153944064 11:46:03 INFO - PROCESS | 24120 | 11:46:06 INFO - PROCESS | 24120 | Cycle 1(1): loaded http://localhost:45822/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45822/tests/kraken/driver.html?testName=audio-beat-detection) 11:46:06 INFO - PROCESS | 24120 | RSS: Main: 196931584 11:46:06 INFO - PROCESS | 24120 | 11:46:09 INFO - PROCESS | 24120 | Cycle 1(1): loaded http://localhost:45822/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45822/tests/kraken/driver.html?testName=audio-dft) 11:46:10 INFO - PROCESS | 24120 | RSS: Main: 186523648 11:46:10 INFO - PROCESS | 24120 | 11:46:13 INFO - PROCESS | 24120 | Cycle 1(1): loaded http://localhost:45822/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45822/tests/kraken/driver.html?testName=audio-fft) 11:46:13 INFO - PROCESS | 24120 | RSS: Main: 170409984 11:46:13 INFO - PROCESS | 24120 | 11:46:15 INFO - PROCESS | 24120 | Cycle 1(1): loaded http://localhost:45822/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45822/tests/kraken/driver.html?testName=audio-oscillator) 11:46:16 INFO - PROCESS | 24120 | RSS: Main: 173563904 11:46:16 INFO - PROCESS | 24120 | 11:46:18 INFO - PROCESS | 24120 | Cycle 1(1): loaded http://localhost:45822/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45822/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:46:19 INFO - PROCESS | 24120 | RSS: Main: 175837184 11:46:19 INFO - PROCESS | 24120 | 11:46:22 INFO - PROCESS | 24120 | Cycle 1(1): loaded http://localhost:45822/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45822/tests/kraken/driver.html?testName=imaging-darkroom) 11:46:22 INFO - PROCESS | 24120 | RSS: Main: 174260224 11:46:22 INFO - PROCESS | 24120 | 11:46:26 INFO - PROCESS | 24120 | Cycle 1(1): loaded http://localhost:45822/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45822/tests/kraken/driver.html?testName=imaging-desaturate) 11:46:26 INFO - PROCESS | 24120 | RSS: Main: 175181824 11:46:26 INFO - PROCESS | 24120 | 11:46:29 INFO - PROCESS | 24120 | Cycle 1(1): loaded http://localhost:45822/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45822/tests/kraken/driver.html?testName=json-parse-financial) 11:46:29 INFO - PROCESS | 24120 | RSS: Main: 176336896 11:46:29 INFO - PROCESS | 24120 | 11:46:31 INFO - PROCESS | 24120 | Cycle 1(1): loaded http://localhost:45822/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45822/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:46:32 INFO - PROCESS | 24120 | RSS: Main: 184602624 11:46:32 INFO - PROCESS | 24120 | 11:46:33 INFO - PROCESS | 24120 | Cycle 1(1): loaded http://localhost:45822/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45822/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:46:34 INFO - PROCESS | 24120 | RSS: Main: 183984128 11:46:34 INFO - PROCESS | 24120 | 11:46:36 INFO - PROCESS | 24120 | Cycle 1(1): loaded http://localhost:45822/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45822/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:46:37 INFO - PROCESS | 24120 | RSS: Main: 193548288 11:46:37 INFO - PROCESS | 24120 | 11:46:39 INFO - PROCESS | 24120 | Cycle 1(1): loaded http://localhost:45822/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45822/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:46:39 INFO - PROCESS | 24120 | RSS: Main: 200736768 11:46:39 INFO - PROCESS | 24120 | 11:46:42 INFO - PROCESS | 24120 | Cycle 1(1): loaded http://localhost:45822/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45822/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:46:42 INFO - PROCESS | 24120 | RSS: Main: 201900032 11:46:42 INFO - PROCESS | 24120 | 11:46:44 INFO - PROCESS | 24120 | Cycle 1(1): loaded http://localhost:45822/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45822/tests/kraken/driver.html?testName=ai-astar) 11:46:44 INFO - PROCESS | 24120 | RSS: Main: 260685824 11:46:44 INFO - PROCESS | 24120 | 11:46:44 INFO - PROCESS | 24120 | __start_tp_report 11:46:44 INFO - PROCESS | 24120 | _x_x_mozilla_page_load 11:46:44 INFO - PROCESS | 24120 | _x_x_mozilla_page_load_details 11:46:44 INFO - PROCESS | 24120 | |i|pagename|runs| 11:46:44 INFO - PROCESS | 24120 | |0;ai-astar;108;110;106;108;109;111;99;109;109;107 11:46:44 INFO - PROCESS | 24120 | |1;audio-beat-detection;149;126;158;164;144;174;158;124;181;125 11:46:44 INFO - PROCESS | 24120 | |2;audio-dft;162;160;161;160;162;161;160;165;162;163 11:46:44 INFO - PROCESS | 24120 | |3;audio-fft;74;72;97;97;72;73;74;119;96;72 11:46:44 INFO - PROCESS | 24120 | |4;audio-oscillator;92;93;135;93;93;93;147;93;93;138 11:46:44 INFO - PROCESS | 24120 | |5;imaging-gaussian-blur;117;117;116;117;116;117;117;117;117;117 11:46:44 INFO - PROCESS | 24120 | |6;imaging-darkroom;146;145;146;145;146;145;145;145;145;146 11:46:44 INFO - PROCESS | 24120 | |7;imaging-desaturate;95;95;96;95;95;95;95;95;95;96 11:46:44 INFO - PROCESS | 24120 | |8;json-parse-financial;55;54;57;54;55;54;55;64;53;52 11:46:44 INFO - PROCESS | 24120 | |9;json-stringify-tinderbox;60;60;61;60;60;62;61;61;61;63 11:46:44 INFO - PROCESS | 24120 | |10;stanford-crypto-aes;76;77;77;76;77;77;76;76;78;76 11:46:44 INFO - PROCESS | 24120 | |11;stanford-crypto-ccm;110;111;110;107;113;115;111;108;110;108 11:46:44 INFO - PROCESS | 24120 | |12;stanford-crypto-pbkdf2;127;134;133;135;135;134;134;133;132;136 11:46:44 INFO - PROCESS | 24120 | |13;stanford-crypto-sha256-iterative;66;62;65;62;63;62;63;62;62;67 11:46:44 INFO - PROCESS | 24120 | __end_tp_report 11:46:44 INFO - PROCESS | 24120 | __start_cc_report 11:46:44 INFO - PROCESS | 24120 | _x_x_mozilla_cycle_collect,1033 11:46:44 INFO - PROCESS | 24120 | __end_cc_report 11:46:44 INFO - PROCESS | 24120 | __startTimestamp1458326804834__endTimestamp 11:46:44 INFO - PROCESS | 24120 | 11:46:44 INFO - PROCESS | 24120 | ------- Summary: start ------- 11:46:44 INFO - PROCESS | 24120 | Number of tests: 14 11:46:44 INFO - PROCESS | 24120 | 11:46:44 INFO - PROCESS | 24120 | [#0] ai-astar Cycles:10 Average:107.60 Median:109.00 stddev:3.34 (3.1%) stddev-sans-first:3.54 11:46:44 INFO - PROCESS | 24120 | Values: 108.0 110.0 106.0 108.0 109.0 111.0 99.0 109.0 109.0 107.0 11:46:44 INFO - PROCESS | 24120 | 11:46:44 INFO - PROCESS | 24120 | [#1] audio-beat-detection Cycles:10 Average:150.30 Median:158.00 stddev:20.48 (13.0%) stddev-sans-first:21.71 11:46:44 INFO - PROCESS | 24120 | Values: 149.0 126.0 158.0 164.0 144.0 174.0 158.0 124.0 181.0 125.0 11:46:44 INFO - PROCESS | 24120 | 11:46:44 INFO - PROCESS | 24120 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.58 (1.0%) stddev-sans-first:1.67 11:46:44 INFO - PROCESS | 24120 | Values: 162.0 160.0 161.0 160.0 162.0 161.0 160.0 165.0 162.0 163.0 11:46:44 INFO - PROCESS | 24120 | 11:46:44 INFO - PROCESS | 24120 | [#3] audio-fft Cycles:10 Average:84.60 Median:74.00 stddev:16.52 (22.3%) stddev-sans-first:17.07 11:46:44 INFO - PROCESS | 24120 | Values: 74.0 72.0 97.0 97.0 72.0 73.0 74.0 119.0 96.0 72.0 11:46:44 INFO - PROCESS | 24120 | 11:46:44 INFO - PROCESS | 24120 | [#4] audio-oscillator Cycles:10 Average:107.00 Median:93.00 stddev:22.96 (24.7%) stddev-sans-first:23.71 11:46:44 INFO - PROCESS | 24120 | Values: 92.0 93.0 135.0 93.0 93.0 93.0 147.0 93.0 93.0 138.0 11:46:44 INFO - PROCESS | 24120 | 11:46:44 INFO - PROCESS | 24120 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:46:44 INFO - PROCESS | 24120 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 11:46:44 INFO - PROCESS | 24120 | 11:46:44 INFO - PROCESS | 24120 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 11:46:44 INFO - PROCESS | 24120 | Values: 146.0 145.0 146.0 145.0 146.0 145.0 145.0 145.0 145.0 146.0 11:46:44 INFO - PROCESS | 24120 | 11:46:44 INFO - PROCESS | 24120 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:46:44 INFO - PROCESS | 24120 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 11:46:44 INFO - PROCESS | 24120 | 11:46:44 INFO - PROCESS | 24120 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.00 stddev:3.33 (6.1%) stddev-sans-first:3.54 11:46:44 INFO - PROCESS | 24120 | Values: 55.0 54.0 57.0 54.0 55.0 54.0 55.0 64.0 53.0 52.0 11:46:44 INFO - PROCESS | 24120 | 11:46:44 INFO - PROCESS | 24120 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.99 (1.6%) stddev-sans-first:1.00 11:46:44 INFO - PROCESS | 24120 | Values: 60.0 60.0 61.0 60.0 60.0 62.0 61.0 61.0 61.0 63.0 11:46:44 INFO - PROCESS | 24120 | 11:46:44 INFO - PROCESS | 24120 | [#10] stanford-crypto-aes Cycles:10 Average:76.60 Median:77.00 stddev:0.70 (0.9%) stddev-sans-first:0.71 11:46:44 INFO - PROCESS | 24120 | Values: 76.0 77.0 77.0 76.0 77.0 77.0 76.0 76.0 78.0 76.0 11:46:44 INFO - PROCESS | 24120 | 11:46:44 INFO - PROCESS | 24120 | [#11] stanford-crypto-ccm Cycles:10 Average:110.30 Median:110.50 stddev:2.41 (2.2%) stddev-sans-first:2.55 11:46:44 INFO - PROCESS | 24120 | Values: 110.0 111.0 110.0 107.0 113.0 115.0 111.0 108.0 110.0 108.0 11:46:44 INFO - PROCESS | 24120 | 11:46:44 INFO - PROCESS | 24120 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:133.30 Median:134.00 stddev:2.50 (1.9%) stddev-sans-first:1.22 11:46:44 INFO - PROCESS | 24120 | Values: 127.0 134.0 133.0 135.0 135.0 134.0 134.0 133.0 132.0 136.0 11:46:44 INFO - PROCESS | 24120 | 11:46:44 INFO - PROCESS | 24120 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.00 stddev:1.90 (3.0%) stddev-sans-first:1.76 11:46:44 INFO - PROCESS | 24120 | Values: 66.0 62.0 65.0 62.0 63.0 62.0 63.0 62.0 62.0 67.0 11:46:44 INFO - PROCESS | 24120 | -------- Summary: end -------- 11:46:44 INFO - PROCESS | 24120 | 11:46:45 INFO - TEST-INFO | 24120: exit 0 11:46:45 INFO - TEST-OK | kraken | took 59522ms 11:46:45 INFO - SUITE-END | took 1171s 11:46:45 INFO - Completed test suite (00:19:31) 11:46:45 INFO - javascript benchmark 11:46:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3082.537619357096, 3143.8113713177195, 3186.856591453384, 3197.680231976801, 3224.838758062098, 5329.307190065296, 5399.62202645815, 5433.429489903558, 5461.481159289871, 5518.2826232589705, 5386.596005299599, 5411.621186516945, 5444.700541470217, 5454.781808727646, 5470.398256191816, 4867.902641947159, 4871.585915197213, 4893.681910675812, 4900.460949295574, 4973.303737476738, 4873.512648735116, 4898.314236006961, 4941.530554597308, 4949.529794669518, 4951.207806750921, 4798.352222449959, 4875.561199492045, 4901.142300097468, 4960.900781984358, 4967.528084831935, 4872.853814385574, 4873.756312184377, 4874.341963834872, 4895.069936712013, 4912.312276281288, 4744.4069491313585, 4828.37231159947, 4840.636952228561, 4854.368932038848, 4907.337509436216, 5280.392754833205, 5338.225957236179, 5348.705821179834, 5352.5182733553775, 5370.489803468664, 5727.656340619576, 5735.827925162252, 5741.511971482429, 5741.511971482429, 5746.396628354046, 5689.715514224314, 5779.2775903012125, 5780.595358324919, 5784.16129661201, 5789.421057894219, 5421.024215641183, 5468.043092458884, 5473.425290344497, 5495.2856128703015, 5517.531009864167, 5975.043992961106, 5976.5218782497295, 5979.19280897082, 5986.940130598726, 6019.458248757633, 5511.173324001432, 5685.971570142123, 5729.226554415184, 5741.942580574141, 5742.799002034909, 5798.768049277982, 5799.33307669615, 5801.593888427854, 5810.1865738796605, 5857.648541087548, 5724.141378793214, 5768.2501274834, 5769.624974376652, 5770.2498675171955, 5777.855553611109, 5676.233708449389, 5718.79984200551, 5783.971080144656, 5799.681017544076, 5912.438318359749, 4422.336649502536, 4422.447194100738, 4425.601695847325, 4455.042165934275, 4466.955330446719, 3917.0794863207125, 3941.9605803941595, 3942.1130245695063, 3943.881683549498, 3968.6626636735623, 5362.436944120889, 5390.4879036491475, 5462.071447853875, 5483.1227003680015, 5524.033294173503, 5848.327442344185, 5854.092615644582, 5870.5890587659305, 5876.559258055663, 5878.059510478389, 5498.560115190775, 5501.724913754297, 5510.173473978935, 5515.172724091338, 5516.889662206733, 4690.624750019991, 4774.618030557547, 4791.832285869978, 4806.615470762331, 4820.68665536739, 5972.372900845348, 5998.970005149947, 6056.06131049688, 6056.636601803906, 6057.909131363033, 5649.971750141223, 5779.104238842986, 5784.21913041734, 5831.06702927538, 5839.591228613956, 5983.790567330123, 6047.123167140828, 6048.90926636092, 6085.391460853879, 6095.0, 5661.094224923992, 5692.089265717631, 5694.686792226302, 5699.772009119589, 5708.200851880657, 5618.550515958796, 5725.971370143123, 5787.768489260551, 5793.15999180125, 5825.330087040044, 5714.571407144564, 5723.198752174782, 5728.656280623176, 5732.742026608729, 5774.711264436845, 5671.17767923657, 5673.517750991047, 5678.233438485751, 5679.204911312337, 5682.6306290091015, 5463.344398672185, 5569.860753481195, 5590.161475778503, 5600.467955544217, 5632.5212356950115, 5665.0, 5668.914966275427, 5676.858078548069, 5685.260916080883, 5691.2032315475035, 5528.944710552843, 5564.693941833238, 5564.860878478071, 5578.414266501959, 5607.271054762855], "unit": "score", "name": "dojo.html", "value": 5331.164785913364}, {"lowerIsBetter": false, "replicates": [554.2237129998356, 566.4137617565821, 589.4547543522241, 609.8261995331329, 616.3928530397559, 31832.0, 37547.43678844816, 38209.235815283675, 38252.61747382525, 38522.80738596303, 40898.79550602243, 41351.58648413515, 41373.17253654925, 41389.37915931264, 41412.37881431781, 7495.812604684899, 8511.574421278941, 8712.172343627346, 8719.302455803521, 10004.349717268391, 10196.0, 10321.12270457012, 10362.896371036268, 10371.948140259288, 10374.533146008447, 10262.179025677928, 10295.794084118314, 10317.690469285933, 10325.58697652093, 10412.271141020132, 10226.33528820628, 10349.172066234683, 10356.948215258952, 10360.585576576928, 10362.119219866321, 9995.100440960276, 10116.49417529128, 10131.44277064761, 10134.847977280348, 10345.17238620916, 40575.797121014504, 41023.589764102275, 41051.0, 41067.58932410697, 41085.794571026956, 3537.204129070964, 3595.227026189356, 3620.348337299285, 3638.563372395303, 3722.404415293567, 31441.213969650715, 31610.841945790355, 32054.0, 32159.83920080408, 32323.676763232303, 4197.601227883346, 4274.0, 4313.352997050468, 4326.156399502099, 4342.1532801103795, 314640.0, 315092.0, 315818.0, 315861.0, 316335.0, 47147.29279060817, 59075.704621476616, 59177.40822591805, 59420.0, 59569.404305956385, 46297.76851115723, 46333.30500042502, 46442.76778616085, 46453.535464645596, 46467.535324647, 14851.108933464027, 15026.624334391508, 15044.774328385083, 15049.0, 15065.246737663074, 11558.768824623461, 11617.6514704559, 11619.244749091282, 11659.242149260272, 11661.358625275521, 15722.842771572366, 15827.287772050286, 15886.52340429789, 15902.204889755465, 15907.761383579256, 6195.81412557624, 6206.441420272197, 6261.686915654199, 6280.434760871543, 6327.272363678236, 1082.1775450657399, 1082.7996820588216, 1139.9455503659083, 1154.0709728668503, 1154.8902854228834, 31133.066008019796, 31295.53056704151, 31684.0, 31888.16313998928, 32279.35441291161, 1094.7482079121687, 1111.9277246979082, 1210.4250481021445, 1226.9877301227052, 1227.1287385955893, 15865.286062127232, 16478.42325518601, 16500.83499164993, 16538.601902724036, 16703.749443758352, 390769.0, 392987.0, 395219.0, 395498.0, 396294.0, 55825.162622560696, 55896.0, 56419.0, 56426.71786641041, 56444.0, 1366.2007725480507, 1368.8152099466445, 1378.1730961423066, 1380.9792853107413, 1412.9505467308595, 27726.584101238095, 29362.853185733933, 29569.704302957554, 29625.407491850474, 30223.0, 41553.1689366217, 41785.582144178166, 42334.57665423306, 42357.788211058745, 42412.575874240865, 217683.0, 218261.0, 218899.0, 219901.0, 220796.0, 32670.0, 34240.486392704624, 48616.0, 49058.50941490539, 49147.262791057445, 46763.85591140952, 46966.76516617395, 47402.0, 47862.76068619634, 50225.497745023546, 40367.59632403756, 40662.0, 41136.58863411328, 41297.0, 42431.0, 40098.79950600345, 40871.18257634771, 41004.794976026125, 41520.79239603903, 41753.373699393924, 41318.58681413268, 42287.365689515296, 42716.57283427126, 42919.141617168105, 42935.14129717451, 36650.8167459161, 37934.24131517409, 38116.809415952746, 38526.0, 39939.60060399475, 25213.369665757768, 25680.486390271715, 25723.742762572136, 25790.226293211235, 26134.477310454065], "unit": "score", "name": "ext.html", "value": 19347.78284196402}, {"lowerIsBetter": false, "replicates": [372.43761919501554, 378.9223209242104, 379.1204405778593, 383.1991138520492, 384.19127736115496, 17562.736558951627, 18317.45047648571, 18368.265269389227, 18586.256549737995, 18608.627827443444, 17860.82139178611, 18346.816531834713, 19071.427857164308, 19072.71390929134, 19076.427707168772, 5462.0987537056335, 5604.8038318658855, 5634.9718251408685, 5637.408072152426, 5638.520725738296, 4000.4999375078114, 5626.887462250773, 5904.114382842587, 6288.717007734663, 6312.431881130698, 6186.164867742865, 6189.783357582485, 6195.163652906867, 6212.409821066992, 6218.564700470969, 5982.820515384546, 6233.0, 6238.189035425366, 6240.251169859646, 6246.843828904291, 3698.408254679265, 5297.073012222845, 5450.809221677262, 5471.945280547184, 5494.862628434281, 21606.891965540228, 21782.019809108628, 21849.781502184935, 23233.651495227587, 23246.883765581064, 2382.4996750682376, 2412.216029790325, 2620.829646073018, 2743.7804975602103, 2842.701516340796, 13861.999690156506, 14053.718925621533, 14328.785068223984, 14420.510770153369, 14564.271786410636, 2010.316492392579, 2030.0, 2044.877307361563, 2044.9877310731283, 2078.812906838392, 67004.3299567003, 71073.0, 71583.64208178977, 72964.0, 73571.26428735751, 10682.092022178202, 10819.891801082045, 11097.500612472297, 11117.11063114965, 11301.378424186585, 14284.714305713827, 14347.210903400204, 14380.640483987774, 14387.64030899215, 14392.640183995483, 7620.1998790127345, 7837.804054898673, 7871.960640196877, 7989.201079892081, 8003.639836207385, 7465.29079737424, 7500.662470188855, 7542.962285188649, 7600.771976840703, 7617.162112167657, 6542.869142617121, 6681.9331806682285, 6733.831654208586, 6806.897896531457, 6816.727330906808, 1756.998510848804, 1821.3534195360721, 1860.702287633999, 1893.6023435078787, 1893.8674292799647, 476.49729535339856, 479.85364463838164, 1020.0105897279627, 1021.2238698589126, 1081.9459027048615, 11088.833667494993, 11153.10775137987, 11242.887571124347, 11365.147613928822, 11535.480903359368, 462.49587949135605, 955.9187469065207, 984.9753756156153, 1000.6341344065298, 1060.8886066963012, 9769.706908792748, 10187.7453063674, 10212.336198147097, 10213.131883789812, 10378.325408848401, 474240.0, 485003.0, 491505.0, 500068.0, 500877.0, 81168.59415703002, 85324.14675853286, 85576.0, 85618.57190714132, 86185.56907215549, 1083.041508265191, 1103.0183137008069, 1118.7147277444199, 1126.7408496045955, 1133.9149563782585, 15615.474794841826, 15615.609609759847, 15759.842401576296, 15908.602284942968, 15957.521274361789, 36904.81547592245, 37253.81373093117, 37541.0, 37924.81037594794, 38082.238355232184, 56547.434525654215, 57104.0, 57144.0, 57238.7138064307, 57468.71265643645, 7580.9620951894885, 8076.838463230585, 8309.83380332378, 8389.161083891562, 8535.53054582004, 12348.197367171106, 12819.230846149261, 12860.164089334163, 13037.674058148623, 13257.535986240435, 11574.363410012531, 11824.290542567473, 11923.284602923852, 11960.222585531912, 11964.58123965657, 11236.55053797839, 11550.537978481103, 11560.30638161713, 11671.824922625998, 11782.0, 9512.81089863767, 10987.890121098686, 11443.713907152387, 11688.415579220835, 11928.463219154984, 8307.335413167053, 8430.367722420966, 8453.788655283666, 8458.619362128842, 8472.729090636454, 10972.526294266367, 11877.46551405206, 11952.76094478088, 12022.699432514257, 12089.0], "unit": "score", "name": "jquery.html", "value": 9007.895941838215}, {"lowerIsBetter": false, "replicates": [1323.344944252595, 1495.1104093064625, 1498.220925118938, 1688.5047950741962, 1831.917563709632, 7879.172686867875, 8002.199780021995, 8037.758867233978, 8075.232852878975, 8080.6767729290905, 7908.683652653887, 8028.3978701597325, 8048.8390232195325, 8070.394720395964, 8071.313938315236, 2054.137262349809, 2309.9191528296515, 2361.0673783855323, 2382.8451150675237, 2390.557746816836, 2385.6183010718287, 2399.0643648976825, 2404.927852164429, 2407.735149133594, 2407.807375409972, 2334.4630734930975, 2396.293093537402, 2397.904083836653, 2401.435662619283, 2403.098837935774, 2311.133325003124, 2344.0623750499767, 2350.811935045192, 2358.233574088428, 2358.7995020423286, 2342.426105604121, 2350.788429041377, 2362.7164740231283, 2405.7714517120844, 2410.3612542676206, 8242.587870606445, 8324.83350332996, 8327.20891515305, 8329.292010179142, 8336.916630833675, 5138.177891537373, 5270.631055826094, 5271.103912334912, 5278.736063196825, 5281.603879708999, 3477.078574177845, 3519.788812671248, 3560.4659301104784, 3641.089727568108, 3649.799261040642, 1119.8488204092425, 1143.2625956258166, 1143.3311512765042, 1158.2239899267427, 1197.3953153657435, 11650.533978640844, 11653.883461165364, 11656.650300490914, 11662.067034637208, 11699.590514331958, 4538.319252112209, 4539.6368290536675, 4662.813487460464, 4667.789949452283, 4672.112298663243, 9960.352577082467, 9971.451570163566, 9988.05113514215, 9992.750181245527, 10009.69970900874, 4502.212112880233, 5151.4333423323405, 5182.4299327073995, 5187.377514698185, 5200.375954885362, 4519.096180763795, 4593.356930029799, 4596.241620132708, 4615.746133962597, 4641.814327426932, 3974.6682453976605, 4027.7381970171846, 4028.436018957348, 4061.593840615974, 4084.264832330209, 1284.319310765296, 1299.051692264652, 1299.3957809618385, 1310.5871650430083, 1312.4356526693423, 809.461707964209, 1400.4818217259476, 1400.9719805603831, 1407.0, 1409.9647508812361, 8075.071366792777, 8094.838103237902, 8095.838083238302, 8097.635606397608, 8101.594920253964, 499.2511233150275, 501.7516329416962, 510.5481648740817, 513.1584201908872, 514.108022580822, 6068.150458935753, 6098.72555734993, 6113.755449782047, 6168.8766224675255, 6262.937370626327, 9919.950400247953, 10189.796204075878, 10274.897251027543, 10282.588696452207, 10308.433036182932, 9838.06538378853, 9917.65288214909, 10035.197184225244, 10107.595696172071, 10173.84739228912, 7749.961250193713, 7805.726799562101, 7818.8827167592535, 7819.960900195462, 7901.446898717149, 7399.556026638419, 7411.184769675439, 7415.8146046349275, 7535.54786712799, 7548.245175482408, 8983.371164018456, 9136.6802161924, 9148.771280717769, 9229.215516681157, 9230.400023998418, 9214.493202873906, 9361.906380936376, 9458.385204961656, 9467.810643787223, 9530.618775248913, 6283.37166283368, 6971.75598854058, 7171.4979951404985, 7421.109466864011, 7483.88774168377, 7786.18245084258, 7812.296893279405, 7828.530288182727, 7856.135825059353, 7863.646135924012, 6802.387785099365, 6937.618430986142, 6972.6862291196, 7001.929980700332, 7104.680289387094, 6850.0752398425575, 6899.413549848319, 6923.584584924921, 6948.9305106950305, 7108.182559005781, 7359.705611775469, 7377.077865266841, 7432.293932076444, 7484.887726684213, 7493.850122997401, 6795.762148324785, 6823.420009299265, 6834.248232694499, 6847.760328388483, 6870.553414028072, 6953.096097507494, 6972.0, 7024.121984751906, 7045.11936007999, 7052.0], "unit": "score", "name": "mootools.html", "value": 4683.282271661827}, {"lowerIsBetter": false, "replicates": [345.6129135368387, 350.9894703158903, 352.96999755020823, 355.60527814126317, 356.5560876708498, 6044.214252147221, 6063.120847477113, 6129.295131059935, 6131.049687298465, 6169.290531588868, 5958.255218097738, 5999.1301261317085, 6004.699765011743, 6008.459238668519, 6011.458968692817, 4374.9781251093855, 4510.939929116655, 4581.0, 4636.559526844944, 4647.163510568096, 4605.286180642006, 4615.238485649864, 4622.14490319292, 4623.86128416148, 4645.8838529036875, 4572.702774319659, 4597.195490789099, 4620.861374158764, 4627.490975992638, 4631.3516107744945, 4368.497622773374, 4475.843345482925, 4560.293154561048, 4573.382593349888, 4626.097910907374, 4062.8171732272117, 4071.1857628474127, 4076.144009757925, 4076.2051399977017, 4084.12191378852, 5773.538116950634, 5774.942250577525, 5775.220345253421, 5782.653040817564, 5783.681897495636, 5367.114426119724, 5367.355917289911, 5373.677579345252, 5374.8925021499745, 5399.973000134974, 6288.496920246369, 6293.905591416133, 6296.68516574174, 6298.937010629927, 6311.0, 4222.472190976128, 4357.324614684729, 4364.89087772805, 4395.736255824629, 4535.546445355471, 6585.341465853424, 6637.900431493483, 6651.900221496681, 6653.201615806086, 6655.999999999952, 4556.134334476439, 4560.657950653715, 4563.748993805372, 4565.315202719618, 4565.406497155415, 4618.122556714214, 4622.214223581999, 4622.491525932145, 4624.421947256593, 4628.352030715702, 5330.866728331823, 5344.064788662046, 5348.759305831247, 5353.544948679406, 5357.4106848246665, 6290.591111577733, 6383.6488993104895, 6405.839854003687, 6423.582467139714, 6434.485241180694, 1594.5057032320017, 1611.6293252551745, 1617.5309160343604, 1619.5060506545617, 1622.6998005369044, 1001.1940387987594, 1052.2476429353048, 1066.6853278282924, 1066.7919755647729, 1083.5828206140693, 6139.96930015356, 6141.293751218667, 6149.446549810449, 6154.692265386802, 6154.753809847556, 6516.120323756327, 6542.476601871839, 6548.083268342436, 6550.639714815731, 6556.967215163989, 6154.78458253959, 6158.199434073542, 6179.3202747697715, 6222.3466536013975, 6226.283977342573, 3501.1772233525103, 3530.646935306449, 3531.876384326536, 3533.293341331744, 3537.5931767846514, 6582.670866456754, 6776.830579235559, 6777.288384719632, 6782.69477873487, 6796.116504854337, 6648.66756662165, 6654.800355989328, 6660.200775906922, 6663.833404164838, 6670.299618540081, 6728.6635668216395, 6738.393544581109, 6742.49431292655, 6742.5280230383405, 6751.493637977172, 6495.967520162369, 6517.283098859217, 6519.315471875385, 6525.3800888915475, 6546.214454265519, 6360.840978975562, 6423.96788016057, 6436.0, 6614.900776488453, 6646.667666616747, 6935.549189302679, 6940.271271516418, 6958.0, 6958.965205173941, 6973.47698922593, 4535.546445355438, 4543.54564543543, 4569.086182763527, 4569.977150114228, 4575.65682573815, 6566.474682025331, 6606.405423511907, 6634.402903738686, 6639.634820084942, 6648.867022659617, 6310.432061114522, 6427.164468619237, 6439.935600643934, 6440.194975628046, 6450.903236451551, 6320.893843577447, 6360.49116070704, 6390.616563006234, 6391.360863913572, 6404.327545607644, 6238.532110091671, 6284.151639528605, 6286.4342209201395, 6291.96854015727, 6304.968475157595, 6367.840803979938, 6427.17204430068, 6429.7428102875365, 6433.195850518685, 6435.259945106185, 6004.0093384591055, 6126.0, 6248.500119990299, 6270.4670103039925, 6283.340249273943], "unit": "score", "name": "prototype.html", "value": 4819.502119015202}, {"lowerIsBetter": false, "replicates": [852.6193642208641, 853.3258725606771, 855.1662129423812, 860.1914200651389, 867.11554214701, 13561.525346612858, 13612.319384030796, 13678.863211367883, 13748.656283592914, 14067.648308792286, 13503.527376541822, 13546.525871594496, 13564.525241616546, 13565.932170339134, 13638.454461821515, 653.6111013946718, 797.2266901105918, 808.6482380164617, 811.4887620798888, 824.3034635732796, 824.7072289337259, 825.2572684583893, 826.3471857232779, 827.6441130313963, 828.457360428917, 864.3258258558303, 869.5739087846941, 870.0820634230884, 870.4777133719781, 873.1268731268731, 695.2005194026859, 852.3735054734765, 865.0916537635458, 865.5715420866649, 866.2593482572436, 632.3739497897095, 632.5129650169343, 633.2116514938931, 633.4647223096476, 635.0505993539641, 13906.652333691638, 13963.65090872726, 13978.510752123628, 13992.370343334574, 13998.0, 13442.865571344259, 13880.61193880614, 13928.651783705489, 13933.0, 14730.410783568645, 11642.534298628045, 11664.0, 11939.34333611651, 11973.820392694117, 12005.699857503545, 3782.167923056923, 3796.734228603999, 3871.632194941476, 3882.650561449455, 3897.2984862724697, 54546.727266363414, 54598.0, 54632.180517292276, 54676.726616367065, 54816.0, 11298.0, 11370.260933039326, 11710.238834475731, 11828.349440780668, 11875.287482751062, 19726.802731972784, 19861.106250218774, 19885.701714474293, 19918.50203744918, 19938.60122797536, 8168.7957801055445, 8740.431871928304, 8743.081976392514, 8903.19871211594, 8938.24024957886, 4903.754812259373, 5041.092603331435, 5047.4447810740785, 5052.747362631853, 5097.388313402415, 3501.807400592992, 3560.127768696686, 3564.108972756811, 3564.6791788739138, 3565.322588708137, 569.0695712509993, 592.7540070870626, 621.5773274173605, 639.0892977507034, 655.0305547789203, 580.5645765675744, 591.4920736078994, 708.4544900426642, 738.8710645198095, 799.9320057795036, 9323.25413966881, 9454.290928180413, 9753.658621948198, 9771.413715177112, 9778.706638800848, 635.580516858871, 781.5037451218403, 791.9010123734533, 806.7620052084649, 812.9634166462523, 4583.312503124558, 4612.123696497655, 4702.224133018014, 4731.1720448921305, 4759.881002974884, 60497.69751151216, 60882.0, 61369.69315153396, 61578.38421615816, 61588.0, 54566.72716636391, 54814.72592637011, 54941.1758823618, 56030.43969560252, 56656.0, 48877.0, 49087.509124909724, 50294.24558631623, 50305.0, 51166.0, 9321.021292764162, 9390.812183756423, 9688.176504997155, 9920.503974801086, 9996.500174991366, 38772.0, 39525.2094958105, 39587.80206098951, 40505.392419113145, 40569.59430405776, 48258.5174148254, 48812.0, 49048.50951490439, 49671.25493117679, 50195.0, 11909.642710718692, 12031.338276394883, 12055.51777928873, 12201.938990304992, 12217.816732749194, 13280.136791108547, 13494.52769153075, 13508.797368039292, 13751.931240343734, 14679.412823487368, 12934.417951192407, 12942.352882355655, 13081.60755177308, 13081.672958176121, 13380.732385352434, 12414.813777793159, 12603.243805371707, 12671.0, 12735.80896286538, 13226.801597975846, 12219.69450763738, 12321.260724356567, 12365.876341236832, 12691.492340306284, 12720.300383478627, 10792.514336854703, 11065.446727663424, 11093.16801239894, 11143.442827858737, 11414.828777568177, 9781.60873565078, 10877.347359158475, 10930.562777489129, 10948.288361256811, 10949.945250273699], "unit": "score", "name": "yui.html", "value": 6898.917160727545}], "name": "dromaeo_css", "value": 7245.606278752809}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 106.0, 108.0, 109.0, 111.0, 99.0, 109.0, 109.0, 107.0], "unit": "score", "name": "ai-astar", "value": 107.6}, {"lowerIsBetter": true, "replicates": [149.0, 126.0, 158.0, 164.0, 144.0, 174.0, 158.0, 124.0, 181.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 150.3}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 161.0, 160.0, 162.0, 161.0, 160.0, 165.0, 162.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 97.0, 97.0, 72.0, 73.0, 74.0, 119.0, 96.0, 72.0], "unit": "score", "name": "audio-fft", "value": 84.6}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 135.0, 93.0, 93.0, 93.0, 147.0, 93.0, 93.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 107.0}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [55.0, 54.0, 57.0, 54.0, 55.0, 54.0, 55.0, 64.0, 53.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.3}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 61.0, 60.0, 60.0, 62.0, 61.0, 61.0, 61.0, 63.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 60.9}, {"lowerIsBetter": true, "replicates": [76.0, 77.0, 77.0, 76.0, 77.0, 77.0, 76.0, 76.0, 78.0, 76.0], "unit": "score", "name": "stanford-crypto-aes", "value": 76.6}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 110.0, 107.0, 113.0, 115.0, 111.0, 108.0, 110.0, 108.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 110.3}, {"lowerIsBetter": true, "replicates": [127.0, 134.0, 133.0, 135.0, 135.0, 134.0, 134.0, 133.0, 132.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 133.3}, {"lowerIsBetter": true, "replicates": [66.0, 62.0, 65.0, 62.0, 63.0, 62.0, 63.0, 62.0, 62.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 63.4}], "name": "kraken", "value": 1468.3}]} 11:46:46 INFO - Return code: 0 11:46:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:46:46 ERROR - # TBPL SUCCESS # 11:46:46 INFO - Running post-action listener: _resource_record_post_action 11:46:46 INFO - Running post-run listener: _resource_record_post_run 11:46:47 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 155648; Write bytes: 539127808; Read time: 888; Write time: 442288 11:46:47 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 32768; Write bytes: 242159616; Read time: 268; Write time: 258188 11:46:47 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 122880; Write bytes: 296370176; Read time: 620; Write time: 184100 11:46:47 INFO - Running post-run listener: _upload_blobber_files 11:46:47 INFO - Blob upload gear active. 11:46:47 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:46:47 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:46:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 11:46:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 11:46:47 INFO - (blobuploader) - INFO - Open directory for files ... 11:46:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 11:46:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:46:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:46:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:46:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:46:48 INFO - (blobuploader) - INFO - Done attempting. 11:46:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:46:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:46:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:46:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:46:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:46:49 INFO - (blobuploader) - INFO - Done attempting. 11:46:49 INFO - (blobuploader) - INFO - Iteration through files over. 11:46:49 INFO - Return code: 0 11:46:49 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:46:49 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:46:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/515420bf8a0f537e693dbf14be56682f48acd2c541c18985ee89d03faf4451eced7c46630428ec3b1860a1febb8fe6b83b583b44102b0e0a89fa0aae3000126a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0c8f6be9973d57cac0100551874eba4f0ba80cd6b1f6a7ed4e3a1a19a78e3968da06c6d82aaed9ce3ca1e14e9d7bbd0c2033f57d8149afe357dd58b0956b462"} 11:46:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:46:49 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:46:49 INFO - Contents: 11:46:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/515420bf8a0f537e693dbf14be56682f48acd2c541c18985ee89d03faf4451eced7c46630428ec3b1860a1febb8fe6b83b583b44102b0e0a89fa0aae3000126a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0c8f6be9973d57cac0100551874eba4f0ba80cd6b1f6a7ed4e3a1a19a78e3968da06c6d82aaed9ce3ca1e14e9d7bbd0c2033f57d8149afe357dd58b0956b462"} 11:46:49 INFO - Running post-run listener: copy_logs_to_upload_dir 11:46:49 INFO - Copying logs to upload dir... 11:46:49 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 11:46:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.526872 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-03-18 11:46:49.334872) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-18 11:46:49.338644) ========= 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=836cfdc75598d54cb747368e000001a9-1458325581.122532-384308191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/515420bf8a0f537e693dbf14be56682f48acd2c541c18985ee89d03faf4451eced7c46630428ec3b1860a1febb8fe6b83b583b44102b0e0a89fa0aae3000126a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0c8f6be9973d57cac0100551874eba4f0ba80cd6b1f6a7ed4e3a1a19a78e3968da06c6d82aaed9ce3ca1e14e9d7bbd0c2033f57d8149afe357dd58b0956b462"} build_url:https://queue.taskcluster.net/v1/task/f8otThnQTHO9EXEy3jXN6w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011335 build_url: 'https://queue.taskcluster.net/v1/task/f8otThnQTHO9EXEy3jXN6w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/515420bf8a0f537e693dbf14be56682f48acd2c541c18985ee89d03faf4451eced7c46630428ec3b1860a1febb8fe6b83b583b44102b0e0a89fa0aae3000126a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0c8f6be9973d57cac0100551874eba4f0ba80cd6b1f6a7ed4e3a1a19a78e3968da06c6d82aaed9ce3ca1e14e9d7bbd0c2033f57d8149afe357dd58b0956b462"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-18 11:46:49.368768) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 11:46:49.369542) ========= 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=836cfdc75598d54cb747368e000001a9-1458325581.122532-384308191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004399 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 11:46:49.454793) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-18 11:46:49.455151) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-18 11:46:49.455482) ========= ========= Total master_lag: 0.28 =========