builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-008 starttime: 1455692073.75 results: success (0) buildid: 20160216203241 builduid: 720eec33c4864076a5ef3fdabf757eb5 revision: db7c5f35321fae1b076a088553ec92a9b89d883b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-16 22:54:33.753583) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-16 22:54:33.753977) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-16 22:54:33.754286) ========= 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=32c5991c409366f7fec8a718000001d2-1455688561.831153-228785954 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006455 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-16 22:54:33.778108) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-16 22:54:33.778419) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-16 22:54:33.794858) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 22:54:33.795198) ========= 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=32c5991c409366f7fec8a718000001d2-1455688561.831153-228785954 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004575 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 22:54:33.844479) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-16 22:54:33.844773) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-16 22:54:33.845137) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 22:54:33.845412) ========= 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=32c5991c409366f7fec8a718000001d2-1455688561.831153-228785954 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-16 22:54:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.4M=0s 2016-02-16 22:54:34 (35.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.139018 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 22:54:34.002456) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 22:54:34.002734) ========= 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=32c5991c409366f7fec8a718000001d2-1455688561.831153-228785954 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020499 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 22:54:34.051223) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 22:54:34.051521) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev db7c5f35321fae1b076a088553ec92a9b89d883b --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 db7c5f35321fae1b076a088553ec92a9b89d883b --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=32c5991c409366f7fec8a718000001d2-1455688561.831153-228785954 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-16 22:54:34,472 truncating revision to first 12 chars 2016-02-16 22:54:34,472 Setting DEBUG logging. 2016-02-16 22:54:34,472 attempt 1/10 2016-02-16 22:54:34,473 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/db7c5f35321f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-16 22:54:34,732 unpacking tar archive at: fx-team-db7c5f35321f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.548443 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 22:54:34.613613) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-16 22:54:34.613990) ========= echo db7c5f35321fae1b076a088553ec92a9b89d883b in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'db7c5f35321fae1b076a088553ec92a9b89d883b'] 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=32c5991c409366f7fec8a718000001d2-1455688561.831153-228785954 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False db7c5f35321fae1b076a088553ec92a9b89d883b program finished with exit code 0 elapsedTime=0.003840 script_repo_revision: 'db7c5f35321fae1b076a088553ec92a9b89d883b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-16 22:54:34.663688) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-16 22:54:34.664045) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-16 22:54:34.675384) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-02-16 22:54:34.675740) ========= /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=32c5991c409366f7fec8a718000001d2-1455688561.831153-228785954 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:54:35 INFO - MultiFileLogger online at 20160216 22:54:35 in /builds/slave/test-pgo 22:54:35 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 22:54:35 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:54:35 INFO - {'append_to_log': False, 22:54:35 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:54:35 INFO - 'blob_upload_branch': 'Fx-Team', 22:54:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:54:35 INFO - 'branch': 'Fx-Team', 22:54:35 INFO - 'buildbot_json_path': 'buildprops.json', 22:54:35 INFO - 'config_files': ('talos/linux_config.py',), 22:54:35 INFO - 'default_actions': ('clobber', 22:54:35 INFO - 'read-buildbot-config', 22:54:35 INFO - 'download-and-extract', 22:54:35 INFO - 'populate-webroot', 22:54:35 INFO - 'create-virtualenv', 22:54:35 INFO - 'install', 22:54:35 INFO - 'run-tests'), 22:54:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:54:35 INFO - 'download_minidump_stackwalk': True, 22:54:35 INFO - 'download_symbols': 'ondemand', 22:54:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:54:35 INFO - 'tooltool.py': '/tools/tooltool.py', 22:54:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:54:35 INFO - '/tools/misc-python/virtualenv.py')}, 22:54:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:54:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:54:35 INFO - 'installer_path': 'installer.exe', 22:54:35 INFO - 'log_level': 'info', 22:54:35 INFO - 'log_name': 'talos', 22:54:35 INFO - 'log_to_console': True, 22:54:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:54:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:54:35 INFO - 'opt_config_files': (), 22:54:35 INFO - 'pip_index': False, 22:54:35 INFO - 'sps_profile': False, 22:54:35 INFO - 'sps_profile_interval': 0, 22:54:35 INFO - 'suite': 'dromaeojs', 22:54:35 INFO - 'system_bits': '32', 22:54:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:54:35 INFO - 'title': 'talos-linux64-ix-008', 22:54:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:54:35 INFO - 'use_talos_json': True, 22:54:35 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:54:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:54:35 INFO - 'work_dir': 'build'} 22:54:35 INFO - ##### 22:54:35 INFO - ##### Running clobber step. 22:54:35 INFO - ##### 22:54:35 INFO - Running pre-action listener: _resource_record_pre_action 22:54:35 INFO - Running main action method: clobber 22:54:35 INFO - rmtree: /builds/slave/test-pgo/build 22:54:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:54:36 INFO - Running post-action listener: _resource_record_post_action 22:54:36 INFO - ##### 22:54:36 INFO - ##### Running read-buildbot-config step. 22:54:36 INFO - ##### 22:54:36 INFO - Running pre-action listener: _resource_record_pre_action 22:54:36 INFO - Running main action method: read_buildbot_config 22:54:36 INFO - Using buildbot properties: 22:54:36 INFO - { 22:54:36 INFO - "project": "", 22:54:36 INFO - "product": "firefox", 22:54:36 INFO - "script_repo_revision": "production", 22:54:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:54:36 INFO - "repository": "", 22:54:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 22:54:36 INFO - "buildid": "20160216203241", 22:54:36 INFO - "pgo_build": "True", 22:54:36 INFO - "basedir": "/builds/slave/test-pgo", 22:54:36 INFO - "buildnumber": 499, 22:54:36 INFO - "slavename": "talos-linux64-ix-008", 22:54:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:54:36 INFO - "platform": "ubuntu64_hw", 22:54:36 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 22:54:36 INFO - "branch": "fx-team", 22:54:36 INFO - "repo_path": "integration/fx-team", 22:54:36 INFO - "revision": "db7c5f35321fae1b076a088553ec92a9b89d883b", 22:54:36 INFO - "stage_platform": "linux64-pgo", 22:54:36 INFO - "builduid": "720eec33c4864076a5ef3fdabf757eb5", 22:54:36 INFO - "slavebuilddir": "test" 22:54:36 INFO - } 22:54:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/GW6Y9T6JRzuB4kHAxxRXJw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 22:54:36 INFO - Running post-action listener: _resource_record_post_action 22:54:36 INFO - ##### 22:54:36 INFO - ##### Running download-and-extract step. 22:54:36 INFO - ##### 22:54:36 INFO - Running pre-action listener: _resource_record_pre_action 22:54:36 INFO - Running main action method: download_and_extract 22:54:36 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:36 INFO - https://queue.taskcluster.net/v1/task/GW6Y9T6JRzuB4kHAxxRXJw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:54:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GW6Y9T6JRzuB4kHAxxRXJw/artifacts/public/build/test_packages.json 22:54:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GW6Y9T6JRzuB4kHAxxRXJw/artifacts/public/build/test_packages.json 22:54:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GW6Y9T6JRzuB4kHAxxRXJw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:54:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GW6Y9T6JRzuB4kHAxxRXJw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:54:39 INFO - Downloaded 1448 bytes. 22:54:39 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:54:39 INFO - Using the following test package requirements: 22:54:39 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:54:39 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:39 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:54:39 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:39 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:54:39 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:39 INFO - u'jsshell-linux-x86_64.zip'], 22:54:39 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:39 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:54:39 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:54:39 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:39 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:54:39 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:39 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:54:39 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:39 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:54:39 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:54:39 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:54:39 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:54:39 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:54:39 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')]} 22:54:39 INFO - https://queue.taskcluster.net/v1/task/GW6Y9T6JRzuB4kHAxxRXJw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:54:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GW6Y9T6JRzuB4kHAxxRXJw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:54:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GW6Y9T6JRzuB4kHAxxRXJw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:54:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GW6Y9T6JRzuB4kHAxxRXJw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:54:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GW6Y9T6JRzuB4kHAxxRXJw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:54:46 INFO - Downloaded 23343630 bytes. 22:54:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:54:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:54:48 INFO - Return code: 0 22:54:48 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:48 INFO - https://queue.taskcluster.net/v1/task/GW6Y9T6JRzuB4kHAxxRXJw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:54:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GW6Y9T6JRzuB4kHAxxRXJw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:54:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GW6Y9T6JRzuB4kHAxxRXJw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:54:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GW6Y9T6JRzuB4kHAxxRXJw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:54:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GW6Y9T6JRzuB4kHAxxRXJw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:54:50 INFO - Downloaded 23343630 bytes. 22:54:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:54:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:54:51 INFO - Return code: 0 22:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:51 INFO - https://queue.taskcluster.net/v1/task/GW6Y9T6JRzuB4kHAxxRXJw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:54:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GW6Y9T6JRzuB4kHAxxRXJw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:54:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GW6Y9T6JRzuB4kHAxxRXJw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:54:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GW6Y9T6JRzuB4kHAxxRXJw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:54:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GW6Y9T6JRzuB4kHAxxRXJw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:54:53 INFO - Downloaded 10707071 bytes. 22:54:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:54:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 22:54:53 INFO - Return code: 0 22:54: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')]} 22:54:53 INFO - https://queue.taskcluster.net/v1/task/GW6Y9T6JRzuB4kHAxxRXJw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:54:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GW6Y9T6JRzuB4kHAxxRXJw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:54:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GW6Y9T6JRzuB4kHAxxRXJw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:54:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GW6Y9T6JRzuB4kHAxxRXJw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:54:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GW6Y9T6JRzuB4kHAxxRXJw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:54:56 INFO - Downloaded 56566172 bytes. 22:54:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GW6Y9T6JRzuB4kHAxxRXJw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:54:56 INFO - mkdir: /builds/slave/test-pgo/properties 22:54:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:54:56 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:54:56 INFO - Contents: 22:54:56 INFO - build_url:https://queue.taskcluster.net/v1/task/GW6Y9T6JRzuB4kHAxxRXJw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:54:56 INFO - Running post-action listener: _resource_record_post_action 22:54:56 INFO - Running post-action listener: set_extra_try_arguments 22:54:56 INFO - ##### 22:54:56 INFO - ##### Running populate-webroot step. 22:54:56 INFO - ##### 22:54:56 INFO - Running pre-action listener: _resource_record_pre_action 22:54:56 INFO - Running main action method: populate_webroot 22:54:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:54:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:54:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:54:57 INFO - '--tppagecycles', 22:54:57 INFO - '7'], 22:54:57 INFO - 'tests': ['tsvgm']}}, 22:54:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:54:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:54:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:54:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:54:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:54:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:54:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:54:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:57 INFO - 'talos_options': ['--e10s'], 22:54:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:54:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:57 INFO - 'tests': ['damp', 'tps']}, 22:54:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:57 INFO - 'talos_options': ['--e10s'], 22:54:57 INFO - 'tests': ['damp', 'tps']}, 22:54:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:54:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:54:57 INFO - 'other': {'tests': ['a11yr', 22:54:57 INFO - 'ts_paint', 22:54:57 INFO - 'tpaint', 22:54:57 INFO - 'sessionrestore', 22:54:57 INFO - 'sessionrestore_no_auto_restore']}, 22:54:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:54:57 INFO - 'tests': ['a11yr', 22:54:57 INFO - 'ts_paint', 22:54:57 INFO - 'tpaint', 22:54:57 INFO - 'sessionrestore', 22:54:57 INFO - 'sessionrestore_no_auto_restore']}, 22:54:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:54:57 INFO - 'tests': ['a11yr', 22:54:57 INFO - 'ts_paint', 22:54:57 INFO - 'tpaint', 22:54:57 INFO - 'sessionrestore', 22:54:57 INFO - 'sessionrestore_no_auto_restore']}, 22:54:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:54:57 INFO - 'tests': ['a11yr', 22:54:57 INFO - 'ts_paint', 22:54:57 INFO - 'tpaint', 22:54:57 INFO - 'sessionrestore', 22:54:57 INFO - 'sessionrestore_no_auto_restore']}, 22:54:57 INFO - 'other_l64': {'tests': ['a11yr', 22:54:57 INFO - 'ts_paint', 22:54:57 INFO - 'tpaint', 22:54:57 INFO - 'sessionrestore', 22:54:57 INFO - 'sessionrestore_no_auto_restore']}, 22:54:57 INFO - 'other_nol64': {'tests': ['a11yr', 22:54:57 INFO - 'ts_paint', 22:54:57 INFO - 'tpaint', 22:54:57 INFO - 'sessionrestore', 22:54:57 INFO - 'sessionrestore_no_auto_restore']}, 22:54:57 INFO - 'svgr': {'tests': ['tsvgx', 22:54:57 INFO - 'tsvgr_opacity', 22:54:57 INFO - 'tart', 22:54:57 INFO - 'tscrollx', 22:54:57 INFO - 'cart']}, 22:54:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:54:57 INFO - 'tests': ['tsvgx', 22:54:57 INFO - 'tsvgr_opacity', 22:54:57 INFO - 'tart', 22:54:57 INFO - 'tscrollx', 22:54:57 INFO - 'cart']}, 22:54:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:57 INFO - 'tests': ['tp5o']}, 22:54:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:57 INFO - 'talos_options': ['--e10s'], 22:54:57 INFO - 'tests': ['tp5o']}, 22:54:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:57 INFO - 'talos_options': ['--xperf_path', 22:54:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:54:57 INFO - 'tests': ['tp5n']}, 22:54:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:54:57 INFO - 'talos_options': ['--e10s', 22:54:57 INFO - '--xperf_path', 22:54:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:54:57 INFO - 'tests': ['tp5n']}}, 22:54:57 INFO - 'talos.zip': {'path': '', 22:54:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:54:57 INFO - Running post-action listener: _resource_record_post_action 22:54:57 INFO - ##### 22:54:57 INFO - ##### Running create-virtualenv step. 22:54:57 INFO - ##### 22:54:57 INFO - Running pre-action listener: _resource_record_pre_action 22:54:57 INFO - Running main action method: create_virtualenv 22:54:57 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:54:57 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 22:54:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:54:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:54:57 INFO - Using real prefix '/usr' 22:54:57 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:54:57 INFO - Installing distribute.............................................................................................................................................................................................done. 22:54:59 INFO - Installing pip.................done. 22:54:59 INFO - Return code: 0 22:54:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:59 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 0x7f797f7c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2895670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29248c0>, '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 0x29257c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2925c50>, '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': '32c5991c409366f7fec8a718000001d2-1455688561.831153-228785954', '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 22:54:59 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 22:54:59 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 22:54:59 INFO - Using env: {'DISPLAY': ':0', 22:54:59 INFO - 'HOME': '/home/cltbld', 22:54:59 INFO - 'LANG': 'en_US.UTF-8', 22:54:59 INFO - 'LANGUAGE': 'en_US:en', 22:54:59 INFO - 'LOGNAME': 'cltbld', 22:54:59 INFO - 'MAIL': '/var/mail/cltbld', 22:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:59 INFO - 'MOZ_NO_REMOTE': '1', 22:54:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:59 INFO - 'NO_EM_RESTART': '1', 22:54:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:59 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:59 INFO - 'SHELL': '/bin/bash', 22:54:59 INFO - 'SHLVL': '1', 22:54:59 INFO - 'TERM': 'linux', 22:54:59 INFO - 'TMOUT': '86400', 22:54:59 INFO - 'USER': 'cltbld', 22:54:59 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455688561.831153-228785954', 22:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:59 INFO - '_': '/tools/buildbot/bin/python'} 22:54:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:59 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 22:54:59 INFO - Cleaning up... 22:54:59 INFO - Return code: 0 22:54:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:59 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 0x7f797f7c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2895670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29248c0>, '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 0x29257c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2925c50>, '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': '32c5991c409366f7fec8a718000001d2-1455688561.831153-228785954', '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 22:54:59 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 22:54:59 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 22:54:59 INFO - Using env: {'DISPLAY': ':0', 22:54:59 INFO - 'HOME': '/home/cltbld', 22:54:59 INFO - 'LANG': 'en_US.UTF-8', 22:54:59 INFO - 'LANGUAGE': 'en_US:en', 22:54:59 INFO - 'LOGNAME': 'cltbld', 22:54:59 INFO - 'MAIL': '/var/mail/cltbld', 22:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:59 INFO - 'MOZ_NO_REMOTE': '1', 22:54:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:59 INFO - 'NO_EM_RESTART': '1', 22:54:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:59 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:59 INFO - 'SHELL': '/bin/bash', 22:54:59 INFO - 'SHLVL': '1', 22:54:59 INFO - 'TERM': 'linux', 22:54:59 INFO - 'TMOUT': '86400', 22:54:59 INFO - 'USER': 'cltbld', 22:54:59 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455688561.831153-228785954', 22:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:59 INFO - '_': '/tools/buildbot/bin/python'} 22:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:00 INFO - Downloading/unpacking psutil>=0.7.1 22:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:55:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:55:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:55:01 INFO - Installing collected packages: psutil 22:55:01 INFO - Running setup.py install for psutil 22:55:02 INFO - building 'psutil._psutil_linux' extension 22:55:02 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 22:55:02 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 22:55:02 INFO - building 'psutil._psutil_posix' extension 22:55:02 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 22:55:02 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 22:55:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:55:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:55:02 INFO - Successfully installed psutil 22:55:02 INFO - Cleaning up... 22:55:02 INFO - Return code: 0 22:55:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:55:02 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')]} 22:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:02 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')]} 22:55:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:02 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 0x7f797f7c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2895670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29248c0>, '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 0x29257c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2925c50>, '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': '32c5991c409366f7fec8a718000001d2-1455688561.831153-228785954', '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 22:55:02 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 22:55:02 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 22:55:02 INFO - Using env: {'DISPLAY': ':0', 22:55:02 INFO - 'HOME': '/home/cltbld', 22:55:02 INFO - 'LANG': 'en_US.UTF-8', 22:55:02 INFO - 'LANGUAGE': 'en_US:en', 22:55:02 INFO - 'LOGNAME': 'cltbld', 22:55:02 INFO - 'MAIL': '/var/mail/cltbld', 22:55:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:02 INFO - 'MOZ_NO_REMOTE': '1', 22:55:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:02 INFO - 'NO_EM_RESTART': '1', 22:55:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:55:02 INFO - 'PWD': '/builds/slave/test-pgo', 22:55:02 INFO - 'SHELL': '/bin/bash', 22:55:02 INFO - 'SHLVL': '1', 22:55:02 INFO - 'TERM': 'linux', 22:55:02 INFO - 'TMOUT': '86400', 22:55:02 INFO - 'USER': 'cltbld', 22:55:02 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455688561.831153-228785954', 22:55:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:02 INFO - '_': '/tools/buildbot/bin/python'} 22:55:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:55:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:55:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:55:04 INFO - Installing collected packages: mozsystemmonitor 22:55:04 INFO - Running setup.py install for mozsystemmonitor 22:55:04 INFO - Successfully installed mozsystemmonitor 22:55:04 INFO - Cleaning up... 22:55:04 INFO - Return code: 0 22:55:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:55:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:04 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 0x7f797f7c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2895670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29248c0>, '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 0x29257c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2925c50>, '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': '32c5991c409366f7fec8a718000001d2-1455688561.831153-228785954', '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 22:55:04 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 22:55:04 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 22:55:04 INFO - Using env: {'DISPLAY': ':0', 22:55:04 INFO - 'HOME': '/home/cltbld', 22:55:04 INFO - 'LANG': 'en_US.UTF-8', 22:55:04 INFO - 'LANGUAGE': 'en_US:en', 22:55:04 INFO - 'LOGNAME': 'cltbld', 22:55:04 INFO - 'MAIL': '/var/mail/cltbld', 22:55:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:04 INFO - 'MOZ_NO_REMOTE': '1', 22:55:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:04 INFO - 'NO_EM_RESTART': '1', 22:55:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:55:04 INFO - 'PWD': '/builds/slave/test-pgo', 22:55:04 INFO - 'SHELL': '/bin/bash', 22:55:04 INFO - 'SHLVL': '1', 22:55:04 INFO - 'TERM': 'linux', 22:55:04 INFO - 'TMOUT': '86400', 22:55:04 INFO - 'USER': 'cltbld', 22:55:04 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455688561.831153-228785954', 22:55:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:04 INFO - '_': '/tools/buildbot/bin/python'} 22:55:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:05 INFO - Downloading/unpacking blobuploader==1.2.4 22:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:06 INFO - Downloading blobuploader-1.2.4.tar.gz 22:55:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:55:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:55:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:55:07 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 22:55:07 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 22:55:07 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 22:55:07 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 22:55:07 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 22:55:07 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 22:55:07 INFO - Downloading docopt-0.6.1.tar.gz 22:55:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:55:07 INFO - Installing collected packages: blobuploader, requests, docopt 22:55:07 INFO - Running setup.py install for blobuploader 22:55:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:55:07 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:55:07 INFO - Running setup.py install for requests 22:55:08 INFO - Running setup.py install for docopt 22:55:08 INFO - Successfully installed blobuploader requests docopt 22:55:08 INFO - Cleaning up... 22:55:08 INFO - Return code: 0 22:55:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:55:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:08 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 0x7f797f7c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2895670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29248c0>, '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 0x29257c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2925c50>, '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': '32c5991c409366f7fec8a718000001d2-1455688561.831153-228785954', '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 22:55:08 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 22:55:08 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 22:55:08 INFO - Using env: {'DISPLAY': ':0', 22:55:08 INFO - 'HOME': '/home/cltbld', 22:55:08 INFO - 'LANG': 'en_US.UTF-8', 22:55:08 INFO - 'LANGUAGE': 'en_US:en', 22:55:08 INFO - 'LOGNAME': 'cltbld', 22:55:08 INFO - 'MAIL': '/var/mail/cltbld', 22:55:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:08 INFO - 'MOZ_NO_REMOTE': '1', 22:55:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:08 INFO - 'NO_EM_RESTART': '1', 22:55:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:55:08 INFO - 'PWD': '/builds/slave/test-pgo', 22:55:08 INFO - 'SHELL': '/bin/bash', 22:55:08 INFO - 'SHLVL': '1', 22:55:08 INFO - 'TERM': 'linux', 22:55:08 INFO - 'TMOUT': '86400', 22:55:08 INFO - 'USER': 'cltbld', 22:55:08 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455688561.831153-228785954', 22:55:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:08 INFO - '_': '/tools/buildbot/bin/python'} 22:55:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:55:08 INFO - Running setup.py (path:/tmp/pip-iGvkZg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:55:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:55:08 INFO - Running setup.py (path:/tmp/pip-3UPu9g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:55:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:55:08 INFO - Running setup.py (path:/tmp/pip-rzF3Le-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:55:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:55:08 INFO - Running setup.py (path:/tmp/pip-1xIPPU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:55:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:55:08 INFO - Running setup.py (path:/tmp/pip-vXm_KI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:55:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:55:08 INFO - Running setup.py (path:/tmp/pip-7EjbQK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:55:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:55:08 INFO - Running setup.py (path:/tmp/pip-yykBDC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:55:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:55:08 INFO - Running setup.py (path:/tmp/pip-nDPdnG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:55:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:55:09 INFO - Running setup.py (path:/tmp/pip-dv3gQB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:55:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:55:09 INFO - Running setup.py (path:/tmp/pip-6wwaMa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:55:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:55:09 INFO - Running setup.py (path:/tmp/pip-pWzuAo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:55:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:55:09 INFO - Running setup.py (path:/tmp/pip-ZhaDMI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:55:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:55:09 INFO - Running setup.py (path:/tmp/pip-Heirip-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:55:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:55:09 INFO - Running setup.py (path:/tmp/pip-Q621Mj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:55:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:55:09 INFO - Running setup.py (path:/tmp/pip-EUEp3U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:55:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:55:09 INFO - Running setup.py (path:/tmp/pip-O7YliI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:55:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:55:09 INFO - Running setup.py (path:/tmp/pip-wO3sQK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:55:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:55:09 INFO - Running setup.py install for manifestparser 22:55:09 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:55:09 INFO - Running setup.py install for mozcrash 22:55:09 INFO - Running setup.py install for mozdebug 22:55:09 INFO - Running setup.py install for mozdevice 22:55:10 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:55:10 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:55:10 INFO - Running setup.py install for mozfile 22:55:10 INFO - Running setup.py install for mozhttpd 22:55:10 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:55:10 INFO - Running setup.py install for mozinfo 22:55:10 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:55:10 INFO - Running setup.py install for mozInstall 22:55:10 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:55:10 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:55:10 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:55:10 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:55:10 INFO - Running setup.py install for mozleak 22:55:10 INFO - Running setup.py install for mozlog 22:55:10 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:55:10 INFO - Running setup.py install for moznetwork 22:55:10 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:55:10 INFO - Running setup.py install for mozprocess 22:55:10 INFO - Running setup.py install for mozprofile 22:55:11 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:55:11 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:55:11 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:55:11 INFO - Running setup.py install for mozrunner 22:55:11 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:55:11 INFO - Running setup.py install for mozscreenshot 22:55:11 INFO - Running setup.py install for moztest 22:55:11 INFO - Running setup.py install for mozversion 22:55:11 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:55:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:55:11 INFO - Cleaning up... 22:55:11 INFO - Return code: 0 22:55:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:55:11 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')]} 22:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:11 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')]} 22:55:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:11 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 0x7f797f7c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2895670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29248c0>, '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 0x29257c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2925c50>, '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': '32c5991c409366f7fec8a718000001d2-1455688561.831153-228785954', '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 22:55:11 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 22:55:11 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 22:55:11 INFO - Using env: {'DISPLAY': ':0', 22:55:11 INFO - 'HOME': '/home/cltbld', 22:55:11 INFO - 'LANG': 'en_US.UTF-8', 22:55:11 INFO - 'LANGUAGE': 'en_US:en', 22:55:11 INFO - 'LOGNAME': 'cltbld', 22:55:11 INFO - 'MAIL': '/var/mail/cltbld', 22:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:11 INFO - 'MOZ_NO_REMOTE': '1', 22:55:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:11 INFO - 'NO_EM_RESTART': '1', 22:55:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:55:11 INFO - 'PWD': '/builds/slave/test-pgo', 22:55:11 INFO - 'SHELL': '/bin/bash', 22:55:11 INFO - 'SHLVL': '1', 22:55:11 INFO - 'TERM': 'linux', 22:55:11 INFO - 'TMOUT': '86400', 22:55:11 INFO - 'USER': 'cltbld', 22:55:11 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455688561.831153-228785954', 22:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:11 INFO - '_': '/tools/buildbot/bin/python'} 22:55:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:55:11 INFO - Running setup.py (path:/tmp/pip-rfRuyB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:55:11 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)) 22:55:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:55:11 INFO - Running setup.py (path:/tmp/pip-U6YHk_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:55:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:55:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:55:11 INFO - Running setup.py (path:/tmp/pip-V3nnAV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:55:11 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)) 22:55:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:55:11 INFO - Running setup.py (path:/tmp/pip-zNERzu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:55:11 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)) 22:55:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:55:11 INFO - Running setup.py (path:/tmp/pip-gGRaAB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:55:12 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)) 22:55:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:55:12 INFO - Running setup.py (path:/tmp/pip-JSc2kQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:55:12 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)) 22:55:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:55:12 INFO - Running setup.py (path:/tmp/pip-Izndck-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:55:12 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)) 22:55:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:55:12 INFO - Running setup.py (path:/tmp/pip-iG7TLl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:55:12 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)) 22:55:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:55:12 INFO - Running setup.py (path:/tmp/pip-WI9hs0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:55:12 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)) 22:55:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:55:12 INFO - Running setup.py (path:/tmp/pip-3wscbH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:55:12 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)) 22:55:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:55:12 INFO - Running setup.py (path:/tmp/pip-SQAR5u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:55:12 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)) 22:55:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:55:12 INFO - Running setup.py (path:/tmp/pip-hrLdul-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:55:12 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)) 22:55:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:55:12 INFO - Running setup.py (path:/tmp/pip-kVJu0n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:55:12 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)) 22:55:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:55:12 INFO - Running setup.py (path:/tmp/pip-s9yLE7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:55:12 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)) 22:55:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:55:12 INFO - Running setup.py (path:/tmp/pip-0Rj5J1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:55:12 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)) 22:55:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:55:12 INFO - Running setup.py (path:/tmp/pip-uzEZip-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:55:12 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)) 22:55:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:55:12 INFO - Running setup.py (path:/tmp/pip-_b42vH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:55:12 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)) 22:55:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:55:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:55:12 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)) 22:55:12 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)) 22:55:12 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)) 22:55:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:14 INFO - Downloading blessings-1.6.tar.gz 22:55:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:55:14 INFO - Installing collected packages: blessings 22:55:14 INFO - Running setup.py install for blessings 22:55:14 INFO - Successfully installed blessings 22:55:14 INFO - Cleaning up... 22:55:14 INFO - Return code: 0 22:55:14 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:55:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:55:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:55:15 INFO - Reading from file tmpfile_stdout 22:55:15 INFO - Current package versions: 22:55:15 INFO - argparse == 1.2.1 22:55:15 INFO - blessings == 1.6 22:55:15 INFO - blobuploader == 1.2.4 22:55:15 INFO - docopt == 0.6.1 22:55:15 INFO - manifestparser == 1.1 22:55:15 INFO - mozInstall == 1.12 22:55:15 INFO - mozcrash == 0.16 22:55:15 INFO - mozdebug == 0.1 22:55:15 INFO - mozdevice == 0.48 22:55:15 INFO - mozfile == 1.2 22:55:15 INFO - mozhttpd == 0.7 22:55:15 INFO - mozinfo == 0.9 22:55:15 INFO - mozleak == 0.1 22:55:15 INFO - mozlog == 3.1 22:55:15 INFO - moznetwork == 0.27 22:55:15 INFO - mozprocess == 0.22 22:55:15 INFO - mozprofile == 0.28 22:55:15 INFO - mozrunner == 6.11 22:55:15 INFO - mozscreenshot == 0.1 22:55:15 INFO - mozsystemmonitor == 0.0 22:55:15 INFO - moztest == 0.7 22:55:15 INFO - mozversion == 1.4 22:55:15 INFO - psutil == 3.1.1 22:55:15 INFO - requests == 1.2.3 22:55:15 INFO - wsgiref == 0.1.2 22:55:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:55:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:15 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 0x7f797f7c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2895670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29248c0>, '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 0x29257c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2925c50>, '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': '32c5991c409366f7fec8a718000001d2-1455688561.831153-228785954', '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 22:55:15 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 22:55:15 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 22:55:15 INFO - Using env: {'DISPLAY': ':0', 22:55:15 INFO - 'HOME': '/home/cltbld', 22:55:15 INFO - 'LANG': 'en_US.UTF-8', 22:55:15 INFO - 'LANGUAGE': 'en_US:en', 22:55:15 INFO - 'LOGNAME': 'cltbld', 22:55:15 INFO - 'MAIL': '/var/mail/cltbld', 22:55:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:15 INFO - 'MOZ_NO_REMOTE': '1', 22:55:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:15 INFO - 'NO_EM_RESTART': '1', 22:55:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:55:15 INFO - 'PWD': '/builds/slave/test-pgo', 22:55:15 INFO - 'SHELL': '/bin/bash', 22:55:15 INFO - 'SHLVL': '1', 22:55:15 INFO - 'TERM': 'linux', 22:55:15 INFO - 'TMOUT': '86400', 22:55:15 INFO - 'USER': 'cltbld', 22:55:15 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455688561.831153-228785954', 22:55:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:15 INFO - '_': '/tools/buildbot/bin/python'} 22:55:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:15 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)) 22:55:15 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)) 22:55:15 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)) 22:55:15 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)) 22:55:15 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)) 22:55:15 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)) 22:55:15 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)) 22:55:15 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)) 22:55:15 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)) 22:55:15 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)) 22:55:15 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)) 22:55:15 INFO - Cleaning up... 22:55:15 INFO - Return code: 0 22:55:15 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:55:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:15 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 0x7f797f7c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2895670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29248c0>, '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 0x29257c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2925c50>, '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': '32c5991c409366f7fec8a718000001d2-1455688561.831153-228785954', '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 22:55:15 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 22:55:15 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 22:55:15 INFO - Using env: {'DISPLAY': ':0', 22:55:15 INFO - 'HOME': '/home/cltbld', 22:55:15 INFO - 'LANG': 'en_US.UTF-8', 22:55:15 INFO - 'LANGUAGE': 'en_US:en', 22:55:15 INFO - 'LOGNAME': 'cltbld', 22:55:15 INFO - 'MAIL': '/var/mail/cltbld', 22:55:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:15 INFO - 'MOZ_NO_REMOTE': '1', 22:55:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:15 INFO - 'NO_EM_RESTART': '1', 22:55:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:55:15 INFO - 'PWD': '/builds/slave/test-pgo', 22:55:15 INFO - 'SHELL': '/bin/bash', 22:55:15 INFO - 'SHLVL': '1', 22:55:15 INFO - 'TERM': 'linux', 22:55:15 INFO - 'TMOUT': '86400', 22:55:15 INFO - 'USER': 'cltbld', 22:55:15 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455688561.831153-228785954', 22:55:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:15 INFO - '_': '/tools/buildbot/bin/python'} 22:55:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:15 INFO - Downloading/unpacking jsonschema 22:55:15 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 22:55:15 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 22:55:15 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 22:55:15 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 22:55:15 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 22:55:15 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 22:55:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:55:17 INFO - Downloading/unpacking functools32 (from jsonschema) 22:55:17 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 22:55:17 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 22:55:17 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 22:55:17 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 22:55:17 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 22:55:17 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 22:55:17 INFO - Downloading functools32-3.2.3-2.tar.gz 22:55:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:55:17 INFO - warning: no files found matching '*.txt' 22:55:17 INFO - no previously-included directories found matching 'build' 22:55:17 INFO - no previously-included directories found matching 'dist' 22:55:17 INFO - no previously-included directories found matching '.git*' 22:55:17 INFO - Installing collected packages: jsonschema, functools32 22:55:17 INFO - Running setup.py install for functools32 22:55:17 INFO - warning: no files found matching '*.txt' 22:55:17 INFO - no previously-included directories found matching 'build' 22:55:17 INFO - no previously-included directories found matching 'dist' 22:55:17 INFO - no previously-included directories found matching '.git*' 22:55:17 INFO - Successfully installed jsonschema functools32 22:55:17 INFO - Cleaning up... 22:55:17 INFO - Return code: 0 22:55:17 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:55:17 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')]} 22:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:17 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')]} 22:55:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:17 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 0x7f797f7c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2895670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29248c0>, '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 0x29257c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2925c50>, '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': '32c5991c409366f7fec8a718000001d2-1455688561.831153-228785954', '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 22:55:17 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 22:55:17 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 22:55:17 INFO - Using env: {'DISPLAY': ':0', 22:55:17 INFO - 'HOME': '/home/cltbld', 22:55:17 INFO - 'LANG': 'en_US.UTF-8', 22:55:17 INFO - 'LANGUAGE': 'en_US:en', 22:55:17 INFO - 'LOGNAME': 'cltbld', 22:55:17 INFO - 'MAIL': '/var/mail/cltbld', 22:55:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:17 INFO - 'MOZ_NO_REMOTE': '1', 22:55:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:17 INFO - 'NO_EM_RESTART': '1', 22:55:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:55:17 INFO - 'PWD': '/builds/slave/test-pgo', 22:55:17 INFO - 'SHELL': '/bin/bash', 22:55:17 INFO - 'SHLVL': '1', 22:55:17 INFO - 'TERM': 'linux', 22:55:17 INFO - 'TMOUT': '86400', 22:55:17 INFO - 'USER': 'cltbld', 22:55:17 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455688561.831153-228785954', 22:55:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:17 INFO - '_': '/tools/buildbot/bin/python'} 22:55:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:18 INFO - Downloading/unpacking flake8 22:55:18 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 22:55:18 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 22:55:18 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 22:55:18 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 22:55:18 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 22:55:18 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 22:55:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:55:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:55:19 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 22:55:19 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 22:55:19 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 22:55:19 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 22:55:19 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 22:55:19 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 22:55:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:55:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:55:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:55:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:55:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:55:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:55:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:55:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:55:20 INFO - no previously-included directories found matching 'docs/_build' 22:55:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:55:20 INFO - Running setup.py install for pep8 22:55:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:55:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:55:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:55:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:55:20 INFO - no previously-included directories found matching 'docs/_build' 22:55:20 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:55:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:55:20 INFO - Cleaning up... 22:55:20 INFO - Return code: 0 22:55:20 INFO - Running post-action listener: _resource_record_post_action 22:55:20 INFO - Running post-action listener: _start_resource_monitoring 22:55:20 INFO - Starting resource monitoring. 22:55:20 INFO - ##### 22:55:20 INFO - ##### Running install step. 22:55:20 INFO - ##### 22:55:20 INFO - Running pre-action listener: _resource_record_pre_action 22:55:20 INFO - Running main action method: install 22:55:20 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:55:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:55:21 INFO - Reading from file tmpfile_stdout 22:55:21 INFO - Detecting whether we're running mozinstall >=1.0... 22:55:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:55:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:55:21 INFO - Reading from file tmpfile_stdout 22:55:21 INFO - Output received: 22:55:21 INFO - Usage: mozinstall [options] installer 22:55:21 INFO - Options: 22:55:21 INFO - -h, --help show this help message and exit 22:55:21 INFO - -d DEST, --destination=DEST 22:55:21 INFO - Directory to install application into. [default: 22:55:21 INFO - "/builds/slave/test-pgo"] 22:55:21 INFO - --app=APP Application being installed. [default: firefox] 22:55:21 INFO - mkdir: /builds/slave/test-pgo/build/application 22:55:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 22:55:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 22:55:37 INFO - Reading from file tmpfile_stdout 22:55:37 INFO - Output received: 22:55:37 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:55:37 INFO - Running post-action listener: _resource_record_post_action 22:55:37 INFO - ##### 22:55:37 INFO - ##### Running run-tests step. 22:55:37 INFO - ##### 22:55:37 INFO - Running pre-action listener: _resource_record_pre_action 22:55:37 INFO - Running main action method: run_tests 22:55:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:55:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:55:37 INFO - Python 2.7.3 22:55:37 INFO - Return code: 0 22:55:37 INFO - grabbing minidump binary from tooltool 22:55: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')]} 22:55:37 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 0x29248c0>, '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 0x29257c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2925c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:55:37 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 22:55:37 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 22:55:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:55:37 INFO - Return code: 0 22:55:37 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:55:37 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:55:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:55:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:55:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:55:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:55:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:55:38 INFO - Return code: 0 22:55:38 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/GW6Y9T6JRzuB4kHAxxRXJw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 22:55:38 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/GW6Y9T6JRzuB4kHAxxRXJw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 22:55:38 INFO - Using env: {'DISPLAY': ':0', 22:55:38 INFO - 'HOME': '/home/cltbld', 22:55:38 INFO - 'LANG': 'en_US.UTF-8', 22:55:38 INFO - 'LANGUAGE': 'en_US:en', 22:55:38 INFO - 'LOGNAME': 'cltbld', 22:55:38 INFO - 'MAIL': '/var/mail/cltbld', 22:55:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:55:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:55:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:38 INFO - 'MOZ_NO_REMOTE': '1', 22:55:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:55:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:38 INFO - 'NO_EM_RESTART': '1', 22:55:38 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:55:38 INFO - 'PWD': '/builds/slave/test-pgo', 22:55:38 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:55:38 INFO - 'SHELL': '/bin/bash', 22:55:38 INFO - 'SHLVL': '1', 22:55:38 INFO - 'TERM': 'linux', 22:55:38 INFO - 'TMOUT': '86400', 22:55:38 INFO - 'USER': 'cltbld', 22:55:38 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455688561.831153-228785954', 22:55:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:38 INFO - '_': '/tools/buildbot/bin/python'} 22:55:38 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/GW6Y9T6JRzuB4kHAxxRXJw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 22:55:38 INFO - mozversion application_buildid: 20160216203241 22:55:38 INFO - mozversion application_changeset: db7c5f35321fae1b076a088553ec92a9b89d883b 22:55:38 INFO - mozversion application_display_name: Nightly 22:55:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:55:38 INFO - mozversion application_name: Firefox 22:55:38 INFO - mozversion application_remotingname: firefox 22:55:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:55:38 INFO - mozversion application_vendor: Mozilla 22:55:38 INFO - mozversion application_version: 47.0a1 22:55:38 INFO - mozversion platform_buildid: 20160216203241 22:55:38 INFO - mozversion platform_changeset: db7c5f35321fae1b076a088553ec92a9b89d883b 22:55:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:55:38 INFO - mozversion platform_version: 47.0a1 22:55:38 INFO - using testdate: 1455692138 22:55:38 INFO - actual date: 1455692138 22:55:38 INFO - starting webserver on 'localhost:33441' 22:55:38 INFO - SUITE-START | Running 2 tests 22:55:38 INFO - TEST-START | dromaeo_css 22:55:38 INFO - operating with platform_type : linux_ 22:55:38 INFO - Initialising browser for dromaeo_css test... 22:55:38 INFO - TEST-INFO | started process 9627 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpibFaVH/profile http://localhost:33441/getInfo.html) 22:55:42 INFO - PROCESS | 9627 | __metrics Screen width/height:1600/1200 22:55:42 INFO - PROCESS | 9627 | colorDepth:24 22:55:42 INFO - PROCESS | 9627 | Browser inner width/height: 1024/697 22:55:42 INFO - PROCESS | 9627 | __metrics 22:55:43 INFO - PROCESS | 9627 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:55:43 INFO - PROCESS | 9627 | 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. 22:55:44 INFO - TEST-INFO | 9627: exit 0 22:55:44 INFO - Browser initialized. 22:55:44 INFO - Running cycle 1/1 for dromaeo_css test... 22:55:44 INFO - TEST-INFO | started process 9725 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpibFaVH/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:55:56 INFO - PROCESS | 9725 | RSS: Main: 146784256 22:55:56 INFO - PROCESS | 9725 | 22:56:47 INFO - PROCESS | 9725 | 1455692207642 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] 22:58:55 INFO - PROCESS | 9725 | Cycle 1(1): loaded http://localhost:33441/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33441/tests/dromaeo/cssquery-ext.html) 22:58:56 INFO - PROCESS | 9725 | RSS: Main: 252571648 22:58:56 INFO - PROCESS | 9725 | 23:01:59 INFO - PROCESS | 9725 | Cycle 1(1): loaded http://localhost:33441/tests/dromaeo/cssquery-ext.html (next: http://localhost:33441/tests/dromaeo/cssquery-jquery.html) 23:01:59 INFO - PROCESS | 9725 | RSS: Main: 232353792 23:01:59 INFO - PROCESS | 9725 | 23:05:01 INFO - PROCESS | 9725 | Cycle 1(1): loaded http://localhost:33441/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33441/tests/dromaeo/cssquery-mootools.html) 23:05:02 INFO - PROCESS | 9725 | RSS: Main: 238796800 23:05:02 INFO - PROCESS | 9725 | 23:08:04 INFO - PROCESS | 9725 | Cycle 1(1): loaded http://localhost:33441/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33441/tests/dromaeo/cssquery-prototype.html) 23:08:04 INFO - PROCESS | 9725 | RSS: Main: 217755648 23:08:04 INFO - PROCESS | 9725 | 23:11:07 INFO - PROCESS | 9725 | Cycle 1(1): loaded http://localhost:33441/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33441/tests/dromaeo/cssquery-yui.html) 23:11:07 INFO - PROCESS | 9725 | RSS: Main: 222466048 23:11:07 INFO - PROCESS | 9725 | 23:14:10 INFO - PROCESS | 9725 | Cycle 1(1): loaded http://localhost:33441/tests/dromaeo/cssquery-yui.html (next: http://localhost:33441/tests/dromaeo/cssquery-dojo.html) 23:14:10 INFO - PROCESS | 9725 | RSS: Main: 291840000 23:14:10 INFO - PROCESS | 9725 | 23:14:10 INFO - PROCESS | 9725 | __start_tp_report 23:14:10 INFO - PROCESS | 9725 | _x_x_mozilla_page_load 23:14:10 INFO - PROCESS | 9725 | _x_x_mozilla_page_load_details 23:14:10 INFO - PROCESS | 9725 | |i|pagename|runs| 23:14:10 INFO - PROCESS | 9725 | |0;dojo.html;3067.570540124382;3147.071613873907;3167.6357218919816;3187.250996015936;3219.6297425796033;4849.830255941043;4929.728864912428;4990.925136122956;5040.798368065278;5043.672161309517;4935.506449355072;5045.1423258046125;5056.115179843522;5127.205283181103;5156.175011998081;4480.663950203748;4526.185286648394;4544.590986811187;4552.772361381934;4595.471520775121;4655.045715628305;4704.623630109583;4720.669553131283;4725.881852953669;4732.124556956956;4560.703554268962;4632.930506042412;4643.3731446255;4656.138614356355;4697.788599513013;4548.681592288541;4554.294084416921;4558.863234102949;4559.156556037111;4565.269556870885;4521.050579378334;4545.704529205591;4548.931766023512;4555.9772201138785;4609.124266389409;4986.87532811679;4992.950070499285;5011.523905228997;5020.698758074527;5035.446100928895;5444.863878403032;5445.482679145475;5466.617336786427;5467.535259502947;5508.44915508446;5264.499872512105;5300.814471493479;5369.677819330814;5425.701586412746;5427.402985671573;5034.219695947134;5071.18860982241;5077.390713114413;5082.390113186404;5089.847304580869;5488.725563721798;5489.752961116759;5490.588205884575;5494.2582751328055;5507.917381239285;5168.8966220675375;5257.185136303879;5292.44429334922;5360.088784906575;5393.568514518829;5314.096603577324;5324.5740340772645;5333.359996800331;5339.145736682112;5340.946590534123;5310.442403547572;5320.920186197211;5321.600879934021;5324.0150572144275;5368.114261146945;5264.341957255343;5349.839504814861;5364.6512976656395;5377.946220537823;5452.372977107604;4265.168292182994;4289.485261768607;4293.656507479394;4327.459067616548;4329.913401732011;3808.352580061396;3878.903027424337;3879.4180872868733;3887.2031233597045;3926.86255981045;5082.2122571001555;5108.565771909355;5115.693058416433;5133.537981581676;5161.66449180802;5389.083855744533;5412.539934105566;5418.349798024262;5426.213199086111;5476.972615136899;5007.499250074963;5078.542931136216;5154.7938082476285;5161;5166.095933211673;4667.556582124693;4681.6722829401615;4689.835855745033;4720.669553131248;4728.88177795551;5679.375268720438;5679.801206957736;5679.914801277984;5688.800891968761;5697.686627235459;5293.047251494768;5341.759620816995;5375.892482150413;5379.031774280511;5456.536194423518;5702.258706368146;5716.399778023248;5716.514096301695;5732.16883551891;5740.225069615549;5308.814191503279;5317.282166907573;5324.414314425333;5332.493413125747;5332.706701131475;5310.734463276898;5409.107497262908;5409.323834520685;5442.428545002717;5491.423400543045;5212.270282160576;5241.187615919539;5243;5243.606729495227;5243.8164664236565;5133.820316288912;5243.501867322599;5248.763805628832;5249.685018898878;5259.342582177228;5087.64386492942;5115.18157094863;5182.818601348935;5194.636375453682;5194.870128246673;5192.065428222956;5214.8957020860125;5216.37403511581;5236.5548928339995;5255.527002569787;5085;5101.795928162832;5119.87200319995;5120.078385890575;5123.410807757006 23:14:10 INFO - PROCESS | 9725 | |1;ext.html;521.2858384013902;526.0767353294967;536.8577327008344;549.7004132747652;550.8925759476903;28824;29437.2640683983;29448.26379340515;36820.44769328462;37213.069673258186;39673.20653586926;40103.39844902329;40120.79939600298;40274;40347;8520.02019767727;8725.258353039999;8729.301655867515;8731.738047858542;8735.432196907212;8466.068732439428;8591.44155629882;8593.570321483932;8598.699045533407;8598.87101693475;8834.072422395653;8928.910710892873;8931.95534022329;8934.865977010317;8940.687075952343;8791.252743516809;8863.601137948808;8872.201501864798;8876;8879.911200887973;8700.956495217546;8790.384673072887;8828.779280517974;8860.955695221546;8865.601047952858;41175.7941210295;41793;41802.581974180175;41875.790621047;41879.1624167515;3296.4890441981292;3350.983245083759;3478.4086705260165;3706.4625629283605;3992.2215168042244;30422.695773042207;30596.235094122603;31001.534976975363;31358.52962205569;31666.208344791565;3793.2223894101917;3912.3544615138467;3930.331843586597;4011.7392369496183;4127.29835927893;258775;259657;260181;260411;262291.688541558;42187.78906105511;42712.57287427148;59074;60158.398416016156;60427;40922;41122.58877411188;41390.37914431286;41404.58595414007;41459.1708165835;13367.799483007762;13522.32388380577;13605.523806666719;13753.931230343784;13775;9288.303377246733;11087.168462365355;11142.331460112418;11150.944245278723;11158.944205278922;13986.650333741534;14191.509891461454;14209.50266740659;14221.502247421498;14313.21277329736;5616.466435688603;5651.886962260732;5722.914156287659;5748.971255143698;5756.913646295309;914.8673442350822;931.366670663955;974.668612671695;997.8852431970271;1053.7839742852698;28777.85611071973;29069.273268168043;29107.85446072756;29502.262443439085;29623.703762962527;1030.567161792049;1031.1802117316752;1093.1582681335328;1151.37825574189;1161.5469966712988;15096;15174.468893588672;15345.23273836326;15465.226738663021;15514.689706205812;307245;311895;312279;312677;312783;54069.72965135149;54586;54644.72677636586;54652;54660.453395466335;1338.2305174524492;1344.6235054184845;1366.364640442199;1368.9110207836459;1370.1025828082622;27503.86248068747;28503.572446413735;28525.14424567266;28943.42113157767;29084.418311633224;47435.288470672276;47937.5206247947;47978.04043919172;48057.75971120122;48080.51919480901;291216;293570;293702;293744;294236;32127.196820079684;33382.83308583539;33479.33041339111;33592.664073359934;33596.160095997795;43583.56416435795;44297.55702443063;44355.33466997933;45068.54931450643;45624;36339.881014716455;37079.44380834236;37163.81418092892;37869.81065094657;37994;37145.81427092847;37349.25301494009;38285.6171438282;38566.22867542689;38747;36957.489038541295;37734.24531509409;38059.42910856395;38075.619243808316;38129;32662.51006234956;34170.82914585411;34442.655573443946;34795.304093917475;34898.302033959684;25768.484630307663;25813.6127958077;26082.355349004134;26307;26469.602955956063 23:14:10 INFO - PROCESS | 9725 | |2;jquery.html;348.766326561204;359.41415492746836;365.1929236387583;367.3919662957805;371.7806494168442;12542.247465152097;16161.595960101004;17128.74306885396;18099.4570162895;18103.4568962931;15078.924605376958;15214.467493637725;15790.368385264605;15814.841851581481;15883.761743573827;4056.817443215062;4216.388623649569;4222.648752399234;5335.0663633864115;5492.093804522269;4186.727862688916;4381.605655491006;5846.269216347957;5968.074948383008;6028.547858910577;5912.17229587858;5964.552658550604;5977.282726072877;5985.072313791347;5987;5778.942210577882;5918.585699001072;5931.228940237742;5936.673482958436;5936.7031648417405;5225.843224703227;5227.529522343008;5231.764570594332;5236.7905283788605;5260.28986086881;20083.698744518842;20103.29638462647;20241.595168096555;20370.898145509327;20371.89814050935;2005.46855083403;2005.8796472211714;2029.4621925189836;2106.273335699181;2195.3194509702043;9189.77025574366;9198.95400522993;9227.215686666641;9545.284103692251;9610.6636267731;1775.9822401775946;1833.734108554252;1861.3578315481138;1876.127600665697;1881.2569035231145;58870.41129588692;60868;61583;62214.68892655553;62403.68798156026;8985.415947963493;9439.103285187895;9847.16299114569;9903.851442228372;9938.503074846229;12976.935115324362;13016.869831301756;13257.867421325856;13276.73446531064;13305.334733263298;7171.03191069199;7259.346658800733;7308.926910730931;7311.597862117635;7317.536492701374;7033.366996970297;7039.472039596948;7069.823254418578;7089.149302083783;7101.89347159793;4409.096135292258;4444.866654000385;4465.218586747306;4494.123645889085;4508.211063063951;1791.3730194432105;1798.5593529585074;1843.889366638006;1852.19429548147;1884.2086323743786;915.6520522201654;923.4874644572327;963.7735132243918;1019.3934608907688;1040.5785656809005;16175.514734557983;16322.510324690278;16506.504804855875;16514.33942642305;16890;795.4392153531746;873.7728190670344;902.5216635183364;911.794846159622;971.4220039076738;9217.815643687089;9369.753101706303;9395.530223488935;9420.717378478657;9824.852627210597;484559;486944;487129;488832;494649;69475.65262173758;70582.64708676423;71728.2827171732;73852.63073684704;74870;1083.3370775859019;1093.0981939899614;1106.2090605217309;1107.3189988157064;1108.4402376799826;14215;14644.194569298365;14799.334029968462;15255.160966146968;15267.23663816827;31175.688243118188;31251.406088300137;31381.52927706132;31993.840030799696;32503;41334.586654133076;44804.10391792081;45050.54949450595;45061;45282.09435811331;7546.24537546241;7669;7678.6544605494;7749.380049595906;7778.844423111619;9674.56464459087;11047.72380690489;11429.199956003;11542.884571154516;11847.585334513251;6454.935450645434;8291.170882911661;9748.415095094317;10099.545520451744;10505.42220177867;9780.80438391214;9876.35803672759;10213.438260895722;10221.9488902555;10378.221633377376;7030.50786444944;7967.800804979922;9046.239759137821;9905.455199963782;10199.592016319264;7539.246075392417;7654.201262703149;7797.337226335598;7809.882851757342;7829.7259595913865;9739.61041558358;9744.902550974399;9906.653267135616;10205.59177632916;10641.361518308617 23:14:10 INFO - PROCESS | 9725 | |3;mootools.html;1364.6247281997455;1429.9285035748214;1441.1857300625145;1609.9436519721812;1812.728090786382;6575.8027259182245;7415.2584741525825;7531.736389226378;7546.924530754691;7550.093988721361;7165.104361954755;7263.0921134858145;7296.96351518243;7297.197308296083;7307.269273072703;1933.7776155742129;1980;1980.554375265568;2244.2145249162786;2269.693591365161;2289.8855057247156;2336.6027775278158;2343.027643527934;2343.5195784864145;2345.472268739537;2175.1734340950416;2194.078487035449;2209.591225623265;2309.457277539777;2317.536492701458;2262.298687406893;2276.6243569810963;2281.4296425893526;2286.3598192506042;2348.953020939589;2293.392251053472;2295.896684649195;2296.334063121693;2297.4715815362392;2302.7697230277004;7532.058492688414;7571.24287571244;7576.886346704804;7577.204393538655;7588.81027974305;4697.060587882437;4760.666753327268;4769.523047695237;4779.450363208241;4783.067301876135;3082.568440418343;3093.3040065985197;3156.305612765188;3162.5926462724096;3163.952540711868;950.3632566180606;952.0241752203978;981.8969008254102;992.1467537917457;1009.3943633819723;10536.26246162769;10551.630692925788;10552.261341706084;10552.894471055344;10567.471626418648;4236.5128010278595;4291.334843099325;4303.827846886152;4323.135372925364;4432.31299148626;9152.816943661222;9159.22146617545;9168.770780730536;9188.632454701738;9192.95403522978;4809.2305231162845;4843.321934929113;4845.442774080955;4852.199387101089;4854.951450485521;4379.759113248802;4382.123575284956;4426.468823741172;4431.556844315543;4437.911241775147;3373.7638365314683;3579.069441945113;3663.267346530651;3755.549334079928;3761.6990640748672;1158.7914175448332;1175.4651633506735;1179.887910648487;1187.382561068257;1188.7563049574817;1276.5978716704208;1282.4741855839247;1303.8500572434102;1319.0568743348551;1339.1028011232497;6824.283450237654;6835.658217089126;6839.589624622538;6912.758053468205;7017.508774385744;1055.8732952045805;1077.9137668986461;1106.2068277599126;1123.9100871930225;1146.1003112556602;5737.77048918047;5848.912266316009;5850.2102216200265;5868.09044598088;5875.853103672443;9061.909380906238;9148.2681385489;9250.583723732449;9276.814463710689;9339.906600933904;9120.315976301805;9184.63261469547;9209.171174594185;9221.95389023064;9232.492212928353;7182.3535881770895;7281.854362912712;7287.963560182166;7303.233160518069;7346.485745997836;7050.964745176241;7089.0784198053925;7105.715771369088;7113.217546070032;7115.501914865909;7985.2014798519685;8171.060328062111;8220.260176584135;8220.83558328842;8372.87440688378;8314.750557483285;8402.95798521028;8529.488230706178;8581.95709021451;8655.56722163902;6660.666966651745;6776.525643205126;6860.862782744417;6866.382025617719;6890.20762612306;6334.429901308904;6929.099217101744;7109.608971506616;7305.598192099273;7360.558366498028;6694.330566943267;6759.797206083826;6858.3827455529245;6872.381485666314;6909.205441374306;6592.934070659232;6645.767398141042;6666.133402657623;6785.626790526569;6811.89782153278;6793.184817821893;6851.07510486078;6854.246032936473;6855.6572171390235;6858.554193977376;6323.114763932961;6473.935260647521;6516.934830651633;6537.280899101;6547.476201903741;6506.186726659168;6517.608943463218;6545.869082618226;6550.508711846726;6552.737890484327 23:14:10 INFO - PROCESS | 9725 | |4;prototype.html;335.7750307294113;342.5923151449775;346.1484747521098;348.9214926641505;350.1980464735755;5669.1212862006405;5695.373508914021;5716.799912003081;5741.311042674884;5789.855253618651;5419.187121931712;5476.205950137238;5550.47270509302;5602.943970560294;5652.463016013472;4397.8240870365225;4400.581944715247;4411.316245981878;4413.6910416270875;4417.293233082707;4277.2087163874785;4448.666350023745;4458.621017213541;4459.331100334944;4462.509123996374;4320.265554855667;4388;4405.185040767452;4410.62509686677;4412.404325416076;4432.135733531963;4438.134563760068;4443.977780111111;4446.110777844444;4446.644268458515;3929.960700393017;3936.389859571771;3939;3941.783201923893;3941.8423263069444;5392.946070539323;5474.39781624021;5486.1222204447495;5489.1217405215375;5490.639025219154;5122.846314610568;5156.948430515685;5165.535101840853;5166.948330516722;5170.1986192140275;5983.311919129313;5985.281766188085;5991.3109992351;5994.310654274771;5999.280086389661;4365.279728844736;4371.235033869092;4372.781360931941;4378.759168245745;4379.146066517031;6093.11649810775;6257.405546473078;6295;6297.338779428185;6338.080978258126;4328.848490302824;4348.043430445297;4361.6510679145595;4367.58507941745;4375.693701440869;4408.096340250241;4411.625011873963;4412.84555040572;4414.161309351213;4415.249407600716;5069.1635880079375;5074.695518268842;5080.46655101209;5084.669496482717;5086.669366491166;5932.495737862244;6050.42520960508;6053.424924632153;6061.090836374491;6068.393160683896;1512.2816662085422;1532.0501289200545;1533.02652815463;1534.946276880304;1535.0405996252343;1019.1591936652292;1039.5841663334575;1041.1254546181244;1043.3166276089173;1053.7681710023783;5871.911921321183;5872.236609240771;5872.765089396376;5873.500752436005;5880.323762767251;6244.063390491463;6244.500439964792;6247.718852651642;6249.156363890907;6250.124982502453;5672.064109421982;5774.82675519735;5802.680852553066;5859.091840764689;5877.5591830612875;3343.297907439416;3360.277540328841;3375.8480868360984;3382.4080785862375;3386.8645254189555;6634.170728658918;6636.369544893228;6637.867242655217;6651.66741662915;6653.833654158685;6245.906311405332;6371.936280637227;6455.677216139175;6457.806265812033;6481.0602462642655;6762.323767623198;6768.153980752406;6769.42459890905;6783.559068660521;6789.0834737310815;6297.622142671455;6302.1492098566105;6321.462675672619;6323.873522529431;6326.272478664829;6034.456898879122;6153.4769544587425;6224.502039836892;6226.40849119333;6239.594426362272;6765.052892594942;6769.1876974763345;6782.98255261695;6809.046733457221;6863.897041544281;4325.76208308546;4390.714603550759;4396.868093957187;4397.6042156206095;4399.076193999296;6141.3551577085545;6277.435030847246;6298.275698294571;6333.8733225336155;6340.841478963062;6125.050617154348;6131.325554189125;6132.601380910227;6142.232220972379;6142.385761423822;6105.877882442415;6139.570230083851;6150.077488376779;6158.353372895961;6159.244615284622;5904.380040095728;6048.032314829607;6050.394960503914;6058.636481811105;6062.302835174011;6174.228221472316;6175.9073613894925;6176.81469555914;6181.196444462191;6182.474489668429;6026.789062382795;6030.577859549965;6037.75848966054;6046.758129674764;6050.969745151246 23:14:10 INFO - PROCESS | 9725 | |5;yui.html;650.5381179362653;659.0805825872909;660.8314879705674;729.879569870971;786.2884089898644;13444.596662100128;13482.123661961978;13515.729685406286;13555;15665.138417387068;14836.109833409975;14894.776578351333;14934;14957.326920288586;14966.102033877974;669.7454967112491;678.8065401360614;811.3468657730554;813.1705660226565;835.8620827563444;824.6495239523209;827.7268501394525;829.4318391901537;830.8629076202419;837.3175861672747;710.4990981358156;878.2096113497871;878.4158534574532;879.0374539878823;881.0836729800999;870.6909047288217;888.7911340834899;889.6263569300877;890.4523717913502;891.1979218703154;654.3914159831355;654.5777973207303;654.5941516259902;655.2006552006544;655.220287857448;13829.308534573333;13864.306784660726;13870.029097963146;13884.23636699981;13911.79132313016;12279.324637144953;12540;12632.431540580605;12705.237685738884;13156.60530184096;10083.49582520871;10174.745631359201;10381.84427233592;10447.791044179074;10490.79018419635;3533.628968958248;3606.3328284267495;3623.40213864712;3635.2184280379847;3636.945445818315;48369.75815120902;48854;48913.75543122261;49018;49271.260931086064;9381.765455863659;9534.28492863038;9654.420734755797;9777.315587908779;9787.510624468749;17863.196156173002;17897.552561185814;17898.10509474547;17907.1941762621;17941.37205197838;7171.462140339496;7244.963775181091;7650.42621803367;7756.844863102707;7796.064472263365;4216.831326746896;4239.936400953989;4280.978595107004;4288.120935208275;4331.870043898688;3049.573059771634;3077.046115704139;3085;3088.783785135019;3093.211231136046;553.8698405874616;562.9774809007675;563.6477201748907;571.3229822660161;590.0117303516593;565.7256230728094;638.8339031851659;665.9146679331913;691.2430888177438;696.3002182806349;7801.9103483809195;8511.829763404698;8547.27348175412;8591.140885911358;8763.430377025601;556.3574071946908;592.9881402372015;607.9392060793974;608.8325710429667;628.9905651415232;3611.3860643690637;3864.8260828262796;3931.410288456754;4039.8990025249605;4065.8576949806616;48987;49345.50654493409;56284;56526.71736641291;56820.43179568234;43547.78226108849;43875;43903.560964390585;44182;48530.757346213046;47227.76386118116;47249.291260631115;47725.284120738215;47923.5207647926;48320.27519587209;8276.213759692819;8633.568321584022;8687.435316704394;8826.109493998933;8881.911180888108;34300.828495857364;35352.46971295381;35584.64415355813;35585.64414355823;35735.82132089323;42205.78897105618;43588.78205608952;45616.771916140206;45808.770956145;45980.8504787383;10419.374837509773;10506.212034097625;10579.471026448493;10590.735231618963;10993.670189894316;11676.649700508999;11856.70358241051;11886.167968242486;12091.395430228278;12414.503419863104;10902.345859248471;11235.887641123483;11473.311601303949;11496.425178740863;11820.172587918763;10453.372797632166;10582.682519524427;10850.45747712627;11019.228653994463;11052.778944420907;11149.386783726974;11253.549858005588;11258.943705281421;11283.815199404273;11612.535498579962;9081.909180908106;9305.098132721221;9372.578233979624;9396.389234699722;9527.380720253439;8910.198082172636;9129.908700912905;9132.908670913206;9194.49430281341;9844.803103938024 23:14:10 INFO - PROCESS | 9725 | __end_tp_report 23:14:10 INFO - PROCESS | 9725 | __start_cc_report 23:14:10 INFO - PROCESS | 9725 | _x_x_mozilla_cycle_collect,848 23:14:10 INFO - PROCESS | 9725 | __end_cc_report 23:14:10 INFO - PROCESS | 9725 | __startTimestamp1455693250652__endTimestamp 23:14:10 INFO - PROCESS | 9725 | 23:14:10 INFO - PROCESS | 9725 | ------- Summary: start ------- 23:14:10 INFO - PROCESS | 9725 | Number of tests: 6 23:14:10 INFO - PROCESS | 9725 | 23:14:10 INFO - PROCESS | 9725 | [#0] dojo.html Cycles:165 Average:5027.39 Median:5166.10 stddev:521.62 (10.1%) stddev-sans-first:500.05 23:14:10 INFO - PROCESS | 9725 | Values: 3067.6 3147.1 3167.6 3187.3 3219.6 4849.8 4929.7 4990.9 5040.8 5043.7 4935.5 5045.1 5056.1 5127.2 5156.2 4480.7 4526.2 4544.6 4552.8 4595.5 4655.0 4704.6 4720.7 4725.9 4732.1 4560.7 4632.9 4643.4 4656.1 4697.8 4548.7 4554.3 4558.9 4559.2 4565.3 4521.1 4545.7 4548.9 4556.0 4609.1 4986.9 4993.0 5011.5 5020.7 5035.4 5444.9 5445.5 5466.6 5467.5 5508.4 5264.5 5300.8 5369.7 5425.7 5427.4 5034.2 5071.2 5077.4 5082.4 5089.8 5488.7 5489.8 5490.6 5494.3 5507.9 5168.9 5257.2 5292.4 5360.1 5393.6 5314.1 5324.6 5333.4 5339.1 5340.9 5310.4 5320.9 5321.6 5324.0 5368.1 5264.3 5349.8 5364.7 5377.9 5452.4 4265.2 4289.5 4293.7 4327.5 4329.9 3808.4 3878.9 3879.4 3887.2 3926.9 5082.2 5108.6 5115.7 5133.5 5161.7 5389.1 5412.5 5418.3 5426.2 5477.0 5007.5 5078.5 5154.8 5161.0 5166.1 4667.6 4681.7 4689.8 4720.7 4728.9 5679.4 5679.8 5679.9 5688.8 5697.7 5293.0 5341.8 5375.9 5379.0 5456.5 5702.3 5716.4 5716.5 5732.2 5740.2 5308.8 5317.3 5324.4 5332.5 5332.7 5310.7 5409.1 5409.3 5442.4 5491.4 5212.3 5241.2 5243.0 5243.6 5243.8 5133.8 5243.5 5248.8 5249.7 5259.3 5087.6 5115.2 5182.8 5194.6 5194.9 5192.1 5214.9 5216.4 5236.6 5255.5 5085.0 5101.8 5119.9 5120.1 5123.4 23:14:10 INFO - PROCESS | 9725 | 23:14:10 INFO - PROCESS | 9725 | [#1] ext.html Cycles:180 Average:45292.13 Median:37802.03 stddev:75514.26 (199.8%) stddev-sans-first:75651.27 23:14:10 INFO - PROCESS | 9725 | Values: 521.3 526.1 536.9 549.7 550.9 28824.0 29437.3 29448.3 36820.4 37213.1 39673.2 40103.4 40120.8 40274.0 40347.0 8520.0 8725.3 8729.3 8731.7 8735.4 8466.1 8591.4 8593.6 8598.7 8598.9 8834.1 8928.9 8932.0 8934.9 8940.7 8791.3 8863.6 8872.2 8876.0 8879.9 8701.0 8790.4 8828.8 8861.0 8865.6 41175.8 41793.0 41802.6 41875.8 41879.2 3296.5 3351.0 3478.4 3706.5 3992.2 30422.7 30596.2 31001.5 31358.5 31666.2 3793.2 3912.4 3930.3 4011.7 4127.3 258775.0 259657.0 260181.0 260411.0 262291.7 42187.8 42712.6 59074.0 60158.4 60427.0 40922.0 41122.6 41390.4 41404.6 41459.2 13367.8 13522.3 13605.5 13753.9 13775.0 9288.3 11087.2 11142.3 11150.9 11158.9 13986.7 14191.5 14209.5 14221.5 14313.2 5616.5 5651.9 5722.9 5749.0 5756.9 914.9 931.4 974.7 997.9 1053.8 28777.9 29069.3 29107.9 29502.3 29623.7 1030.6 1031.2 1093.2 1151.4 1161.5 15096.0 15174.5 15345.2 15465.2 15514.7 307245.0 311895.0 312279.0 312677.0 312783.0 54069.7 54586.0 54644.7 54652.0 54660.5 1338.2 1344.6 1366.4 1368.9 1370.1 27503.9 28503.6 28525.1 28943.4 29084.4 47435.3 47937.5 47978.0 48057.8 48080.5 291216.0 293570.0 293702.0 293744.0 294236.0 32127.2 33382.8 33479.3 33592.7 33596.2 43583.6 44297.6 44355.3 45068.5 45624.0 36339.9 37079.4 37163.8 37869.8 37994.0 37145.8 37349.3 38285.6 38566.2 38747.0 36957.5 37734.2 38059.4 38075.6 38129.0 32662.5 34170.8 34442.7 34795.3 34898.3 25768.5 25813.6 26082.4 26307.0 26469.6 23:14:10 INFO - PROCESS | 9725 | 23:14:10 INFO - PROCESS | 9725 | [#2] jquery.html Cycles:180 Average:26172.88 Median:487036.50 stddev:79905.29 (16.4%) stddev-sans-first:80105.91 23:14:10 INFO - PROCESS | 9725 | Values: 348.8 359.4 365.2 367.4 371.8 12542.2 16161.6 17128.7 18099.5 18103.5 15078.9 15214.5 15790.4 15814.8 15883.8 4056.8 4216.4 4222.6 5335.1 5492.1 4186.7 4381.6 5846.3 5968.1 6028.5 5912.2 5964.6 5977.3 5985.1 5987.0 5778.9 5918.6 5931.2 5936.7 5936.7 5225.8 5227.5 5231.8 5236.8 5260.3 20083.7 20103.3 20241.6 20370.9 20371.9 2005.5 2005.9 2029.5 2106.3 2195.3 9189.8 9199.0 9227.2 9545.3 9610.7 1776.0 1833.7 1861.4 1876.1 1881.3 58870.4 60868.0 61583.0 62214.7 62403.7 8985.4 9439.1 9847.2 9903.9 9938.5 12976.9 13016.9 13257.9 13276.7 13305.3 7171.0 7259.3 7308.9 7311.6 7317.5 7033.4 7039.5 7069.8 7089.1 7101.9 4409.1 4444.9 4465.2 4494.1 4508.2 1791.4 1798.6 1843.9 1852.2 1884.2 915.7 923.5 963.8 1019.4 1040.6 16175.5 16322.5 16506.5 16514.3 16890.0 795.4 873.8 902.5 911.8 971.4 9217.8 9369.8 9395.5 9420.7 9824.9 484559.0 486944.0 487129.0 488832.0 494649.0 69475.7 70582.6 71728.3 73852.6 74870.0 1083.3 1093.1 1106.2 1107.3 1108.4 14215.0 14644.2 14799.3 15255.2 15267.2 31175.7 31251.4 31381.5 31993.8 32503.0 41334.6 44804.1 45050.5 45061.0 45282.1 7546.2 7669.0 7678.7 7749.4 7778.8 9674.6 11047.7 11429.2 11542.9 11847.6 6454.9 8291.2 9748.4 10099.5 10505.4 9780.8 9876.4 10213.4 10221.9 10378.2 7030.5 7967.8 9046.2 9905.5 10199.6 7539.2 7654.2 7797.3 7809.9 7829.7 9739.6 9744.9 9906.7 10205.6 10641.4 23:14:10 INFO - PROCESS | 9725 | 23:14:10 INFO - PROCESS | 9725 | [#3] mootools.html Cycles:180 Average:5380.52 Median:6517.27 stddev:2743.83 (42.1%) stddev-sans-first:2734.92 23:14:10 INFO - PROCESS | 9725 | Values: 1364.6 1429.9 1441.2 1609.9 1812.7 6575.8 7415.3 7531.7 7546.9 7550.1 7165.1 7263.1 7297.0 7297.2 7307.3 1933.8 1980.0 1980.6 2244.2 2269.7 2289.9 2336.6 2343.0 2343.5 2345.5 2175.2 2194.1 2209.6 2309.5 2317.5 2262.3 2276.6 2281.4 2286.4 2349.0 2293.4 2295.9 2296.3 2297.5 2302.8 7532.1 7571.2 7576.9 7577.2 7588.8 4697.1 4760.7 4769.5 4779.5 4783.1 3082.6 3093.3 3156.3 3162.6 3164.0 950.4 952.0 981.9 992.1 1009.4 10536.3 10551.6 10552.3 10552.9 10567.5 4236.5 4291.3 4303.8 4323.1 4432.3 9152.8 9159.2 9168.8 9188.6 9193.0 4809.2 4843.3 4845.4 4852.2 4855.0 4379.8 4382.1 4426.5 4431.6 4437.9 3373.8 3579.1 3663.3 3755.5 3761.7 1158.8 1175.5 1179.9 1187.4 1188.8 1276.6 1282.5 1303.9 1319.1 1339.1 6824.3 6835.7 6839.6 6912.8 7017.5 1055.9 1077.9 1106.2 1123.9 1146.1 5737.8 5848.9 5850.2 5868.1 5875.9 9061.9 9148.3 9250.6 9276.8 9339.9 9120.3 9184.6 9209.2 9222.0 9232.5 7182.4 7281.9 7288.0 7303.2 7346.5 7051.0 7089.1 7105.7 7113.2 7115.5 7985.2 8171.1 8220.3 8220.8 8372.9 8314.8 8403.0 8529.5 8582.0 8655.6 6660.7 6776.5 6860.9 6866.4 6890.2 6334.4 6929.1 7109.6 7305.6 7360.6 6694.3 6759.8 6858.4 6872.4 6909.2 6592.9 6645.8 6666.1 6785.6 6811.9 6793.2 6851.1 6854.2 6855.7 6858.6 6323.1 6473.9 6516.9 6537.3 6547.5 6506.2 6517.6 6545.9 6550.5 6552.7 23:14:10 INFO - PROCESS | 9725 | 23:14:10 INFO - PROCESS | 9725 | [#4] prototype.html Cycles:180 Average:5124.22 Median:5782.34 stddev:1542.18 (26.7%) stddev-sans-first:1504.04 23:14:10 INFO - PROCESS | 9725 | Values: 335.8 342.6 346.1 348.9 350.2 5669.1 5695.4 5716.8 5741.3 5789.9 5419.2 5476.2 5550.5 5602.9 5652.5 4397.8 4400.6 4411.3 4413.7 4417.3 4277.2 4448.7 4458.6 4459.3 4462.5 4320.3 4388.0 4405.2 4410.6 4412.4 4432.1 4438.1 4444.0 4446.1 4446.6 3930.0 3936.4 3939.0 3941.8 3941.8 5392.9 5474.4 5486.1 5489.1 5490.6 5122.8 5156.9 5165.5 5166.9 5170.2 5983.3 5985.3 5991.3 5994.3 5999.3 4365.3 4371.2 4372.8 4378.8 4379.1 6093.1 6257.4 6295.0 6297.3 6338.1 4328.8 4348.0 4361.7 4367.6 4375.7 4408.1 4411.6 4412.8 4414.2 4415.2 5069.2 5074.7 5080.5 5084.7 5086.7 5932.5 6050.4 6053.4 6061.1 6068.4 1512.3 1532.1 1533.0 1534.9 1535.0 1019.2 1039.6 1041.1 1043.3 1053.8 5871.9 5872.2 5872.8 5873.5 5880.3 6244.1 6244.5 6247.7 6249.2 6250.1 5672.1 5774.8 5802.7 5859.1 5877.6 3343.3 3360.3 3375.8 3382.4 3386.9 6634.2 6636.4 6637.9 6651.7 6653.8 6245.9 6371.9 6455.7 6457.8 6481.1 6762.3 6768.2 6769.4 6783.6 6789.1 6297.6 6302.1 6321.5 6323.9 6326.3 6034.5 6153.5 6224.5 6226.4 6239.6 6765.1 6769.2 6783.0 6809.0 6863.9 4325.8 4390.7 4396.9 4397.6 4399.1 6141.4 6277.4 6298.3 6333.9 6340.8 6125.1 6131.3 6132.6 6142.2 6142.4 6105.9 6139.6 6150.1 6158.4 6159.2 5904.4 6048.0 6050.4 6058.6 6062.3 6174.2 6175.9 6176.8 6181.2 6182.5 6026.8 6030.6 6037.8 6046.8 6051.0 23:14:10 INFO - PROCESS | 9725 | 23:14:10 INFO - PROCESS | 9725 | [#5] yui.html Cycles:180 Average:13578.06 Median:47487.29 stddev:15429.73 (32.5%) stddev-sans-first:15442.48 23:14:10 INFO - PROCESS | 9725 | Values: 650.5 659.1 660.8 729.9 786.3 13444.6 13482.1 13515.7 13555.0 15665.1 14836.1 14894.8 14934.0 14957.3 14966.1 669.7 678.8 811.3 813.2 835.9 824.6 827.7 829.4 830.9 837.3 710.5 878.2 878.4 879.0 881.1 870.7 888.8 889.6 890.5 891.2 654.4 654.6 654.6 655.2 655.2 13829.3 13864.3 13870.0 13884.2 13911.8 12279.3 12540.0 12632.4 12705.2 13156.6 10083.5 10174.7 10381.8 10447.8 10490.8 3533.6 3606.3 3623.4 3635.2 3636.9 48369.8 48854.0 48913.8 49018.0 49271.3 9381.8 9534.3 9654.4 9777.3 9787.5 17863.2 17897.6 17898.1 17907.2 17941.4 7171.5 7245.0 7650.4 7756.8 7796.1 4216.8 4239.9 4281.0 4288.1 4331.9 3049.6 3077.0 3085.0 3088.8 3093.2 553.9 563.0 563.6 571.3 590.0 565.7 638.8 665.9 691.2 696.3 7801.9 8511.8 8547.3 8591.1 8763.4 556.4 593.0 607.9 608.8 629.0 3611.4 3864.8 3931.4 4039.9 4065.9 48987.0 49345.5 56284.0 56526.7 56820.4 43547.8 43875.0 43903.6 44182.0 48530.8 47227.8 47249.3 47725.3 47923.5 48320.3 8276.2 8633.6 8687.4 8826.1 8881.9 34300.8 35352.5 35584.6 35585.6 35735.8 42205.8 43588.8 45616.8 45808.8 45980.9 10419.4 10506.2 10579.5 10590.7 10993.7 11676.6 11856.7 11886.2 12091.4 12414.5 10902.3 11235.9 11473.3 11496.4 11820.2 10453.4 10582.7 10850.5 11019.2 11052.8 11149.4 11253.5 11258.9 11283.8 11612.5 9081.9 9305.1 9372.6 9396.4 9527.4 8910.2 9129.9 9132.9 9194.5 9844.8 23:14:10 INFO - PROCESS | 9725 | -------- Summary: end -------- 23:14:10 INFO - PROCESS | 9725 | 23:14:11 INFO - TEST-INFO | 9725: exit 0 23:14:11 INFO - TEST-OK | dromaeo_css | took 1112630ms 23:14:11 INFO - TEST-START | kraken 23:14:11 INFO - operating with platform_type : linux_ 23:14:11 INFO - Initialising browser for kraken test... 23:14:11 INFO - TEST-INFO | started process 9913 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLznRxK/profile http://localhost:33441/getInfo.html) 23:14:15 INFO - PROCESS | 9913 | __metrics Screen width/height:1600/1200 23:14:15 INFO - PROCESS | 9913 | colorDepth:24 23:14:15 INFO - PROCESS | 9913 | Browser inner width/height: 1024/697 23:14:15 INFO - PROCESS | 9913 | __metrics 23:14:16 INFO - PROCESS | 9913 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:14:17 INFO - TEST-INFO | 9913: exit 0 23:14:17 INFO - Browser initialized. 23:14:17 INFO - Running cycle 1/1 for kraken test... 23:14:17 INFO - TEST-INFO | started process 9996 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLznRxK/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:14:29 INFO - PROCESS | 9996 | RSS: Main: 147558400 23:14:29 INFO - PROCESS | 9996 | 23:14:31 INFO - PROCESS | 9996 | Cycle 1(1): loaded http://localhost:33441/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33441/tests/kraken/driver.html?testName=audio-beat-detection) 23:14:32 INFO - PROCESS | 9996 | RSS: Main: 191098880 23:14:32 INFO - PROCESS | 9996 | 23:14:34 INFO - PROCESS | 9996 | Cycle 1(1): loaded http://localhost:33441/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33441/tests/kraken/driver.html?testName=audio-dft) 23:14:35 INFO - PROCESS | 9996 | RSS: Main: 180822016 23:14:35 INFO - PROCESS | 9996 | 23:14:38 INFO - PROCESS | 9996 | Cycle 1(1): loaded http://localhost:33441/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33441/tests/kraken/driver.html?testName=audio-fft) 23:14:38 INFO - PROCESS | 9996 | RSS: Main: 167370752 23:14:38 INFO - PROCESS | 9996 | 23:14:40 INFO - PROCESS | 9996 | Cycle 1(1): loaded http://localhost:33441/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33441/tests/kraken/driver.html?testName=audio-oscillator) 23:14:41 INFO - PROCESS | 9996 | RSS: Main: 166715392 23:14:41 INFO - PROCESS | 9996 | 23:14:43 INFO - PROCESS | 9996 | Cycle 1(1): loaded http://localhost:33441/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33441/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:14:44 INFO - PROCESS | 9996 | RSS: Main: 169881600 23:14:44 INFO - PROCESS | 9996 | 23:14:47 INFO - PROCESS | 9996 | Cycle 1(1): loaded http://localhost:33441/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33441/tests/kraken/driver.html?testName=imaging-darkroom) 23:14:47 INFO - PROCESS | 9996 | RSS: Main: 169492480 23:14:47 INFO - PROCESS | 9996 | 23:14:51 INFO - PROCESS | 9996 | Cycle 1(1): loaded http://localhost:33441/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33441/tests/kraken/driver.html?testName=imaging-desaturate) 23:14:51 INFO - PROCESS | 9996 | RSS: Main: 170962944 23:14:51 INFO - PROCESS | 9996 | 23:14:54 INFO - PROCESS | 9996 | Cycle 1(1): loaded http://localhost:33441/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33441/tests/kraken/driver.html?testName=json-parse-financial) 23:14:55 INFO - PROCESS | 9996 | RSS: Main: 171163648 23:14:55 INFO - PROCESS | 9996 | 23:14:56 INFO - PROCESS | 9996 | Cycle 1(1): loaded http://localhost:33441/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33441/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:14:57 INFO - PROCESS | 9996 | RSS: Main: 179232768 23:14:57 INFO - PROCESS | 9996 | 23:14:59 INFO - PROCESS | 9996 | Cycle 1(1): loaded http://localhost:33441/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33441/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:14:59 INFO - PROCESS | 9996 | RSS: Main: 179073024 23:14:59 INFO - PROCESS | 9996 | 23:15:01 INFO - PROCESS | 9996 | Cycle 1(1): loaded http://localhost:33441/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33441/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:15:02 INFO - PROCESS | 9996 | RSS: Main: 188260352 23:15:02 INFO - PROCESS | 9996 | 23:15:04 INFO - PROCESS | 9996 | Cycle 1(1): loaded http://localhost:33441/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33441/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:15:05 INFO - PROCESS | 9996 | RSS: Main: 196079616 23:15:05 INFO - PROCESS | 9996 | 23:15:08 INFO - PROCESS | 9996 | Cycle 1(1): loaded http://localhost:33441/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33441/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:15:08 INFO - PROCESS | 9996 | RSS: Main: 194150400 23:15:08 INFO - PROCESS | 9996 | 23:15:10 INFO - PROCESS | 9996 | Cycle 1(1): loaded http://localhost:33441/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33441/tests/kraken/driver.html?testName=ai-astar) 23:15:10 INFO - PROCESS | 9996 | RSS: Main: 256684032 23:15:10 INFO - PROCESS | 9996 | 23:15:10 INFO - PROCESS | 9996 | __start_tp_report 23:15:10 INFO - PROCESS | 9996 | _x_x_mozilla_page_load 23:15:10 INFO - PROCESS | 9996 | _x_x_mozilla_page_load_details 23:15:10 INFO - PROCESS | 9996 | |i|pagename|runs| 23:15:10 INFO - PROCESS | 9996 | |0;ai-astar;112;112;108;112;112;113;103;112;110;110 23:15:10 INFO - PROCESS | 9996 | |1;audio-beat-detection;149;128;159;166;129;152;160;131;173;128 23:15:10 INFO - PROCESS | 9996 | |2;audio-dft;160;163;162;161;161;160;160;165;163;161 23:15:10 INFO - PROCESS | 9996 | |3;audio-fft;73;74;100;102;74;74;74;118;95;77 23:15:10 INFO - PROCESS | 9996 | |4;audio-oscillator;97;96;142;95;96;96;140;96;96;136 23:15:10 INFO - PROCESS | 9996 | |5;imaging-gaussian-blur;120;114;114;115;115;115;114;115;115;114 23:15:10 INFO - PROCESS | 9996 | |6;imaging-darkroom;147;145;145;145;145;145;146;145;145;145 23:15:10 INFO - PROCESS | 9996 | |7;imaging-desaturate;97;98;97;96;96;96;96;95;95;95 23:15:10 INFO - PROCESS | 9996 | |8;json-parse-financial;59;57;58;56;57;58;57;65;54;54 23:15:10 INFO - PROCESS | 9996 | |9;json-stringify-tinderbox;69;67;68;67;68;68;70;67;68;69 23:15:10 INFO - PROCESS | 9996 | |10;stanford-crypto-aes;82;83;85;83;89;90;83;82;83;82 23:15:10 INFO - PROCESS | 9996 | |11;stanford-crypto-ccm;119;122;123;119;119;120;128;117;134;126 23:15:10 INFO - PROCESS | 9996 | |12;stanford-crypto-pbkdf2;142;143;152;161;161;136;150;159;148;150 23:15:10 INFO - PROCESS | 9996 | |13;stanford-crypto-sha256-iterative;69;67;70;70;76;67;68;71;68;67 23:15:10 INFO - PROCESS | 9996 | __end_tp_report 23:15:10 INFO - PROCESS | 9996 | __start_cc_report 23:15:10 INFO - PROCESS | 9996 | _x_x_mozilla_cycle_collect,955 23:15:10 INFO - PROCESS | 9996 | __end_cc_report 23:15:10 INFO - PROCESS | 9996 | __startTimestamp1455693310559__endTimestamp 23:15:10 INFO - PROCESS | 9996 | 23:15:10 INFO - PROCESS | 9996 | ------- Summary: start ------- 23:15:10 INFO - PROCESS | 9996 | Number of tests: 14 23:15:10 INFO - PROCESS | 9996 | 23:15:10 INFO - PROCESS | 9996 | [#0] ai-astar Cycles:10 Average:110.40 Median:112.00 stddev:2.99 (2.7%) stddev-sans-first:3.11 23:15:10 INFO - PROCESS | 9996 | Values: 112.0 112.0 108.0 112.0 112.0 113.0 103.0 112.0 110.0 110.0 23:15:10 INFO - PROCESS | 9996 | 23:15:10 INFO - PROCESS | 9996 | [#1] audio-beat-detection Cycles:10 Average:147.50 Median:155.50 stddev:17.25 (11.1%) stddev-sans-first:18.29 23:15:10 INFO - PROCESS | 9996 | Values: 149.0 128.0 159.0 166.0 129.0 152.0 160.0 131.0 173.0 128.0 23:15:10 INFO - PROCESS | 9996 | 23:15:10 INFO - PROCESS | 9996 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:1.65 (1.0%) stddev-sans-first:1.64 23:15:10 INFO - PROCESS | 9996 | Values: 160.0 163.0 162.0 161.0 161.0 160.0 160.0 165.0 163.0 161.0 23:15:10 INFO - PROCESS | 9996 | 23:15:10 INFO - PROCESS | 9996 | [#3] audio-fft Cycles:10 Average:86.10 Median:74.00 stddev:16.27 (22.0%) stddev-sans-first:16.55 23:15:10 INFO - PROCESS | 9996 | Values: 73.0 74.0 100.0 102.0 74.0 74.0 74.0 118.0 95.0 77.0 23:15:10 INFO - PROCESS | 9996 | 23:15:10 INFO - PROCESS | 9996 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:96.00 stddev:20.99 (21.9%) stddev-sans-first:21.81 23:15:10 INFO - PROCESS | 9996 | Values: 97.0 96.0 142.0 95.0 96.0 96.0 140.0 96.0 96.0 136.0 23:15:10 INFO - PROCESS | 9996 | 23:15:10 INFO - PROCESS | 9996 | [#5] imaging-gaussian-blur Cycles:10 Average:115.10 Median:115.00 stddev:1.79 (1.6%) stddev-sans-first:0.53 23:15:10 INFO - PROCESS | 9996 | Values: 120.0 114.0 114.0 115.0 115.0 115.0 114.0 115.0 115.0 114.0 23:15:10 INFO - PROCESS | 9996 | 23:15:10 INFO - PROCESS | 9996 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.67 (0.5%) stddev-sans-first:0.33 23:15:10 INFO - PROCESS | 9996 | Values: 147.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 23:15:10 INFO - PROCESS | 9996 | 23:15:10 INFO - PROCESS | 9996 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.99 (1.0%) stddev-sans-first:1.00 23:15:10 INFO - PROCESS | 9996 | Values: 97.0 98.0 97.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 23:15:10 INFO - PROCESS | 9996 | 23:15:10 INFO - PROCESS | 9996 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:57.50 stddev:3.10 (5.4%) stddev-sans-first:3.24 23:15:10 INFO - PROCESS | 9996 | Values: 59.0 57.0 58.0 56.0 57.0 58.0 57.0 65.0 54.0 54.0 23:15:10 INFO - PROCESS | 9996 | 23:15:10 INFO - PROCESS | 9996 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.99 (1.5%) stddev-sans-first:1.00 23:15:10 INFO - PROCESS | 9996 | Values: 69.0 67.0 68.0 67.0 68.0 68.0 70.0 67.0 68.0 69.0 23:15:10 INFO - PROCESS | 9996 | 23:15:10 INFO - PROCESS | 9996 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:83.00 stddev:2.94 (3.5%) stddev-sans-first:3.00 23:15:10 INFO - PROCESS | 9996 | Values: 82.0 83.0 85.0 83.0 89.0 90.0 83.0 82.0 83.0 82.0 23:15:10 INFO - PROCESS | 9996 | 23:15:10 INFO - PROCESS | 9996 | [#11] stanford-crypto-ccm Cycles:10 Average:122.70 Median:122.50 stddev:5.25 (4.3%) stddev-sans-first:5.40 23:15:10 INFO - PROCESS | 9996 | Values: 119.0 122.0 123.0 119.0 119.0 120.0 128.0 117.0 134.0 126.0 23:15:10 INFO - PROCESS | 9996 | 23:15:10 INFO - PROCESS | 9996 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.20 Median:151.00 stddev:8.43 (5.6%) stddev-sans-first:8.40 23:15:10 INFO - PROCESS | 9996 | Values: 142.0 143.0 152.0 161.0 161.0 136.0 150.0 159.0 148.0 150.0 23:15:10 INFO - PROCESS | 9996 | 23:15:10 INFO - PROCESS | 9996 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.50 stddev:2.75 (4.0%) stddev-sans-first:2.92 23:15:10 INFO - PROCESS | 9996 | Values: 69.0 67.0 70.0 70.0 76.0 67.0 68.0 71.0 68.0 67.0 23:15:10 INFO - PROCESS | 9996 | -------- Summary: end -------- 23:15:10 INFO - PROCESS | 9996 | 23:15:11 INFO - TEST-INFO | 9996: exit 0 23:15:11 INFO - TEST-OK | kraken | took 60070ms 23:15:11 INFO - SUITE-END | took 1172s 23:15:11 INFO - Completed test suite (00:19:32) 23:15:11 INFO - Working with test: dromaeo_css 23:15:11 INFO - Generating results file: dromaeo_css 23:15:11 INFO - Working with test: kraken 23:15:11 INFO - Generating results file: kraken 23:15:11 INFO - javascript benchmark 23:15:11 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:15:11 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 23:15:11 INFO - process_Request line: dromaeo_css 6739.79 graph.html#tests=[[72,64,35]] 23:15:11 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:15:11 INFO - process_Request line: kraken 1523.10 graph.html#tests=[[232,64,35]] 23:15:11 INFO - RETURN: dromaeo_css: 6739.79 23:15:11 INFO - RETURN: kraken: 1523.10 23:15:11 INFO - javascript benchmark 23:15:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3067.570540124382, 3147.071613873907, 3167.6357218919816, 3187.250996015936, 3219.6297425796033, 4849.830255941043, 4929.728864912428, 4990.925136122956, 5040.798368065278, 5043.672161309517, 4935.506449355072, 5045.1423258046125, 5056.115179843522, 5127.205283181103, 5156.175011998081, 4480.663950203748, 4526.185286648394, 4544.590986811187, 4552.772361381934, 4595.471520775121, 4655.045715628305, 4704.623630109583, 4720.669553131283, 4725.881852953669, 4732.124556956956, 4560.703554268962, 4632.930506042412, 4643.3731446255, 4656.138614356355, 4697.788599513013, 4548.681592288541, 4554.294084416921, 4558.863234102949, 4559.156556037111, 4565.269556870885, 4521.050579378334, 4545.704529205591, 4548.931766023512, 4555.9772201138785, 4609.124266389409, 4986.87532811679, 4992.950070499285, 5011.523905228997, 5020.698758074527, 5035.446100928895, 5444.863878403032, 5445.482679145475, 5466.617336786427, 5467.535259502947, 5508.44915508446, 5264.499872512105, 5300.814471493479, 5369.677819330814, 5425.701586412746, 5427.402985671573, 5034.219695947134, 5071.18860982241, 5077.390713114413, 5082.390113186404, 5089.847304580869, 5488.725563721798, 5489.752961116759, 5490.588205884575, 5494.2582751328055, 5507.917381239285, 5168.8966220675375, 5257.185136303879, 5292.44429334922, 5360.088784906575, 5393.568514518829, 5314.096603577324, 5324.5740340772645, 5333.359996800331, 5339.145736682112, 5340.946590534123, 5310.442403547572, 5320.920186197211, 5321.600879934021, 5324.0150572144275, 5368.114261146945, 5264.341957255343, 5349.839504814861, 5364.6512976656395, 5377.946220537823, 5452.372977107604, 4265.168292182994, 4289.485261768607, 4293.656507479394, 4327.459067616548, 4329.913401732011, 3808.352580061396, 3878.903027424337, 3879.4180872868733, 3887.2031233597045, 3926.86255981045, 5082.2122571001555, 5108.565771909355, 5115.693058416433, 5133.537981581676, 5161.66449180802, 5389.083855744533, 5412.539934105566, 5418.349798024262, 5426.213199086111, 5476.972615136899, 5007.499250074963, 5078.542931136216, 5154.7938082476285, 5161.0, 5166.095933211673, 4667.556582124693, 4681.6722829401615, 4689.835855745033, 4720.669553131248, 4728.88177795551, 5679.375268720438, 5679.801206957736, 5679.914801277984, 5688.800891968761, 5697.686627235459, 5293.047251494768, 5341.759620816995, 5375.892482150413, 5379.031774280511, 5456.536194423518, 5702.258706368146, 5716.399778023248, 5716.514096301695, 5732.16883551891, 5740.225069615549, 5308.814191503279, 5317.282166907573, 5324.414314425333, 5332.493413125747, 5332.706701131475, 5310.734463276898, 5409.107497262908, 5409.323834520685, 5442.428545002717, 5491.423400543045, 5212.270282160576, 5241.187615919539, 5243.0, 5243.606729495227, 5243.8164664236565, 5133.820316288912, 5243.501867322599, 5248.763805628832, 5249.685018898878, 5259.342582177228, 5087.64386492942, 5115.18157094863, 5182.818601348935, 5194.636375453682, 5194.870128246673, 5192.065428222956, 5214.8957020860125, 5216.37403511581, 5236.5548928339995, 5255.527002569787, 5085.0, 5101.795928162832, 5119.87200319995, 5120.078385890575, 5123.410807757006], "unit": "score", "name": "dojo.html", "value": 4996.434219992159}, {"lowerIsBetter": false, "replicates": [521.2858384013902, 526.0767353294967, 536.8577327008344, 549.7004132747652, 550.8925759476903, 28824.0, 29437.2640683983, 29448.26379340515, 36820.44769328462, 37213.069673258186, 39673.20653586926, 40103.39844902329, 40120.79939600298, 40274.0, 40347.0, 8520.02019767727, 8725.258353039999, 8729.301655867515, 8731.738047858542, 8735.432196907212, 8466.068732439428, 8591.44155629882, 8593.570321483932, 8598.699045533407, 8598.87101693475, 8834.072422395653, 8928.910710892873, 8931.95534022329, 8934.865977010317, 8940.687075952343, 8791.252743516809, 8863.601137948808, 8872.201501864798, 8876.0, 8879.911200887973, 8700.956495217546, 8790.384673072887, 8828.779280517974, 8860.955695221546, 8865.601047952858, 41175.7941210295, 41793.0, 41802.581974180175, 41875.790621047, 41879.1624167515, 3296.4890441981292, 3350.983245083759, 3478.4086705260165, 3706.4625629283605, 3992.2215168042244, 30422.695773042207, 30596.235094122603, 31001.534976975363, 31358.52962205569, 31666.208344791565, 3793.2223894101917, 3912.3544615138467, 3930.331843586597, 4011.7392369496183, 4127.29835927893, 258775.0, 259657.0, 260181.0, 260411.0, 262291.688541558, 42187.78906105511, 42712.57287427148, 59074.0, 60158.398416016156, 60427.0, 40922.0, 41122.58877411188, 41390.37914431286, 41404.58595414007, 41459.1708165835, 13367.799483007762, 13522.32388380577, 13605.523806666719, 13753.931230343784, 13775.0, 9288.303377246733, 11087.168462365355, 11142.331460112418, 11150.944245278723, 11158.944205278922, 13986.650333741534, 14191.509891461454, 14209.50266740659, 14221.502247421498, 14313.21277329736, 5616.466435688603, 5651.886962260732, 5722.914156287659, 5748.971255143698, 5756.913646295309, 914.8673442350822, 931.366670663955, 974.668612671695, 997.8852431970271, 1053.7839742852698, 28777.85611071973, 29069.273268168043, 29107.85446072756, 29502.262443439085, 29623.703762962527, 1030.567161792049, 1031.1802117316752, 1093.1582681335328, 1151.37825574189, 1161.5469966712988, 15096.0, 15174.468893588672, 15345.23273836326, 15465.226738663021, 15514.689706205812, 307245.0, 311895.0, 312279.0, 312677.0, 312783.0, 54069.72965135149, 54586.0, 54644.72677636586, 54652.0, 54660.453395466335, 1338.2305174524492, 1344.6235054184845, 1366.364640442199, 1368.9110207836459, 1370.1025828082622, 27503.86248068747, 28503.572446413735, 28525.14424567266, 28943.42113157767, 29084.418311633224, 47435.288470672276, 47937.5206247947, 47978.04043919172, 48057.75971120122, 48080.51919480901, 291216.0, 293570.0, 293702.0, 293744.0, 294236.0, 32127.196820079684, 33382.83308583539, 33479.33041339111, 33592.664073359934, 33596.160095997795, 43583.56416435795, 44297.55702443063, 44355.33466997933, 45068.54931450643, 45624.0, 36339.881014716455, 37079.44380834236, 37163.81418092892, 37869.81065094657, 37994.0, 37145.81427092847, 37349.25301494009, 38285.6171438282, 38566.22867542689, 38747.0, 36957.489038541295, 37734.24531509409, 38059.42910856395, 38075.619243808316, 38129.0, 32662.51006234956, 34170.82914585411, 34442.655573443946, 34795.304093917475, 34898.302033959684, 25768.484630307663, 25813.6127958077, 26082.355349004134, 26307.0, 26469.602955956063], "unit": "score", "name": "ext.html", "value": 17944.88391124742}, {"lowerIsBetter": false, "replicates": [348.766326561204, 359.41415492746836, 365.1929236387583, 367.3919662957805, 371.7806494168442, 12542.247465152097, 16161.595960101004, 17128.74306885396, 18099.4570162895, 18103.4568962931, 15078.924605376958, 15214.467493637725, 15790.368385264605, 15814.841851581481, 15883.761743573827, 4056.817443215062, 4216.388623649569, 4222.648752399234, 5335.0663633864115, 5492.093804522269, 4186.727862688916, 4381.605655491006, 5846.269216347957, 5968.074948383008, 6028.547858910577, 5912.17229587858, 5964.552658550604, 5977.282726072877, 5985.072313791347, 5987.0, 5778.942210577882, 5918.585699001072, 5931.228940237742, 5936.673482958436, 5936.7031648417405, 5225.843224703227, 5227.529522343008, 5231.764570594332, 5236.7905283788605, 5260.28986086881, 20083.698744518842, 20103.29638462647, 20241.595168096555, 20370.898145509327, 20371.89814050935, 2005.46855083403, 2005.8796472211714, 2029.4621925189836, 2106.273335699181, 2195.3194509702043, 9189.77025574366, 9198.95400522993, 9227.215686666641, 9545.284103692251, 9610.6636267731, 1775.9822401775946, 1833.734108554252, 1861.3578315481138, 1876.127600665697, 1881.2569035231145, 58870.41129588692, 60868.0, 61583.0, 62214.68892655553, 62403.68798156026, 8985.415947963493, 9439.103285187895, 9847.16299114569, 9903.851442228372, 9938.503074846229, 12976.935115324362, 13016.869831301756, 13257.867421325856, 13276.73446531064, 13305.334733263298, 7171.03191069199, 7259.346658800733, 7308.926910730931, 7311.597862117635, 7317.536492701374, 7033.366996970297, 7039.472039596948, 7069.823254418578, 7089.149302083783, 7101.89347159793, 4409.096135292258, 4444.866654000385, 4465.218586747306, 4494.123645889085, 4508.211063063951, 1791.3730194432105, 1798.5593529585074, 1843.889366638006, 1852.19429548147, 1884.2086323743786, 915.6520522201654, 923.4874644572327, 963.7735132243918, 1019.3934608907688, 1040.5785656809005, 16175.514734557983, 16322.510324690278, 16506.504804855875, 16514.33942642305, 16890.0, 795.4392153531746, 873.7728190670344, 902.5216635183364, 911.794846159622, 971.4220039076738, 9217.815643687089, 9369.753101706303, 9395.530223488935, 9420.717378478657, 9824.852627210597, 484559.0, 486944.0, 487129.0, 488832.0, 494649.0, 69475.65262173758, 70582.64708676423, 71728.2827171732, 73852.63073684704, 74870.0, 1083.3370775859019, 1093.0981939899614, 1106.2090605217309, 1107.3189988157064, 1108.4402376799826, 14215.0, 14644.194569298365, 14799.334029968462, 15255.160966146968, 15267.23663816827, 31175.688243118188, 31251.406088300137, 31381.52927706132, 31993.840030799696, 32503.0, 41334.586654133076, 44804.10391792081, 45050.54949450595, 45061.0, 45282.09435811331, 7546.24537546241, 7669.0, 7678.6544605494, 7749.380049595906, 7778.844423111619, 9674.56464459087, 11047.72380690489, 11429.199956003, 11542.884571154516, 11847.585334513251, 6454.935450645434, 8291.170882911661, 9748.415095094317, 10099.545520451744, 10505.42220177867, 9780.80438391214, 9876.35803672759, 10213.438260895722, 10221.9488902555, 10378.221633377376, 7030.50786444944, 7967.800804979922, 9046.239759137821, 9905.455199963782, 10199.592016319264, 7539.246075392417, 7654.201262703149, 7797.337226335598, 7809.882851757342, 7829.7259595913865, 9739.61041558358, 9744.902550974399, 9906.653267135616, 10205.59177632916, 10641.361518308617], "unit": "score", "name": "jquery.html", "value": 8129.029580349272}, {"lowerIsBetter": false, "replicates": [1364.6247281997455, 1429.9285035748214, 1441.1857300625145, 1609.9436519721812, 1812.728090786382, 6575.8027259182245, 7415.2584741525825, 7531.736389226378, 7546.924530754691, 7550.093988721361, 7165.104361954755, 7263.0921134858145, 7296.96351518243, 7297.197308296083, 7307.269273072703, 1933.7776155742129, 1980.0, 1980.554375265568, 2244.2145249162786, 2269.693591365161, 2289.8855057247156, 2336.6027775278158, 2343.027643527934, 2343.5195784864145, 2345.472268739537, 2175.1734340950416, 2194.078487035449, 2209.591225623265, 2309.457277539777, 2317.536492701458, 2262.298687406893, 2276.6243569810963, 2281.4296425893526, 2286.3598192506042, 2348.953020939589, 2293.392251053472, 2295.896684649195, 2296.334063121693, 2297.4715815362392, 2302.7697230277004, 7532.058492688414, 7571.24287571244, 7576.886346704804, 7577.204393538655, 7588.81027974305, 4697.060587882437, 4760.666753327268, 4769.523047695237, 4779.450363208241, 4783.067301876135, 3082.568440418343, 3093.3040065985197, 3156.305612765188, 3162.5926462724096, 3163.952540711868, 950.3632566180606, 952.0241752203978, 981.8969008254102, 992.1467537917457, 1009.3943633819723, 10536.26246162769, 10551.630692925788, 10552.261341706084, 10552.894471055344, 10567.471626418648, 4236.5128010278595, 4291.334843099325, 4303.827846886152, 4323.135372925364, 4432.31299148626, 9152.816943661222, 9159.22146617545, 9168.770780730536, 9188.632454701738, 9192.95403522978, 4809.2305231162845, 4843.321934929113, 4845.442774080955, 4852.199387101089, 4854.951450485521, 4379.759113248802, 4382.123575284956, 4426.468823741172, 4431.556844315543, 4437.911241775147, 3373.7638365314683, 3579.069441945113, 3663.267346530651, 3755.549334079928, 3761.6990640748672, 1158.7914175448332, 1175.4651633506735, 1179.887910648487, 1187.382561068257, 1188.7563049574817, 1276.5978716704208, 1282.4741855839247, 1303.8500572434102, 1319.0568743348551, 1339.1028011232497, 6824.283450237654, 6835.658217089126, 6839.589624622538, 6912.758053468205, 7017.508774385744, 1055.8732952045805, 1077.9137668986461, 1106.2068277599126, 1123.9100871930225, 1146.1003112556602, 5737.77048918047, 5848.912266316009, 5850.2102216200265, 5868.09044598088, 5875.853103672443, 9061.909380906238, 9148.2681385489, 9250.583723732449, 9276.814463710689, 9339.906600933904, 9120.315976301805, 9184.63261469547, 9209.171174594185, 9221.95389023064, 9232.492212928353, 7182.3535881770895, 7281.854362912712, 7287.963560182166, 7303.233160518069, 7346.485745997836, 7050.964745176241, 7089.0784198053925, 7105.715771369088, 7113.217546070032, 7115.501914865909, 7985.2014798519685, 8171.060328062111, 8220.260176584135, 8220.83558328842, 8372.87440688378, 8314.750557483285, 8402.95798521028, 8529.488230706178, 8581.95709021451, 8655.56722163902, 6660.666966651745, 6776.525643205126, 6860.862782744417, 6866.382025617719, 6890.20762612306, 6334.429901308904, 6929.099217101744, 7109.608971506616, 7305.598192099273, 7360.558366498028, 6694.330566943267, 6759.797206083826, 6858.3827455529245, 6872.381485666314, 6909.205441374306, 6592.934070659232, 6645.767398141042, 6666.133402657623, 6785.626790526569, 6811.89782153278, 6793.184817821893, 6851.07510486078, 6854.246032936473, 6855.6572171390235, 6858.554193977376, 6323.114763932961, 6473.935260647521, 6516.934830651633, 6537.280899101, 6547.476201903741, 6506.186726659168, 6517.608943463218, 6545.869082618226, 6550.508711846726, 6552.737890484327], "unit": "score", "name": "mootools.html", "value": 4449.6323215103575}, {"lowerIsBetter": false, "replicates": [335.7750307294113, 342.5923151449775, 346.1484747521098, 348.9214926641505, 350.1980464735755, 5669.1212862006405, 5695.373508914021, 5716.799912003081, 5741.311042674884, 5789.855253618651, 5419.187121931712, 5476.205950137238, 5550.47270509302, 5602.943970560294, 5652.463016013472, 4397.8240870365225, 4400.581944715247, 4411.316245981878, 4413.6910416270875, 4417.293233082707, 4277.2087163874785, 4448.666350023745, 4458.621017213541, 4459.331100334944, 4462.509123996374, 4320.265554855667, 4388.0, 4405.185040767452, 4410.62509686677, 4412.404325416076, 4432.135733531963, 4438.134563760068, 4443.977780111111, 4446.110777844444, 4446.644268458515, 3929.960700393017, 3936.389859571771, 3939.0, 3941.783201923893, 3941.8423263069444, 5392.946070539323, 5474.39781624021, 5486.1222204447495, 5489.1217405215375, 5490.639025219154, 5122.846314610568, 5156.948430515685, 5165.535101840853, 5166.948330516722, 5170.1986192140275, 5983.311919129313, 5985.281766188085, 5991.3109992351, 5994.310654274771, 5999.280086389661, 4365.279728844736, 4371.235033869092, 4372.781360931941, 4378.759168245745, 4379.146066517031, 6093.11649810775, 6257.405546473078, 6295.0, 6297.338779428185, 6338.080978258126, 4328.848490302824, 4348.043430445297, 4361.6510679145595, 4367.58507941745, 4375.693701440869, 4408.096340250241, 4411.625011873963, 4412.84555040572, 4414.161309351213, 4415.249407600716, 5069.1635880079375, 5074.695518268842, 5080.46655101209, 5084.669496482717, 5086.669366491166, 5932.495737862244, 6050.42520960508, 6053.424924632153, 6061.090836374491, 6068.393160683896, 1512.2816662085422, 1532.0501289200545, 1533.02652815463, 1534.946276880304, 1535.0405996252343, 1019.1591936652292, 1039.5841663334575, 1041.1254546181244, 1043.3166276089173, 1053.7681710023783, 5871.911921321183, 5872.236609240771, 5872.765089396376, 5873.500752436005, 5880.323762767251, 6244.063390491463, 6244.500439964792, 6247.718852651642, 6249.156363890907, 6250.124982502453, 5672.064109421982, 5774.82675519735, 5802.680852553066, 5859.091840764689, 5877.5591830612875, 3343.297907439416, 3360.277540328841, 3375.8480868360984, 3382.4080785862375, 3386.8645254189555, 6634.170728658918, 6636.369544893228, 6637.867242655217, 6651.66741662915, 6653.833654158685, 6245.906311405332, 6371.936280637227, 6455.677216139175, 6457.806265812033, 6481.0602462642655, 6762.323767623198, 6768.153980752406, 6769.42459890905, 6783.559068660521, 6789.0834737310815, 6297.622142671455, 6302.1492098566105, 6321.462675672619, 6323.873522529431, 6326.272478664829, 6034.456898879122, 6153.4769544587425, 6224.502039836892, 6226.40849119333, 6239.594426362272, 6765.052892594942, 6769.1876974763345, 6782.98255261695, 6809.046733457221, 6863.897041544281, 4325.76208308546, 4390.714603550759, 4396.868093957187, 4397.6042156206095, 4399.076193999296, 6141.3551577085545, 6277.435030847246, 6298.275698294571, 6333.8733225336155, 6340.841478963062, 6125.050617154348, 6131.325554189125, 6132.601380910227, 6142.232220972379, 6142.385761423822, 6105.877882442415, 6139.570230083851, 6150.077488376779, 6158.353372895961, 6159.244615284622, 5904.380040095728, 6048.032314829607, 6050.394960503914, 6058.636481811105, 6062.302835174011, 6174.228221472316, 6175.9073613894925, 6176.81469555914, 6181.196444462191, 6182.474489668429, 6026.789062382795, 6030.577859549965, 6037.75848966054, 6046.758129674764, 6050.969745151246], "unit": "score", "name": "prototype.html", "value": 4628.716559277756}, {"lowerIsBetter": false, "replicates": [650.5381179362653, 659.0805825872909, 660.8314879705674, 729.879569870971, 786.2884089898644, 13444.596662100128, 13482.123661961978, 13515.729685406286, 13555.0, 15665.138417387068, 14836.109833409975, 14894.776578351333, 14934.0, 14957.326920288586, 14966.102033877974, 669.7454967112491, 678.8065401360614, 811.3468657730554, 813.1705660226565, 835.8620827563444, 824.6495239523209, 827.7268501394525, 829.4318391901537, 830.8629076202419, 837.3175861672747, 710.4990981358156, 878.2096113497871, 878.4158534574532, 879.0374539878823, 881.0836729800999, 870.6909047288217, 888.7911340834899, 889.6263569300877, 890.4523717913502, 891.1979218703154, 654.3914159831355, 654.5777973207303, 654.5941516259902, 655.2006552006544, 655.220287857448, 13829.308534573333, 13864.306784660726, 13870.029097963146, 13884.23636699981, 13911.79132313016, 12279.324637144953, 12540.0, 12632.431540580605, 12705.237685738884, 13156.60530184096, 10083.49582520871, 10174.745631359201, 10381.84427233592, 10447.791044179074, 10490.79018419635, 3533.628968958248, 3606.3328284267495, 3623.40213864712, 3635.2184280379847, 3636.945445818315, 48369.75815120902, 48854.0, 48913.75543122261, 49018.0, 49271.260931086064, 9381.765455863659, 9534.28492863038, 9654.420734755797, 9777.315587908779, 9787.510624468749, 17863.196156173002, 17897.552561185814, 17898.10509474547, 17907.1941762621, 17941.37205197838, 7171.462140339496, 7244.963775181091, 7650.42621803367, 7756.844863102707, 7796.064472263365, 4216.831326746896, 4239.936400953989, 4280.978595107004, 4288.120935208275, 4331.870043898688, 3049.573059771634, 3077.046115704139, 3085.0, 3088.783785135019, 3093.211231136046, 553.8698405874616, 562.9774809007675, 563.6477201748907, 571.3229822660161, 590.0117303516593, 565.7256230728094, 638.8339031851659, 665.9146679331913, 691.2430888177438, 696.3002182806349, 7801.9103483809195, 8511.829763404698, 8547.27348175412, 8591.140885911358, 8763.430377025601, 556.3574071946908, 592.9881402372015, 607.9392060793974, 608.8325710429667, 628.9905651415232, 3611.3860643690637, 3864.8260828262796, 3931.410288456754, 4039.8990025249605, 4065.8576949806616, 48987.0, 49345.50654493409, 56284.0, 56526.71736641291, 56820.43179568234, 43547.78226108849, 43875.0, 43903.560964390585, 44182.0, 48530.757346213046, 47227.76386118116, 47249.291260631115, 47725.284120738215, 47923.5207647926, 48320.27519587209, 8276.213759692819, 8633.568321584022, 8687.435316704394, 8826.109493998933, 8881.911180888108, 34300.828495857364, 35352.46971295381, 35584.64415355813, 35585.64414355823, 35735.82132089323, 42205.78897105618, 43588.78205608952, 45616.771916140206, 45808.770956145, 45980.8504787383, 10419.374837509773, 10506.212034097625, 10579.471026448493, 10590.735231618963, 10993.670189894316, 11676.649700508999, 11856.70358241051, 11886.167968242486, 12091.395430228278, 12414.503419863104, 10902.345859248471, 11235.887641123483, 11473.311601303949, 11496.425178740863, 11820.172587918763, 10453.372797632166, 10582.682519524427, 10850.45747712627, 11019.228653994463, 11052.778944420907, 11149.386783726974, 11253.549858005588, 11258.943705281421, 11283.815199404273, 11612.535498579962, 9081.909180908106, 9305.098132721221, 9372.578233979624, 9396.389234699722, 9527.380720253439, 8910.198082172636, 9129.908700912905, 9132.908670913206, 9194.49430281341, 9844.803103938024], "unit": "score", "name": "yui.html", "value": 6243.318992843652}], "name": "dromaeo_css", "value": 6739.791249651322}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 112.0, 108.0, 112.0, 112.0, 113.0, 103.0, 112.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.4}, {"lowerIsBetter": true, "replicates": [149.0, 128.0, 159.0, 166.0, 129.0, 152.0, 160.0, 131.0, 173.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 147.5}, {"lowerIsBetter": true, "replicates": [160.0, 163.0, 162.0, 161.0, 161.0, 160.0, 160.0, 165.0, 163.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 100.0, 102.0, 74.0, 74.0, 74.0, 118.0, 95.0, 77.0], "unit": "score", "name": "audio-fft", "value": 86.1}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 142.0, 95.0, 96.0, 96.0, 140.0, 96.0, 96.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 109.0}, {"lowerIsBetter": true, "replicates": [120.0, 114.0, 114.0, 115.0, 115.0, 115.0, 114.0, 115.0, 115.0, 114.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.1}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 97.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [59.0, 57.0, 58.0, 56.0, 57.0, 58.0, 57.0, 65.0, 54.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.5}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 68.0, 67.0, 68.0, 68.0, 70.0, 67.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 85.0, 83.0, 89.0, 90.0, 83.0, 82.0, 83.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.2}, {"lowerIsBetter": true, "replicates": [119.0, 122.0, 123.0, 119.0, 119.0, 120.0, 128.0, 117.0, 134.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.7}, {"lowerIsBetter": true, "replicates": [142.0, 143.0, 152.0, 161.0, 161.0, 136.0, 150.0, 159.0, 148.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.2}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 70.0, 70.0, 76.0, 67.0, 68.0, 71.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.3}], "name": "kraken", "value": 1523.1}]} 23:15:12 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1523.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6739.79"}}} 23:15:12 INFO - Return code: 0 23:15:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:15:12 INFO - # TBPL SUCCESS # 23:15:12 INFO - Running post-action listener: _resource_record_post_action 23:15:12 INFO - Running post-run listener: _resource_record_post_run 23:15:13 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 538103808; Read time: 16; Write time: 470300 23:15:13 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 240508928; Read time: 0; Write time: 259692 23:15:13 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 297594880; Read time: 16; Write time: 210608 23:15:13 INFO - Running post-run listener: _upload_blobber_files 23:15:13 INFO - Blob upload gear active. 23:15:13 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:15:13 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 23:15:13 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'] 23:15:13 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 23:15:13 INFO - (blobuploader) - INFO - Open directory for files ... 23:15:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 23:15:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:15:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:15:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:15:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:15:14 INFO - (blobuploader) - INFO - Done attempting. 23:15:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:15:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:15:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:15:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:15:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:15:15 INFO - (blobuploader) - INFO - Done attempting. 23:15:15 INFO - (blobuploader) - INFO - Iteration through files over. 23:15:15 INFO - Return code: 0 23:15:15 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:15:15 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:15:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aaf8ad684553b4f81829c3d4b72ca7d393fde67b79a2a4b5617086956c9a1b074e329ea8994cd671e027a0af47c04e019621d862cf4628e466430aa5acedf198", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bfe7cdd0aec0e4ea19fbcd3956991c98da5e0097d7631efcf516af9d423685ea40c99509e875048b6c28cb0eaf216f47b87e999a913b66fe55aed73db27361b6"} 23:15:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:15:15 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:15:15 INFO - Contents: 23:15:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aaf8ad684553b4f81829c3d4b72ca7d393fde67b79a2a4b5617086956c9a1b074e329ea8994cd671e027a0af47c04e019621d862cf4628e466430aa5acedf198", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bfe7cdd0aec0e4ea19fbcd3956991c98da5e0097d7631efcf516af9d423685ea40c99509e875048b6c28cb0eaf216f47b87e999a913b66fe55aed73db27361b6"} 23:15:15 INFO - Running post-run listener: copy_logs_to_upload_dir 23:15:15 INFO - Copying logs to upload dir... 23:15:15 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 23:15:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.170907 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-02-16 23:15:14.857160) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-16 23:15:14.861269) ========= 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=32c5991c409366f7fec8a718000001d2-1455688561.831153-228785954 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/aaf8ad684553b4f81829c3d4b72ca7d393fde67b79a2a4b5617086956c9a1b074e329ea8994cd671e027a0af47c04e019621d862cf4628e466430aa5acedf198", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bfe7cdd0aec0e4ea19fbcd3956991c98da5e0097d7631efcf516af9d423685ea40c99509e875048b6c28cb0eaf216f47b87e999a913b66fe55aed73db27361b6"} build_url:https://queue.taskcluster.net/v1/task/GW6Y9T6JRzuB4kHAxxRXJw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011478 build_url: 'https://queue.taskcluster.net/v1/task/GW6Y9T6JRzuB4kHAxxRXJw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aaf8ad684553b4f81829c3d4b72ca7d393fde67b79a2a4b5617086956c9a1b074e329ea8994cd671e027a0af47c04e019621d862cf4628e466430aa5acedf198", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bfe7cdd0aec0e4ea19fbcd3956991c98da5e0097d7631efcf516af9d423685ea40c99509e875048b6c28cb0eaf216f47b87e999a913b66fe55aed73db27361b6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-16 23:15:14.885839) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 23:15:14.886144) ========= 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=32c5991c409366f7fec8a718000001d2-1455688561.831153-228785954 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004509 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 23:15:14.970950) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-16 23:15:14.971277) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-16 23:15:14.971593) ========= ========= Total master_lag: 0.27 =========