builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-008 starttime: 1458866961.24 results: success (0) buildid: 20160324143036 builduid: c60b8b921e5c4b2cae268ff38af25758 revision: 5e287404e4f8fd81330cd704e42fba5e3baa5f49 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 17:49:21.241578) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 17:49:21.242041) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-24 17:49:21.242328) ========= 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-1458866960.888627-767165492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006135 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-24 17:49:21.264484) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-24 17:49:21.264777) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-24 17:49:21.277834) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 17:49:21.278107) ========= 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-1458866960.888627-767165492 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-03-24 17:49:21.327497) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 17:49:21.327809) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 17:49:21.328161) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 17:49:21.328433) ========= 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-1458866960.888627-767165492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-24 17:49:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 18.2M=0.001s 2016-03-24 17:49:21 (18.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092794 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 17:49:21.433618) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 17:49:21.433951) ========= 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-1458866960.888627-767165492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022365 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 17:49:21.483096) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 17:49:21.483403) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5e287404e4f8fd81330cd704e42fba5e3baa5f49 --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 5e287404e4f8fd81330cd704e42fba5e3baa5f49 --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-1458866960.888627-767165492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-24 17:49:21,850 truncating revision to first 12 chars 2016-03-24 17:49:21,850 Setting DEBUG logging. 2016-03-24 17:49:21,850 attempt 1/10 2016-03-24 17:49:21,850 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5e287404e4f8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-24 17:49:22,131 unpacking tar archive at: fx-team-5e287404e4f8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.565197 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 17:49:22.061279) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-24 17:49:22.061641) ========= echo 5e287404e4f8fd81330cd704e42fba5e3baa5f49 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5e287404e4f8fd81330cd704e42fba5e3baa5f49'] 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-1458866960.888627-767165492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 5e287404e4f8fd81330cd704e42fba5e3baa5f49 program finished with exit code 0 elapsedTime=0.004260 script_repo_revision: '5e287404e4f8fd81330cd704e42fba5e3baa5f49' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-24 17:49:22.112400) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-24 17:49:22.112724) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-24 17:49:22.123206) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-03-24 17:49:22.123489) ========= /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-1458866960.888627-767165492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:49:22 INFO - MultiFileLogger online at 20160324 17:49:22 in /builds/slave/test-pgo 17:49:22 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 17:49:22 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 17:49:22 INFO - {'append_to_log': False, 17:49:22 INFO - 'base_work_dir': '/builds/slave/test-pgo', 17:49:22 INFO - 'blob_upload_branch': 'Fx-Team', 17:49:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 17:49:22 INFO - 'branch': 'Fx-Team', 17:49:22 INFO - 'buildbot_json_path': 'buildprops.json', 17:49:22 INFO - 'config_files': ('talos/linux_config.py',), 17:49:22 INFO - 'default_actions': ('clobber', 17:49:22 INFO - 'read-buildbot-config', 17:49:22 INFO - 'download-and-extract', 17:49:22 INFO - 'populate-webroot', 17:49:22 INFO - 'create-virtualenv', 17:49:22 INFO - 'install', 17:49:22 INFO - 'run-tests'), 17:49:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:49:22 INFO - 'download_minidump_stackwalk': True, 17:49:22 INFO - 'download_symbols': 'ondemand', 17:49:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:49:22 INFO - 'tooltool.py': '/tools/tooltool.py', 17:49:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:49:22 INFO - '/tools/misc-python/virtualenv.py')}, 17:49:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:49:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:49:22 INFO - 'installer_path': 'installer.exe', 17:49:22 INFO - 'log_level': 'info', 17:49:22 INFO - 'log_name': 'talos', 17:49:22 INFO - 'log_to_console': True, 17:49:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:49:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:49:22 INFO - 'opt_config_files': (), 17:49:22 INFO - 'pip_index': False, 17:49:22 INFO - 'sps_profile': False, 17:49:22 INFO - 'sps_profile_interval': 0, 17:49:22 INFO - 'suite': 'dromaeojs', 17:49:22 INFO - 'system_bits': '32', 17:49:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:49:22 INFO - 'title': 'talos-linux64-ix-008', 17:49:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:49:22 INFO - 'use_talos_json': True, 17:49:22 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 17:49:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:49:22 INFO - 'work_dir': 'build'} 17:49:22 INFO - ##### 17:49:22 INFO - ##### Running clobber step. 17:49:22 INFO - ##### 17:49:22 INFO - Running pre-action listener: _resource_record_pre_action 17:49:22 INFO - Running main action method: clobber 17:49:22 INFO - rmtree: /builds/slave/test-pgo/build 17:49:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 17:49:23 INFO - Running post-action listener: _resource_record_post_action 17:49:23 INFO - ##### 17:49:23 INFO - ##### Running read-buildbot-config step. 17:49:23 INFO - ##### 17:49:23 INFO - Running pre-action listener: _resource_record_pre_action 17:49:23 INFO - Running main action method: read_buildbot_config 17:49:23 INFO - Using buildbot properties: 17:49:23 INFO - { 17:49:23 INFO - "project": "", 17:49:23 INFO - "product": "firefox", 17:49:23 INFO - "script_repo_revision": "production", 17:49:23 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:49:23 INFO - "repository": "", 17:49:23 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:49:23 INFO - "buildid": "20160324143036", 17:49:23 INFO - "pgo_build": "True", 17:49:23 INFO - "basedir": "/builds/slave/test-pgo", 17:49:23 INFO - "buildnumber": 1030, 17:49:23 INFO - "slavename": "talos-linux64-ix-008", 17:49:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:49:23 INFO - "platform": "ubuntu64_hw", 17:49:23 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:49:23 INFO - "branch": "fx-team", 17:49:23 INFO - "repo_path": "integration/fx-team", 17:49:23 INFO - "revision": "5e287404e4f8fd81330cd704e42fba5e3baa5f49", 17:49:23 INFO - "stage_platform": "linux64-pgo", 17:49:23 INFO - "builduid": "c60b8b921e5c4b2cae268ff38af25758", 17:49:23 INFO - "slavebuilddir": "test" 17:49:23 INFO - } 17:49:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/dc8QqAQzSFOhg69W2mlQOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 17:49:23 INFO - Running post-action listener: _resource_record_post_action 17:49:23 INFO - ##### 17:49:23 INFO - ##### Running download-and-extract step. 17:49:23 INFO - ##### 17:49:23 INFO - Running pre-action listener: _resource_record_pre_action 17:49:23 INFO - Running main action method: download_and_extract 17:49:23 INFO - mkdir: /builds/slave/test-pgo/build/tests 17:49:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:23 INFO - https://queue.taskcluster.net/v1/task/dc8QqAQzSFOhg69W2mlQOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:49:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc8QqAQzSFOhg69W2mlQOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:49:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc8QqAQzSFOhg69W2mlQOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:49:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc8QqAQzSFOhg69W2mlQOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:49:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc8QqAQzSFOhg69W2mlQOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:49:23 INFO - Downloaded 1361 bytes. 17:49:23 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:49:23 INFO - Using the following test package requirements: 17:49:23 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:49:23 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:49:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:49:23 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:49:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:49:23 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:49:23 INFO - u'jsshell-linux-x86_64.zip'], 17:49:23 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:49:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:49:23 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:49:23 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:49:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:49:23 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:49:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:49:23 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:49:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:49:23 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:49:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:49:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:49:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:23 INFO - https://queue.taskcluster.net/v1/task/dc8QqAQzSFOhg69W2mlQOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:49:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc8QqAQzSFOhg69W2mlQOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:49:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc8QqAQzSFOhg69W2mlQOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:49:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc8QqAQzSFOhg69W2mlQOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:49:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc8QqAQzSFOhg69W2mlQOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:49:24 INFO - Downloaded 23638980 bytes. 17:49:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 17:49:24 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 17:49:26 INFO - Return code: 0 17:49:26 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:26 INFO - https://queue.taskcluster.net/v1/task/dc8QqAQzSFOhg69W2mlQOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:49:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc8QqAQzSFOhg69W2mlQOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:49:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc8QqAQzSFOhg69W2mlQOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:49:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc8QqAQzSFOhg69W2mlQOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:49:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc8QqAQzSFOhg69W2mlQOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:49:27 INFO - Downloaded 23638980 bytes. 17:49:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 17:49:27 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 17:49:28 INFO - Return code: 0 17:49:28 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')]} 17:49:28 INFO - https://queue.taskcluster.net/v1/task/dc8QqAQzSFOhg69W2mlQOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:49:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc8QqAQzSFOhg69W2mlQOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:49:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc8QqAQzSFOhg69W2mlQOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:49:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc8QqAQzSFOhg69W2mlQOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:49:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc8QqAQzSFOhg69W2mlQOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:49:29 INFO - Downloaded 10847187 bytes. 17:49:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 17:49:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 17:49:30 INFO - Return code: 0 17:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:30 INFO - https://queue.taskcluster.net/v1/task/dc8QqAQzSFOhg69W2mlQOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:49:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc8QqAQzSFOhg69W2mlQOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:49:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc8QqAQzSFOhg69W2mlQOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:49:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc8QqAQzSFOhg69W2mlQOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:49:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc8QqAQzSFOhg69W2mlQOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:49:32 INFO - Downloaded 57742523 bytes. 17:49:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dc8QqAQzSFOhg69W2mlQOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:49:32 INFO - mkdir: /builds/slave/test-pgo/properties 17:49:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 17:49:32 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 17:49:32 INFO - Contents: 17:49:32 INFO - build_url:https://queue.taskcluster.net/v1/task/dc8QqAQzSFOhg69W2mlQOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:49:33 INFO - Running post-action listener: _resource_record_post_action 17:49:33 INFO - Running post-action listener: set_extra_try_arguments 17:49:33 INFO - ##### 17:49:33 INFO - ##### Running populate-webroot step. 17:49:33 INFO - ##### 17:49:33 INFO - Running pre-action listener: _resource_record_pre_action 17:49:33 INFO - Running main action method: populate_webroot 17:49:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:49:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:49:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:49:33 INFO - '--tppagecycles', 17:49:33 INFO - '7'], 17:49:33 INFO - 'tests': ['tsvgm']}}, 17:49:33 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:49:33 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:49:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:49:33 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:49:33 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:49:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:49:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:49:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:33 INFO - 'talos_options': ['--e10s'], 17:49:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:49:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:33 INFO - 'tests': ['damp', 'tps']}, 17:49:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:33 INFO - 'talos_options': ['--e10s'], 17:49:33 INFO - 'tests': ['damp', 'tps']}, 17:49:33 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:49:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:49:33 INFO - 'other': {'tests': ['a11yr', 17:49:33 INFO - 'ts_paint', 17:49:33 INFO - 'tpaint', 17:49:33 INFO - 'sessionrestore', 17:49:33 INFO - 'sessionrestore_no_auto_restore', 17:49:33 INFO - 'tabpaint']}, 17:49:33 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:49:33 INFO - 'tests': ['a11yr', 17:49:33 INFO - 'ts_paint', 17:49:33 INFO - 'tpaint', 17:49:33 INFO - 'sessionrestore', 17:49:33 INFO - 'sessionrestore_no_auto_restore', 17:49:33 INFO - 'tabpaint']}, 17:49:33 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:49:33 INFO - 'tests': ['a11yr', 17:49:33 INFO - 'ts_paint', 17:49:33 INFO - 'tpaint', 17:49:33 INFO - 'sessionrestore', 17:49:33 INFO - 'sessionrestore_no_auto_restore', 17:49:33 INFO - 'tabpaint']}, 17:49:33 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:49:33 INFO - 'tests': ['a11yr', 17:49:33 INFO - 'ts_paint', 17:49:33 INFO - 'tpaint', 17:49:33 INFO - 'sessionrestore', 17:49:33 INFO - 'sessionrestore_no_auto_restore', 17:49:33 INFO - 'tabpaint']}, 17:49:33 INFO - 'other_l64': {'tests': ['a11yr', 17:49:33 INFO - 'ts_paint', 17:49:33 INFO - 'tpaint', 17:49:33 INFO - 'sessionrestore', 17:49:33 INFO - 'sessionrestore_no_auto_restore', 17:49:33 INFO - 'tabpaint']}, 17:49:33 INFO - 'other_nol64': {'tests': ['a11yr', 17:49:33 INFO - 'ts_paint', 17:49:33 INFO - 'tpaint', 17:49:33 INFO - 'sessionrestore', 17:49:33 INFO - 'sessionrestore_no_auto_restore', 17:49:33 INFO - 'tabpaint']}, 17:49:33 INFO - 'svgr': {'tests': ['tsvgx', 17:49:33 INFO - 'tsvgr_opacity', 17:49:33 INFO - 'tart', 17:49:33 INFO - 'tscrollx', 17:49:33 INFO - 'cart']}, 17:49:33 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:49:33 INFO - 'tests': ['tsvgx', 17:49:33 INFO - 'tsvgr_opacity', 17:49:33 INFO - 'tart', 17:49:33 INFO - 'tscrollx', 17:49:33 INFO - 'cart']}, 17:49:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:33 INFO - 'tests': ['tp5o']}, 17:49:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:33 INFO - 'talos_options': ['--e10s'], 17:49:33 INFO - 'tests': ['tp5o']}, 17:49:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:33 INFO - 'talos_options': ['--xperf_path', 17:49:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:49:33 INFO - 'tests': ['tp5n']}, 17:49:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:49:33 INFO - 'talos_options': ['--e10s', 17:49:33 INFO - '--xperf_path', 17:49:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:49:33 INFO - 'tests': ['tp5n']}}, 17:49:33 INFO - 'talos.zip': {'path': '', 17:49:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:49:33 INFO - Running post-action listener: _resource_record_post_action 17:49:33 INFO - ##### 17:49:33 INFO - ##### Running create-virtualenv step. 17:49:33 INFO - ##### 17:49:33 INFO - Running pre-action listener: _resource_record_pre_action 17:49:33 INFO - Running main action method: create_virtualenv 17:49:33 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 17:49:33 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 17:49:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 17:49:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:49:33 INFO - Using real prefix '/usr' 17:49:33 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 17:49:34 INFO - Installing distribute.............................................................................................................................................................................................done. 17:49:36 INFO - Installing pip.................done. 17:49:36 INFO - Return code: 0 17:49:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 17:49: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')]} 17:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49: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')]} 17:49:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:36 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 0x7feacff8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16586b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16531d0>, '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 0x1656750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1656be0>, '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-1458866960.888627-767165492', '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 17:49:36 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 17:49:36 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 17:49:36 INFO - Using env: {'DISPLAY': ':0', 17:49:36 INFO - 'HOME': '/home/cltbld', 17:49:36 INFO - 'LANG': 'en_US.UTF-8', 17:49:36 INFO - 'LANGUAGE': 'en_US:en', 17:49:36 INFO - 'LOGNAME': 'cltbld', 17:49:36 INFO - 'MAIL': '/var/mail/cltbld', 17:49:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:36 INFO - 'MOZ_NO_REMOTE': '1', 17:49:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:36 INFO - 'NO_EM_RESTART': '1', 17:49:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:49:36 INFO - 'PWD': '/builds/slave/test-pgo', 17:49:36 INFO - 'SHELL': '/bin/bash', 17:49:36 INFO - 'SHLVL': '1', 17:49:36 INFO - 'TERM': 'linux', 17:49:36 INFO - 'TMOUT': '86400', 17:49:36 INFO - 'USER': 'cltbld', 17:49:36 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1458866960.888627-767165492', 17:49:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:36 INFO - '_': '/tools/buildbot/bin/python'} 17:49:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:36 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 17:49:36 INFO - Cleaning up... 17:49:36 INFO - Return code: 0 17:49:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 17:49: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')]} 17:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49: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')]} 17:49:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:36 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 0x7feacff8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16586b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16531d0>, '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 0x1656750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1656be0>, '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-1458866960.888627-767165492', '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 17:49:36 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 17:49:36 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 17:49:36 INFO - Using env: {'DISPLAY': ':0', 17:49:36 INFO - 'HOME': '/home/cltbld', 17:49:36 INFO - 'LANG': 'en_US.UTF-8', 17:49:36 INFO - 'LANGUAGE': 'en_US:en', 17:49:36 INFO - 'LOGNAME': 'cltbld', 17:49:36 INFO - 'MAIL': '/var/mail/cltbld', 17:49:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:36 INFO - 'MOZ_NO_REMOTE': '1', 17:49:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:36 INFO - 'NO_EM_RESTART': '1', 17:49:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:49:36 INFO - 'PWD': '/builds/slave/test-pgo', 17:49:36 INFO - 'SHELL': '/bin/bash', 17:49:36 INFO - 'SHLVL': '1', 17:49:36 INFO - 'TERM': 'linux', 17:49:36 INFO - 'TMOUT': '86400', 17:49:36 INFO - 'USER': 'cltbld', 17:49:36 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1458866960.888627-767165492', 17:49:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:36 INFO - '_': '/tools/buildbot/bin/python'} 17:49:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:36 INFO - Downloading/unpacking psutil>=0.7.1 17:49:36 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 17:49:36 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 17:49:36 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 17:49:36 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 17:49:36 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 17:49:36 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 17:49:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 17:49:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:49:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:49:38 INFO - Installing collected packages: psutil 17:49:38 INFO - Running setup.py install for psutil 17:49:38 INFO - building 'psutil._psutil_linux' extension 17:49:38 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 17:49:38 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 17:49:38 INFO - building 'psutil._psutil_posix' extension 17:49:38 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 17:49:38 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 17:49:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:49:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:49:38 INFO - Successfully installed psutil 17:49:38 INFO - Cleaning up... 17:49:39 INFO - Return code: 0 17:49:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 17:49: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')]} 17:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49: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')]} 17:49:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:39 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 0x7feacff8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16586b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16531d0>, '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 0x1656750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1656be0>, '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-1458866960.888627-767165492', '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 17:49:39 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 17:49:39 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 17:49:39 INFO - Using env: {'DISPLAY': ':0', 17:49:39 INFO - 'HOME': '/home/cltbld', 17:49:39 INFO - 'LANG': 'en_US.UTF-8', 17:49:39 INFO - 'LANGUAGE': 'en_US:en', 17:49:39 INFO - 'LOGNAME': 'cltbld', 17:49:39 INFO - 'MAIL': '/var/mail/cltbld', 17:49:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:39 INFO - 'MOZ_NO_REMOTE': '1', 17:49:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:39 INFO - 'NO_EM_RESTART': '1', 17:49:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:49:39 INFO - 'PWD': '/builds/slave/test-pgo', 17:49:39 INFO - 'SHELL': '/bin/bash', 17:49:39 INFO - 'SHLVL': '1', 17:49:39 INFO - 'TERM': 'linux', 17:49:39 INFO - 'TMOUT': '86400', 17:49:39 INFO - 'USER': 'cltbld', 17:49:39 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1458866960.888627-767165492', 17:49:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:39 INFO - '_': '/tools/buildbot/bin/python'} 17:49:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:49:39 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 17:49:39 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 17:49:39 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 17:49:39 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 17:49:39 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 17:49:39 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 17:49:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:49:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:49:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:49:41 INFO - Installing collected packages: mozsystemmonitor 17:49:41 INFO - Running setup.py install for mozsystemmonitor 17:49:41 INFO - Successfully installed mozsystemmonitor 17:49:41 INFO - Cleaning up... 17:49:41 INFO - Return code: 0 17:49:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 17:49:41 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')]} 17:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:41 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')]} 17:49:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:41 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 0x7feacff8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16586b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16531d0>, '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 0x1656750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1656be0>, '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-1458866960.888627-767165492', '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 17:49:41 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 17:49:41 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 17:49:41 INFO - Using env: {'DISPLAY': ':0', 17:49:41 INFO - 'HOME': '/home/cltbld', 17:49:41 INFO - 'LANG': 'en_US.UTF-8', 17:49:41 INFO - 'LANGUAGE': 'en_US:en', 17:49:41 INFO - 'LOGNAME': 'cltbld', 17:49:41 INFO - 'MAIL': '/var/mail/cltbld', 17:49:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:41 INFO - 'MOZ_NO_REMOTE': '1', 17:49:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:41 INFO - 'NO_EM_RESTART': '1', 17:49:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:49:41 INFO - 'PWD': '/builds/slave/test-pgo', 17:49:41 INFO - 'SHELL': '/bin/bash', 17:49:41 INFO - 'SHLVL': '1', 17:49:41 INFO - 'TERM': 'linux', 17:49:41 INFO - 'TMOUT': '86400', 17:49:41 INFO - 'USER': 'cltbld', 17:49:41 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1458866960.888627-767165492', 17:49:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:41 INFO - '_': '/tools/buildbot/bin/python'} 17:49:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:41 INFO - Downloading/unpacking blobuploader==1.2.4 17:49:41 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 17:49:41 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 17:49:41 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 17:49:41 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 17:49:41 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 17:49:41 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 17:49:43 INFO - Downloading blobuploader-1.2.4.tar.gz 17:49:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:49:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:49:43 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 17:49:43 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 17:49:43 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 17:49:43 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 17:49:43 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 17:49:43 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 17:49:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 17:49:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:49:43 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 17:49:43 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 17:49:43 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 17:49:43 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 17:49:43 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 17:49:43 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 17:49:44 INFO - Downloading docopt-0.6.1.tar.gz 17:49:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 17:49:44 INFO - Installing collected packages: blobuploader, requests, docopt 17:49:44 INFO - Running setup.py install for blobuploader 17:49:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:49:44 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 17:49:44 INFO - Running setup.py install for requests 17:49:44 INFO - Running setup.py install for docopt 17:49:44 INFO - Successfully installed blobuploader requests docopt 17:49:44 INFO - Cleaning up... 17:49:44 INFO - Return code: 0 17:49:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:49:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:44 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 0x7feacff8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16586b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16531d0>, '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 0x1656750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1656be0>, '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-1458866960.888627-767165492', '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 17:49:44 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 17:49:44 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 17:49:44 INFO - Using env: {'DISPLAY': ':0', 17:49:44 INFO - 'HOME': '/home/cltbld', 17:49:44 INFO - 'LANG': 'en_US.UTF-8', 17:49:44 INFO - 'LANGUAGE': 'en_US:en', 17:49:44 INFO - 'LOGNAME': 'cltbld', 17:49:44 INFO - 'MAIL': '/var/mail/cltbld', 17:49:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:44 INFO - 'MOZ_NO_REMOTE': '1', 17:49:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:44 INFO - 'NO_EM_RESTART': '1', 17:49:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:49:44 INFO - 'PWD': '/builds/slave/test-pgo', 17:49:44 INFO - 'SHELL': '/bin/bash', 17:49:44 INFO - 'SHLVL': '1', 17:49:44 INFO - 'TERM': 'linux', 17:49:44 INFO - 'TMOUT': '86400', 17:49:44 INFO - 'USER': 'cltbld', 17:49:44 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1458866960.888627-767165492', 17:49:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:44 INFO - '_': '/tools/buildbot/bin/python'} 17:49:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:49:45 INFO - Running setup.py (path:/tmp/pip-yqDRrR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:49:45 INFO - Running setup.py (path:/tmp/pip-FvaNhk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:49:45 INFO - Running setup.py (path:/tmp/pip-veGLXq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:49:45 INFO - Running setup.py (path:/tmp/pip-pFwaTe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:49:45 INFO - Running setup.py (path:/tmp/pip-VSJoAU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:49:45 INFO - Running setup.py (path:/tmp/pip-DknHRc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:49:45 INFO - Running setup.py (path:/tmp/pip-7Z4MSF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:49:45 INFO - Running setup.py (path:/tmp/pip-83FN8b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:49:45 INFO - Running setup.py (path:/tmp/pip-yw5J_E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:49:45 INFO - Running setup.py (path:/tmp/pip-W7OQZt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:49:45 INFO - Running setup.py (path:/tmp/pip-X45xKV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:49:45 INFO - Running setup.py (path:/tmp/pip-KFFa8m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:49:45 INFO - Running setup.py (path:/tmp/pip-3j7M4T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:49:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:49:46 INFO - Running setup.py (path:/tmp/pip-XoEueQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:49:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:49:46 INFO - Running setup.py (path:/tmp/pip-28XE__-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:49:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:49:46 INFO - Running setup.py (path:/tmp/pip-adk0W_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:49:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:49:46 INFO - Running setup.py (path:/tmp/pip-p3UzyP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:49:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:49:46 INFO - Running setup.py install for manifestparser 17:49:46 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 17:49:46 INFO - Running setup.py install for mozcrash 17:49:46 INFO - Running setup.py install for mozdebug 17:49:46 INFO - Running setup.py install for mozdevice 17:49:46 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 17:49:46 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 17:49:46 INFO - Running setup.py install for mozfile 17:49:46 INFO - Running setup.py install for mozhttpd 17:49:46 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 17:49:46 INFO - Running setup.py install for mozinfo 17:49:46 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 17:49:47 INFO - Running setup.py install for mozInstall 17:49:47 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 17:49:47 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 17:49:47 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 17:49:47 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 17:49:47 INFO - Running setup.py install for mozleak 17:49:47 INFO - Running setup.py install for mozlog 17:49:47 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 17:49:47 INFO - Running setup.py install for moznetwork 17:49:47 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 17:49:47 INFO - Running setup.py install for mozprocess 17:49:47 INFO - Running setup.py install for mozprofile 17:49:47 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 17:49:47 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 17:49:47 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 17:49:47 INFO - Running setup.py install for mozrunner 17:49:47 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 17:49:47 INFO - Running setup.py install for mozscreenshot 17:49:47 INFO - Running setup.py install for moztest 17:49:47 INFO - Running setup.py install for mozversion 17:49:48 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 17:49:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:49:48 INFO - Cleaning up... 17:49:48 INFO - Return code: 0 17:49:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:49: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')]} 17:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49: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')]} 17:49:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:48 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 0x7feacff8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16586b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16531d0>, '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 0x1656750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1656be0>, '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-1458866960.888627-767165492', '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 17:49:48 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 17:49:48 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 17:49:48 INFO - Using env: {'DISPLAY': ':0', 17:49:48 INFO - 'HOME': '/home/cltbld', 17:49:48 INFO - 'LANG': 'en_US.UTF-8', 17:49:48 INFO - 'LANGUAGE': 'en_US:en', 17:49:48 INFO - 'LOGNAME': 'cltbld', 17:49:48 INFO - 'MAIL': '/var/mail/cltbld', 17:49:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:48 INFO - 'MOZ_NO_REMOTE': '1', 17:49:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:48 INFO - 'NO_EM_RESTART': '1', 17:49:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:49:48 INFO - 'PWD': '/builds/slave/test-pgo', 17:49:48 INFO - 'SHELL': '/bin/bash', 17:49:48 INFO - 'SHLVL': '1', 17:49:48 INFO - 'TERM': 'linux', 17:49:48 INFO - 'TMOUT': '86400', 17:49:48 INFO - 'USER': 'cltbld', 17:49:48 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1458866960.888627-767165492', 17:49:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:48 INFO - '_': '/tools/buildbot/bin/python'} 17:49:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:49:48 INFO - Running setup.py (path:/tmp/pip-B9nmcX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:49:48 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)) 17:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:49:48 INFO - Running setup.py (path:/tmp/pip-p98Enz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:49:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 17:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:49:48 INFO - Running setup.py (path:/tmp/pip-twKJPC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:49:48 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)) 17:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:49:48 INFO - Running setup.py (path:/tmp/pip-MNoEWW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:49:48 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)) 17:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:49:48 INFO - Running setup.py (path:/tmp/pip-uqYGOw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:49:48 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)) 17:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:49:48 INFO - Running setup.py (path:/tmp/pip-08cIs1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:49:48 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)) 17:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:49:48 INFO - Running setup.py (path:/tmp/pip-SjbqA2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:49:48 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)) 17:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:49:48 INFO - Running setup.py (path:/tmp/pip-dxuFfn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:49:48 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)) 17:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:49:48 INFO - Running setup.py (path:/tmp/pip-kLQp8f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:49:48 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)) 17:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:49:48 INFO - Running setup.py (path:/tmp/pip-Zjp_2A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:49:49 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)) 17:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:49:49 INFO - Running setup.py (path:/tmp/pip-PvJClX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:49:49 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)) 17:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:49:49 INFO - Running setup.py (path:/tmp/pip-zWMC6S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:49:49 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)) 17:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:49:49 INFO - Running setup.py (path:/tmp/pip-VEneXw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:49:49 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)) 17:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:49:49 INFO - Running setup.py (path:/tmp/pip-vWuvWB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:49:49 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)) 17:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:49:49 INFO - Running setup.py (path:/tmp/pip-nJ7ktz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:49:49 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)) 17:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:49:49 INFO - Running setup.py (path:/tmp/pip-XgFXVd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:49:49 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)) 17:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:49:49 INFO - Running setup.py (path:/tmp/pip-i48OTu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:49:49 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)) 17:49:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 17:49:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 17:49:49 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)) 17:49:49 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)) 17:49:49 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)) 17:49:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:51 INFO - Downloading blessings-1.6.tar.gz 17:49:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 17:49:51 INFO - Installing collected packages: blessings 17:49:51 INFO - Running setup.py install for blessings 17:49:51 INFO - Successfully installed blessings 17:49:51 INFO - Cleaning up... 17:49:51 INFO - Return code: 0 17:49:51 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 17:49:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:49:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:49:51 INFO - Reading from file tmpfile_stdout 17:49:51 INFO - Current package versions: 17:49:51 INFO - argparse == 1.2.1 17:49:51 INFO - blessings == 1.6 17:49:51 INFO - blobuploader == 1.2.4 17:49:51 INFO - docopt == 0.6.1 17:49:51 INFO - manifestparser == 1.1 17:49:51 INFO - mozInstall == 1.12 17:49:51 INFO - mozcrash == 0.17 17:49:51 INFO - mozdebug == 0.1 17:49:51 INFO - mozdevice == 0.48 17:49:51 INFO - mozfile == 1.2 17:49:51 INFO - mozhttpd == 0.7 17:49:51 INFO - mozinfo == 0.9 17:49:51 INFO - mozleak == 0.1 17:49:51 INFO - mozlog == 3.1 17:49:51 INFO - moznetwork == 0.27 17:49:51 INFO - mozprocess == 0.22 17:49:51 INFO - mozprofile == 0.28 17:49:51 INFO - mozrunner == 6.11 17:49:51 INFO - mozscreenshot == 0.1 17:49:51 INFO - mozsystemmonitor == 0.0 17:49:51 INFO - moztest == 0.7 17:49:51 INFO - mozversion == 1.4 17:49:51 INFO - psutil == 3.1.1 17:49:51 INFO - requests == 1.2.3 17:49:51 INFO - wsgiref == 0.1.2 17:49:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:49: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')]} 17:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49: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')]} 17:49:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:51 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 0x7feacff8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16586b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16531d0>, '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 0x1656750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1656be0>, '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-1458866960.888627-767165492', '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 17:49:51 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 17:49:51 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 17:49:51 INFO - Using env: {'DISPLAY': ':0', 17:49:51 INFO - 'HOME': '/home/cltbld', 17:49:51 INFO - 'LANG': 'en_US.UTF-8', 17:49:51 INFO - 'LANGUAGE': 'en_US:en', 17:49:51 INFO - 'LOGNAME': 'cltbld', 17:49:51 INFO - 'MAIL': '/var/mail/cltbld', 17:49:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:51 INFO - 'MOZ_NO_REMOTE': '1', 17:49:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:51 INFO - 'NO_EM_RESTART': '1', 17:49:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:49:51 INFO - 'PWD': '/builds/slave/test-pgo', 17:49:51 INFO - 'SHELL': '/bin/bash', 17:49:51 INFO - 'SHLVL': '1', 17:49:51 INFO - 'TERM': 'linux', 17:49:51 INFO - 'TMOUT': '86400', 17:49:51 INFO - 'USER': 'cltbld', 17:49:51 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1458866960.888627-767165492', 17:49:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:51 INFO - '_': '/tools/buildbot/bin/python'} 17:49:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:52 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)) 17:49:52 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)) 17:49:52 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)) 17:49:52 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)) 17:49:52 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)) 17:49:52 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)) 17:49:52 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)) 17:49:52 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)) 17:49:52 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)) 17:49:52 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)) 17:49:52 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)) 17:49:52 INFO - Cleaning up... 17:49:52 INFO - Return code: 0 17:49:52 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 17:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:49:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:52 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 0x7feacff8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16586b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16531d0>, '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 0x1656750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1656be0>, '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-1458866960.888627-767165492', '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 17:49:52 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 17:49:52 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 17:49:52 INFO - Using env: {'DISPLAY': ':0', 17:49:52 INFO - 'HOME': '/home/cltbld', 17:49:52 INFO - 'LANG': 'en_US.UTF-8', 17:49:52 INFO - 'LANGUAGE': 'en_US:en', 17:49:52 INFO - 'LOGNAME': 'cltbld', 17:49:52 INFO - 'MAIL': '/var/mail/cltbld', 17:49:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:52 INFO - 'MOZ_NO_REMOTE': '1', 17:49:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:52 INFO - 'NO_EM_RESTART': '1', 17:49:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:49:52 INFO - 'PWD': '/builds/slave/test-pgo', 17:49:52 INFO - 'SHELL': '/bin/bash', 17:49:52 INFO - 'SHLVL': '1', 17:49:52 INFO - 'TERM': 'linux', 17:49:52 INFO - 'TMOUT': '86400', 17:49:52 INFO - 'USER': 'cltbld', 17:49:52 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1458866960.888627-767165492', 17:49:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:52 INFO - '_': '/tools/buildbot/bin/python'} 17:49:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:52 INFO - Downloading/unpacking jsonschema 17:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:49:54 INFO - Downloading/unpacking functools32 (from jsonschema) 17:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:54 INFO - Downloading functools32-3.2.3-2.tar.gz 17:49:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 17:49:54 INFO - warning: no files found matching '*.txt' 17:49:54 INFO - no previously-included directories found matching 'build' 17:49:54 INFO - no previously-included directories found matching 'dist' 17:49:54 INFO - no previously-included directories found matching '.git*' 17:49:54 INFO - Installing collected packages: jsonschema, functools32 17:49:54 INFO - Running setup.py install for functools32 17:49:54 INFO - warning: no files found matching '*.txt' 17:49:54 INFO - no previously-included directories found matching 'build' 17:49:54 INFO - no previously-included directories found matching 'dist' 17:49:54 INFO - no previously-included directories found matching '.git*' 17:49:54 INFO - Successfully installed jsonschema functools32 17:49:54 INFO - Cleaning up... 17:49:54 INFO - Return code: 0 17:49:54 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 17:49:54 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')]} 17:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:54 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')]} 17:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:49:54 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 0x7feacff8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16586b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16531d0>, '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 0x1656750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1656be0>, '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-1458866960.888627-767165492', '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 17:49:54 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 17:49:54 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 17:49:54 INFO - Using env: {'DISPLAY': ':0', 17:49:54 INFO - 'HOME': '/home/cltbld', 17:49:54 INFO - 'LANG': 'en_US.UTF-8', 17:49:54 INFO - 'LANGUAGE': 'en_US:en', 17:49:54 INFO - 'LOGNAME': 'cltbld', 17:49:54 INFO - 'MAIL': '/var/mail/cltbld', 17:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:54 INFO - 'MOZ_NO_REMOTE': '1', 17:49:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:54 INFO - 'NO_EM_RESTART': '1', 17:49:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:49:54 INFO - 'PWD': '/builds/slave/test-pgo', 17:49:54 INFO - 'SHELL': '/bin/bash', 17:49:54 INFO - 'SHLVL': '1', 17:49:54 INFO - 'TERM': 'linux', 17:49:54 INFO - 'TMOUT': '86400', 17:49:54 INFO - 'USER': 'cltbld', 17:49:54 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1458866960.888627-767165492', 17:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:54 INFO - '_': '/tools/buildbot/bin/python'} 17:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:54 INFO - Downloading/unpacking flake8 17:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:49:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:49:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 17:49:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:49:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:49:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:49:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:49:57 INFO - no previously-included directories found matching 'docs/_build' 17:49:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:49:57 INFO - Running setup.py install for pep8 17:49:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:49:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:49:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:49:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:49:57 INFO - no previously-included directories found matching 'docs/_build' 17:49:57 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 17:49:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:49:57 INFO - Cleaning up... 17:49:57 INFO - Return code: 0 17:49:57 INFO - Running post-action listener: _resource_record_post_action 17:49:57 INFO - Running post-action listener: _start_resource_monitoring 17:49:57 INFO - Starting resource monitoring. 17:49:57 INFO - ##### 17:49:57 INFO - ##### Running install step. 17:49:57 INFO - ##### 17:49:57 INFO - Running pre-action listener: _resource_record_pre_action 17:49:57 INFO - Running main action method: install 17:49:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:49:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:49:57 INFO - Reading from file tmpfile_stdout 17:49:57 INFO - Detecting whether we're running mozinstall >=1.0... 17:49:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 17:49:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 17:49:57 INFO - Reading from file tmpfile_stdout 17:49:57 INFO - Output received: 17:49:57 INFO - Usage: mozinstall [options] installer 17:49:57 INFO - Options: 17:49:57 INFO - -h, --help show this help message and exit 17:49:57 INFO - -d DEST, --destination=DEST 17:49:57 INFO - Directory to install application into. [default: 17:49:57 INFO - "/builds/slave/test-pgo"] 17:49:57 INFO - --app=APP Application being installed. [default: firefox] 17:49:57 INFO - mkdir: /builds/slave/test-pgo/build/application 17:49:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 17:49:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 17:50:14 INFO - Reading from file tmpfile_stdout 17:50:14 INFO - Output received: 17:50:14 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 17:50:14 INFO - Running post-action listener: _resource_record_post_action 17:50:14 INFO - ##### 17:50:14 INFO - ##### Running run-tests step. 17:50:14 INFO - ##### 17:50:14 INFO - Running pre-action listener: _resource_record_pre_action 17:50:14 INFO - Running main action method: run_tests 17:50:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 17:50:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 17:50:14 INFO - Python 2.7.3 17:50:14 INFO - Return code: 0 17:50:14 INFO - grabbing minidump binary from tooltool 17:50:14 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')]} 17:50:14 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 0x16531d0>, '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 0x1656750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1656be0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 17:50:14 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 17:50:14 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 17:50:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:50:14 INFO - Return code: 0 17:50:14 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 17:50:14 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 17:50:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 17:50:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 17:50:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 17:50:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 17:50:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 17:50:15 INFO - Return code: 0 17:50:15 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/dc8QqAQzSFOhg69W2mlQOA/artifacts/public/build/firefox-48.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 17:50:15 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/dc8QqAQzSFOhg69W2mlQOA/artifacts/public/build/firefox-48.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 17:50:15 INFO - Using env: {'DISPLAY': ':0', 17:50:15 INFO - 'HOME': '/home/cltbld', 17:50:15 INFO - 'LANG': 'en_US.UTF-8', 17:50:15 INFO - 'LANGUAGE': 'en_US:en', 17:50:15 INFO - 'LOGNAME': 'cltbld', 17:50:15 INFO - 'MAIL': '/var/mail/cltbld', 17:50:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:50:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 17:50:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:15 INFO - 'MOZ_NO_REMOTE': '1', 17:50:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:50:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:15 INFO - 'NO_EM_RESTART': '1', 17:50:15 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:50:15 INFO - 'PWD': '/builds/slave/test-pgo', 17:50:15 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 17:50:15 INFO - 'SHELL': '/bin/bash', 17:50:15 INFO - 'SHLVL': '1', 17:50:15 INFO - 'TERM': 'linux', 17:50:15 INFO - 'TMOUT': '86400', 17:50:15 INFO - 'USER': 'cltbld', 17:50:15 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1458866960.888627-767165492', 17:50:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:15 INFO - '_': '/tools/buildbot/bin/python'} 17:50:15 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/dc8QqAQzSFOhg69W2mlQOA/artifacts/public/build/firefox-48.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 17:50:15 INFO - mozversion application_buildid: 20160324143036 17:50:15 INFO - mozversion application_changeset: 5e287404e4f8fd81330cd704e42fba5e3baa5f49 17:50:15 INFO - mozversion application_display_name: Nightly 17:50:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:50:15 INFO - mozversion application_name: Firefox 17:50:15 INFO - mozversion application_remotingname: firefox 17:50:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:50:15 INFO - mozversion application_vendor: Mozilla 17:50:15 INFO - mozversion application_version: 48.0a1 17:50:15 INFO - mozversion platform_buildid: 20160324143036 17:50:15 INFO - mozversion platform_changeset: 5e287404e4f8fd81330cd704e42fba5e3baa5f49 17:50:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:50:15 INFO - mozversion platform_version: 48.0a1 17:50:15 INFO - using testdate: 1458867015 17:50:15 INFO - actual date: 1458867015 17:50:15 INFO - starting webserver on 'localhost:34920' 17:50:15 INFO - SUITE-START | Running 2 tests 17:50:15 INFO - TEST-START | dromaeo_css 17:50:15 INFO - operating with platform_type : linux_ 17:50:15 INFO - Initialising browser for dromaeo_css test... 17:50:15 INFO - TEST-INFO | started process 12789 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGUpac1/profile http://localhost:34920/getInfo.html) 17:50:19 INFO - PROCESS | 12789 | __metrics Screen width/height:1600/1200 17:50:19 INFO - PROCESS | 12789 | colorDepth:24 17:50:19 INFO - PROCESS | 12789 | Browser inner width/height: 1024/697 17:50:19 INFO - PROCESS | 12789 | __metrics 17:50:20 ERROR - PROCESS | 12789 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:50:20 INFO - PROCESS | 12789 | 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. 17:50:21 INFO - TEST-INFO | 12789: exit 0 17:50:21 INFO - Browser initialized. 17:50:21 INFO - Running cycle 1/1 for dromaeo_css test... 17:50:21 INFO - TEST-INFO | started process 12883 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGUpac1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:50:33 INFO - PROCESS | 12883 | RSS: Main: 152870912 17:50:33 INFO - PROCESS | 12883 | 17:51:24 INFO - PROCESS | 12883 | 1458867084739 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] 17:53:31 INFO - PROCESS | 12883 | Cycle 1(1): loaded http://localhost:34920/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34920/tests/dromaeo/cssquery-ext.html) 17:53:32 INFO - PROCESS | 12883 | RSS: Main: 250785792 17:53:32 INFO - PROCESS | 12883 | 17:56:34 INFO - PROCESS | 12883 | Cycle 1(1): loaded http://localhost:34920/tests/dromaeo/cssquery-ext.html (next: http://localhost:34920/tests/dromaeo/cssquery-jquery.html) 17:56:34 INFO - PROCESS | 12883 | RSS: Main: 240041984 17:56:34 INFO - PROCESS | 12883 | 17:59:36 INFO - PROCESS | 12883 | Cycle 1(1): loaded http://localhost:34920/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34920/tests/dromaeo/cssquery-mootools.html) 17:59:37 INFO - PROCESS | 12883 | RSS: Main: 239624192 17:59:37 INFO - PROCESS | 12883 | 18:02:39 INFO - PROCESS | 12883 | Cycle 1(1): loaded http://localhost:34920/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34920/tests/dromaeo/cssquery-prototype.html) 18:02:39 INFO - PROCESS | 12883 | RSS: Main: 219439104 18:02:39 INFO - PROCESS | 12883 | 18:05:42 INFO - PROCESS | 12883 | Cycle 1(1): loaded http://localhost:34920/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34920/tests/dromaeo/cssquery-yui.html) 18:05:42 INFO - PROCESS | 12883 | RSS: Main: 220090368 18:05:42 INFO - PROCESS | 12883 | 18:08:45 INFO - PROCESS | 12883 | Cycle 1(1): loaded http://localhost:34920/tests/dromaeo/cssquery-yui.html (next: http://localhost:34920/tests/dromaeo/cssquery-dojo.html) 18:08:45 INFO - PROCESS | 12883 | RSS: Main: 269279232 18:08:45 INFO - PROCESS | 12883 | 18:08:45 INFO - PROCESS | 12883 | __start_tp_report 18:08:45 INFO - PROCESS | 12883 | _x_x_mozilla_page_load 18:08:45 INFO - PROCESS | 12883 | _x_x_mozilla_page_load_details 18:08:45 INFO - PROCESS | 12883 | |i|pagename|runs| 18:08:45 INFO - PROCESS | 12883 | |0;dojo.html;2936.897208597699;3033.2568520712402;3065.5861458703084;3067.9233019174517;3095.767817413693;5047.293378926953;5054.317667114948;5161.245385526226;5204.531592156705;5238.135707608245;5042.949570504294;5091.567216786569;5105.897882042357;5226.55574276187;5231.686098834072;4678.97660511697;4711.670183087185;4819.397575303087;4828.324034635154;4877.5366340197625;4640.883977900563;4785.569298763111;4821.927671084936;4839.177339852216;4855.32025516428;4697.013627138305;4722.787474563653;4726.196546587088;4733.0533893221145;4761.500042495522;4730.62155027597;4734;4735.57379835813;4744.122337367598;4770.427548694144;4600.5629465200755;4697.295405689139;4705.529447055302;4712;4790.712557246577;5113.105206588869;5134.8202812901745;5139.17773156297;5139.280500729901;5149.356330458692;5478;5491.313585801775;5500.28496295479;5548.611597188198;5549.334079910396;5384.1923711443205;5419.187121931703;5524.972375138139;5586.581006424534;5614.494695477427;5137.948620513822;5176.663516871391;5178.119719647707;5179.974100129513;5182.093133701587;5657.745401456944;5661.830145095653;5664.26364572603;5664.405237450009;5708.20085188074;5263.657862239019;5323.547498462674;5413.377461591888;5461.699606521679;5480.123180291134;5467.890642187213;5507.394186639466;5508.55931525477;5511.145772405283;5512.0905050667;5234.555062819627;5454.263674403984;5488.890222195613;5491.478309560585;5542.473465020817;5391.32608423947;5422.0511410503;5431.402545719968;5441.102218133963;5470.343558772973;4216.620504154641;4227;4229.048464095554;4234.026173980002;4275.5296917339065;3693.649103335179;3760.7179461540495;3779.527559055118;3807;3835.4055121456217;5167.689938603696;5174.715390653475;5188.740562971836;5216.66091704038;5233.895322093536;5477.370102438271;5493.09363954943;5495.313085864267;5497.560195184456;5503.9174412383845;5107.106256405114;5187.974060129751;5192.143296356059;5196.45437229093;5202.583793296527;4761.309610106515;4773.952260477351;4786.473487916326;4806.8077276909235;4836.951630483721;5620.353659329229;5625.099984002622;5630.97184514083;5634.774609015593;5669.829905102853;5300.681959082467;5483.862903427446;5501.4223506532835;5502.367227768857;5515.145152501369;5639.520640745583;5656.1233008882045;5669.829905102853;5689.146628005832;5707.058335374617;5413.810516631899;5429.864253393696;5436.728163591725;5438.293021907127;5447.509724124848;5382;5507.146392309199;5510.228568000563;5529.889402212014;5582.7766889323975;5473.28847249855;5475.698836564027;5476.04169270384;5480;5525.336959564878;5411.945880541301;5412.864678383072;5434.809781657623;5435.701036443033;5490.203920431435;5220.3735551734035;5299.205119231991;5302.946970530245;5366.114591092426;5369.97315013438;5418.972905135449;5425.755840987086;5427.810026649048;5434.972825135849;5483.040467918178;5321.36143662763;5328.600354973315;5330.573554115584;5335.813246536352;5378.489043540857 18:08:45 INFO - PROCESS | 12883 | |1;ext.html;522.2636083122798;561.859535116221;569.237222122356;582.4350380131272;593.4510577715612;30038.249043773918;38036.23927521452;38127.23745525095;38263.808680956594;38300;40464.595354046454;40714.52140264569;40897;40932.18135637286;41034.17931641373;7794.220577942188;8463.153684631534;8643.913560864405;8655;10000.849987250198;10054.145397641209;10215.080642742189;10215.693529194135;10224;10229.897701023006;10162;10277.229207809407;10282.485875706223;10285.434301113435;10294.485275736184;10061.647842325483;10194.745131371737;10199.4390308533;10217.080462758313;10241.77098748155;10041.698749037541;10079.496025198783;10209.744756381077;10217.744556386075;10519.421431821247;41268.79365603153;41576.1684766306;41582;41668.791656041525;41730;3429.6227414984583;3508.4912687660403;3539.5752509698746;3563.679268865789;3909.902252443683;30907.497363221628;31263.531047034314;31291.578132136565;31332;31957.360852783047;4163.625273725379;4199.097194103252;4230.280852255124;4242.787860606957;4274.700770946035;322498;322617;323525;324736;326037;57365.42634573601;57430.138547921815;57867.42132578704;57934;57996.42003579994;64840.378990524674;65127;66467.66766166234;66893.66553167203;66998.33001670019;16312.75530867038;16401.83598164027;16455.506334809976;16470.83529164693;16484.175791210393;12575;12575.308358040213;12617.810732839014;12622.242665439919;12623;20496.897515512625;20548.38354849357;20677.689834652192;20723.792762072488;20778.272760453612;7392.519486233377;7473.439492038119;7502.62486875654;7732.806679833049;7780.215167671841;896.3680605173337;979.9608015679436;986.0386123529645;1045.5242864496636;1048.2662136504478;28960.855195724307;29483.557746633818;29613;29751;30157.547636785464;1081.561967403203;1115.5649296774266;1124.3085502416118;1130.2596799096605;1146.3523109443138;15213.391464341525;15528.922355388377;15874;17286;17600.735988960176;471934;477741;478089;479421;482998;58177.70911145502;58705;58710.70644646835;58735.70632146898;58738.41261587329;1191.6544202181271;1392.526540976073;1396.3925692323871;1398.7342404943029;1423.9359228834935;27810.582841256994;30484.7806087754;30535;30993.69006309908;31335;44471.33293000543;44825.327620085074;45246.54753452555;45297.54702453065;45326;272717;274796;275872;276161;276670;29697.257568560093;34780.13049673779;34876;34973;35089.64910350864;40071.599284006785;40144;40316.1936761269;41070;41391.37912931248;36525;37869.24261514809;37889.2422151561;38113.2377352457;38113.42829857499;35702.05351213925;37076.81461592675;37353.81323093367;37564.55830371017;37970.62029379671;36253.818730906176;36822.8158859204;37096.814515927246;37135.44296835604;37602.81198594099;31737.36525269528;33099.83450082734;33330.83334583312;33426.49860252049;33591.144752696295;25315;25431.745682542936;25451;25611.231663050137;26116.34709132211 18:08:45 INFO - PROCESS | 12883 | |2;jquery.html;355.34261616010383;362.60476081071624;371.272999816349;372.5175897213108;373.20507319409654;17530.29878804848;18138.183781729822;19104.713429298572;19564.608707825835;19585.608287834235;17539.38612148575;17750.911245443756;18579.907100464512;18598.34905778298;18600.906995465037;5576.442355764421;5749.683767392792;5784.768609255625;5788.652680839163;5792.333881603607;4151.294279972412;5712.771489140429;6037.094435834616;6307.968460157693;6317.557770956035;6230.408111229426;6252.2809876864285;6257.968710156466;6268;6273.12176295319;6043.697815109249;6365.554411191219;6371.39471750183;6382.266039405481;6384.744610215585;3737.7570457920147;5337.946620533823;5530.142827861688;5535.03136951032;5614.747336369873;20424.489387765425;20497.4875628109;20567.691484627743;22066.4483387915;22080.44798880041;2237.6196046672103;2311.352821210047;2354.6232602783643;2391.5814732421754;2776.912772909035;13596.456141754417;13624.591262262147;13659.112157709716;14082.647933801634;14165.362558684885;1795.5152108930515;1859.758231429919;1881.3227238194238;1889.6787546117193;1922.7788804287545;68988.31011689869;71481;71596.64201679011;71826.281737183;72304.6384768078;10578.894211057945;10609.522571484302;10738.731531711614;10750;10757.569697212024;14535.345909433889;14623.04950178235;14632.561023169323;14652.706945861022;14670.266486675624;8067.677292908335;8105.148959359182;8111.634976426075;8126.593670316461;8281.171882811792;7772.922270777333;7893;7907.683692652345;7933.841323173504;8169.63236654352;4484.977575112169;4591;4591.540845915449;4604.608608268268;4618.838340658061;1731.9348600610533;1795.6828254984998;1816.7547381103645;1840.190316260841;1894.2801735340759;864.8140649760331;984.1929617713406;1002.1882275356984;1017.4861694844204;1082.5994382078525;16784.916075419544;16920.407785727686;17148.657026859393;17356.566085847702;17558.29766809313;913.977150571241;921.9677311294073;981.7594689301167;993.2649839119144;1005.703317521333;10132.696019119438;10228.795424091477;10251;10289.845652315222;10350.741231469123;449941;453931;458307;459448;460042;75627.62186189034;76131;77607;78204;78439;1042.9374237545924;1046.3930920066343;1095.1129585036147;1113.6993011886746;1121.6018313498753;16079.67840643204;16098.11460369644;16139.354425823305;16199.838001619833;16287.267072981507;35676.82161589176;36053.27893442064;36707.81646091752;37439.62560374361;37758;47756.28365574589;49918.25122623091;49953;50161.74919125381;50463.74768126136;7965.402594805297;7980.960095199487;7996.880046799186;8004.319632831041;8073.39449541275;12234.938825305817;12567.87432125667;12757.936210318889;13165.53920612774;13253;10600.46997650099;10650.8402373966;10761.46192690378;11173.608923687632;11209.327440353605;10879.78240435171;10928.235023548275;11268.154888383568;11288.209825312479;11541.134414918746;10649.787004260026;10705.9464702676;10862.837057444303;11050.668479945614;11125.221234513507;8590.441621294596;11220.607278745205;11253.381064041556;11299.887001130212;11554.133439991867;10838.187135964992;11134;11139.443027848412;11171.106311494897;11348.375839328586 18:08:45 INFO - PROCESS | 12883 | |3;mootools.html;1342.5301144599398;1477.8743806776424;1478.0466599043616;1628.7312593422087;1808.8824226425281;7511.62441877906;7698.4611077224545;7718.6912523498995;7725;7727.72952946647;7632.122305934819;7793.025871766029;7794.727184548542;7800.921990780091;7814.882776758353;1903.0674969265099;1949.5905859769466;2228.821694264463;2238.3620668109593;2262.592733308004;2316.918907838226;2318.7797159269844;2322.605157123293;2325.9534809303805;2328.685627440291;2145.0776166248506;2197.04428573571;2211.6793065005563;2216.9556608867815;2217.966730499044;2217.1131547381015;2222.5777102350585;2225.5326381459913;2225.8441909066373;2227.509947811479;2251.4934139818574;2258.153192552793;2262.3665373695226;2262.5474905019064;2270.3983444387086;7804.648790804427;7853.96073019637;7891.644875980594;7891.644875980594;7895.249951254622;4793.688410253322;4919.237518184687;4931.408231012301;4944.777485013183;4946.233333833262;3128.311771410286;3153.8423078845967;3257.9348413031844;3276.410246155691;3289.8848540301215;971.2375785008734;979.1090108001684;1008.5159123620704;1040.095117247999;1057.8730552333768;10786.46067696612;10795.892041079645;10830.78338433227;10864.402457864815;10877.619283325124;4203.07532342884;4239.957600423956;4285.400043993844;4302.139572085595;4364.432623758955;9442.527873606292;9451.102145296185;9474.289428292906;9474.763130921645;9477.147056764925;4966.776495057731;4981.850544483671;4983.127952608279;4984.825531106394;4992.625553083533;3880.728349015542;3991.840326386912;4417.757023363682;4493.393391892053;4577.198990176706;3743.0455233915723;3751.174741556853;3814.6566808987322;3843.557990831034;3848.191879705237;1255.2782150263636;1256.7549327880974;1259.118616968126;1279;1280.2766436963086;1338.1101567457727;1342.8858547023417;1344.1263178933575;1353.282760137109;1356.2811709793825;7205.279472052857;7338.339549440576;7350.52221605594;7353;7582.886256706154;1107.8781334053247;1116.625930313338;1140.8288756686397;1150.896419322265;1154.2958795134962;5929.37741537141;5954.136650185699;6011.819645410645;6012.579119461683;6019.187409699634;8948.597313120925;9507.904920950841;9511.66709165176;9513.143817056498;9638;9596.95201523988;9665.516724163763;9713.854292185622;9721.076497732704;9739;7351.705931762776;7589.696412143563;7606.3914886808925;7639.770806875803;7671.2712292332135;6974.128233970754;7004.4046256068805;7007.229204787572;7026.789196324118;7029.226785053538;8562.657493700432;8644.56777161152;8664.35017373687;8726.912730872864;8787;8781.604827782638;8844.425112367675;8845.336599754915;9045.547722613712;9081.500517471603;6000.849978750566;6554.573952693059;6696.229933557508;6899;7006.579605223703;7519.323260906544;7564.583947882919;7579.924200757921;7599.506032107895;7641.044869391326;6805.523613347018;6964.233934267328;6976.093107895941;7013.754518591825;7077.964610176916;6853;6888.517803753689;6944.375006249462;6988.8951665724035;6991;7031.367176954099;7100.538464999759;7110.57336559808;7215.567065976058;7234.927650723425;6509.73961041572;6539.542232043902;6573.605583664996;6582.275949645439;6584.407403333723;6392.169018027626;6521.478281737544;6578.5395022347975;6579.17760279965;6583.901241481286 18:08:45 INFO - PROCESS | 12883 | |4;prototype.html;323.1001660375854;325.1400046876013;327.2163169209742;330.4448526475522;332.0420586607639;6085.391460853913;6142.109394137853;6157.107219453176;6167.167432396625;6180.1656776335185;6062.060380640996;6063.181470501481;6063.211782468284;6075.33171351151;6076.179715738374;4364.127174565084;4539;4565.863024109282;4601.769911504428;4616.192166370888;4561.247394179956;4596.402467679197;4611.054733779584;4612.561806628365;4613.492515823256;4391.780410979454;4565.748883811406;4582.587567118959;4582.7250364978045;4583.289590113538;4478.373027776114;4571.131485017836;4575.702579332333;4589.403377560929;4591.977040114794;3989.780562069085;3994;3994.981279773668;3999.7200195986293;4003.799810009488;5773.134029895507;5778.104393818923;5782.537397008229;5791.65250084992;5866.032104702719;5345.118055520835;5349.251104845324;5350.571954243651;5357.5446087082255;5359.356877174764;6371.490280777527;6378.234611846562;6382.648954307511;6387.489000879918;6390.297067322591;4359.716618419824;4444.466664000341;4448.799804008828;4456.086502267028;4458.754768487732;6662.200535935719;6672.232693240291;6673.399394054559;6679.398854103106;6684.2647308795995;4541.75020373876;4548.931766023512;4553.681242313072;4555.430571178603;4556.88607784808;4609.792559334838;4610.239310513794;4614.838480653161;4617.561331673485;4619.353290539327;5325.733713314319;5327.067763141435;5327.227552004938;5336.252924590561;5346.091164502044;6279.780207692709;6441.64570948593;6445.258795238514;6446.290908000116;6459.160309159779;1600.9839901601067;1609.5090997245952;1619.327978888748;1620.7082725109358;1621.659451515195;966.3284017607696;970.9805803883883;971.048372594861;971.931964762474;1057.4289883462843;6117;6210.596311239755;6211.440970312694;6228.314885362606;6313.210848643919;6694.09629699994;6703.095082163943;6703.463722902254;6706;6710.127683401127;6279.874402511924;6300.653464059429;6304.085907543472;6308.495320374359;6312.810615681537;3553.591336996227;3587.677109060197;3597.3165098631175;3599.298136863339;3604.351216780952;6660.733570657119;6880.415164711056;6881.13985751781;6885.036094946711;6889.758858439931;6772.627505487246;6783.728650854009;6786.219584747817;6793.762218322335;6804.897926531106;6864.656767161622;6873.759418420432;6922.480813938874;6964.373206411447;6970.930290697028;6623.933760662524;6655.2346480153465;6658.500612453989;6659.733610655713;6668.799936001928;6312.715927783169;6596.109525214227;6616.569922954993;6635.336466353326;6636.2700102987665;6834.316568343126;6859.245482996766;6864.862702745817;6885.794985877552;6897.41371983387;4258.127083947845;4258.254805408979;4260.126674031878;4263.424437700871;4264.6375058119165;6671.432928201158;6684.298148694317;6706.094677218513;6713.093732346071;6769.593824370553;6279.932411489966;6504.869902602016;6527.2167339919515;6529.151210342625;6544.6727663617585;6473.805785826433;6479.676016199265;6514.088027676224;6533.934660653333;6549.24683661366;6336.081268216175;6346.048092786119;6353.428191462605;6355.459785918064;6357.809265722036;6520.739170433129;6522;6527.836804079936;6538.738450462119;6543.509236807164;6080.787172448943;6167.290761562298;6260;6265.530085243716;6369.7452101915405 18:08:45 INFO - PROCESS | 12883 | |5;yui.html;670.249320760748;763.3206446262825;777.9377649788021;794.614611913222;798.6925033861963;14487.927560362197;14614.780778288334;14634.926825365872;14640.707185856303;14654.120752754816;13239.669008274797;13647.727045459085;13824.101433406822;13945.163290202596;14004.64988375291;807.5719868469721;813.5606772342928;817.7546735979182;818.615250832111;821.0885916632562;678.0338018323894;813.8535063688533;836.3977935886152;838.9790255243606;843.5065486690294;859.3297228162044;866.3156106675718;866.4584634603373;868.0581568997645;868.2533021601417;701.0150738212768;863.2360361080489;864.062492195965;864.394923553512;864.4251572704144;623.8627501949563;626.0452809465602;626.4455956478504;627.5199472403615;627.6641996531879;14389.13665180082;14434;14448.855511444961;14535.563933082025;14542.054766440147;13387.397567109503;13935.372908219155;14000.929995349958;14010.929945350208;14073.929630351886;11110.44447777616;11242.718932026683;11490.42547872603;11521.135914806424;11964.042876569854;3776.2825063237897;3800.6959443244473;3837.6737977271964;3918.608139186087;3941.4481972523868;52993.470065299625;53033;53102.20346694841;53483.19775203375;53670;10208.132308753691;10626;10705.464726763787;10910.618128365628;10963.61627343055;18911.716324255147;18952.62094758097;19117.713234301496;19143.138558764887;19193.90403047976;8115.75652730419;8116.066652334939;8128.227818357246;8180.222878826502;8310.958445207856;4602.976985115053;4650.4186976627925;4701;4781.426228852491;4813.3983252093485;3286.3263031078573;3298.241404476984;3310.4372256715933;3311.519829624691;3315.635280119185;589.1633879890566;600.5435868739789;608.3855306140741;610.4597431273266;619.1146660275759;702.6943279673359;711.7437722419925;717.8636059148745;725.3399406540128;733.8202140475618;8362.12197719243;8778.429402088845;9350.625974961062;9381.62473501066;9496;700.3346820520526;702.2135208566439;713.7216485570632;718.6981467783544;742.3022358982647;4368.521996641155;4382;4385.846495372647;4425.668074894395;4456.64346852251;59524.40475595189;60751;61389.69305153535;61969.69015154895;62017.68991155015;53886.7305663477;54733.72633136809;55158.44841551533;55729.44270557324;56214.43785562174;49940.500594994315;50593;50964.74517627388;51373;51665;8367.246947774729;8370.539620320696;8548.957255213683;8635.395522313378;9285.72142835716;35900.64099358973;36206.27587448289;36965.26069478649;37651;38491.80754096324;44586.55413445954;45167.77416112898;45674;47400.28899566578;47571.28643070426;11521.942390287995;11683.649490515298;11697.883021169679;11721.88278117242;12149;12836.935815321238;13202.141860779018;13227.867721322664;13568;13833.515826946008;11857.347845868215;11863.940680296544;11937.16439849237;11965;12285.877141228473;12562.120651554304;12609;12727.681807954876;13060.151090179108;13095;11992.700182495508;12103.394830258276;12111.091668124749;12266.938665306616;12660.11379203447;9477.431354118775;9520.285978551497;9794.21646268311;9877.012298770353;10021.448820314952;10424.791504170025;10588.682339529518;10714.464276786286;10730.839037414602;10747.140228781522 18:08:45 INFO - PROCESS | 12883 | __end_tp_report 18:08:45 INFO - PROCESS | 12883 | __start_cc_report 18:08:45 INFO - PROCESS | 12883 | _x_x_mozilla_cycle_collect,780 18:08:45 INFO - PROCESS | 12883 | __end_cc_report 18:08:45 INFO - PROCESS | 12883 | __startTimestamp1458868125618__endTimestamp 18:08:45 INFO - PROCESS | 12883 | 18:08:45 INFO - PROCESS | 12883 | ------- Summary: start ------- 18:08:45 INFO - PROCESS | 12883 | Number of tests: 6 18:08:45 INFO - PROCESS | 12883 | 18:08:45 INFO - PROCESS | 12883 | [#0] dojo.html Cycles:165 Average:5127.69 Median:5323.55 stddev:561.15 (10.5%) stddev-sans-first:535.90 18:08:45 INFO - PROCESS | 12883 | Values: 2936.9 3033.3 3065.6 3067.9 3095.8 5047.3 5054.3 5161.2 5204.5 5238.1 5042.9 5091.6 5105.9 5226.6 5231.7 4679.0 4711.7 4819.4 4828.3 4877.5 4640.9 4785.6 4821.9 4839.2 4855.3 4697.0 4722.8 4726.2 4733.1 4761.5 4730.6 4734.0 4735.6 4744.1 4770.4 4600.6 4697.3 4705.5 4712.0 4790.7 5113.1 5134.8 5139.2 5139.3 5149.4 5478.0 5491.3 5500.3 5548.6 5549.3 5384.2 5419.2 5525.0 5586.6 5614.5 5137.9 5176.7 5178.1 5180.0 5182.1 5657.7 5661.8 5664.3 5664.4 5708.2 5263.7 5323.5 5413.4 5461.7 5480.1 5467.9 5507.4 5508.6 5511.1 5512.1 5234.6 5454.3 5488.9 5491.5 5542.5 5391.3 5422.1 5431.4 5441.1 5470.3 4216.6 4227.0 4229.0 4234.0 4275.5 3693.6 3760.7 3779.5 3807.0 3835.4 5167.7 5174.7 5188.7 5216.7 5233.9 5477.4 5493.1 5495.3 5497.6 5503.9 5107.1 5188.0 5192.1 5196.5 5202.6 4761.3 4774.0 4786.5 4806.8 4837.0 5620.4 5625.1 5631.0 5634.8 5669.8 5300.7 5483.9 5501.4 5502.4 5515.1 5639.5 5656.1 5669.8 5689.1 5707.1 5413.8 5429.9 5436.7 5438.3 5447.5 5382.0 5507.1 5510.2 5529.9 5582.8 5473.3 5475.7 5476.0 5480.0 5525.3 5411.9 5412.9 5434.8 5435.7 5490.2 5220.4 5299.2 5302.9 5366.1 5370.0 5419.0 5425.8 5427.8 5435.0 5483.0 5321.4 5328.6 5330.6 5335.8 5378.5 18:08:45 INFO - PROCESS | 12883 | 18:08:45 INFO - PROCESS | 12883 | [#1] ext.html Cycles:180 Average:52627.02 Median:19104.88 stddev:97537.82 (510.5%) stddev-sans-first:97732.98 18:08:45 INFO - PROCESS | 12883 | Values: 522.3 561.9 569.2 582.4 593.5 30038.2 38036.2 38127.2 38263.8 38300.0 40464.6 40714.5 40897.0 40932.2 41034.2 7794.2 8463.2 8643.9 8655.0 10000.8 10054.1 10215.1 10215.7 10224.0 10229.9 10162.0 10277.2 10282.5 10285.4 10294.5 10061.6 10194.7 10199.4 10217.1 10241.8 10041.7 10079.5 10209.7 10217.7 10519.4 41268.8 41576.2 41582.0 41668.8 41730.0 3429.6 3508.5 3539.6 3563.7 3909.9 30907.5 31263.5 31291.6 31332.0 31957.4 4163.6 4199.1 4230.3 4242.8 4274.7 322498.0 322617.0 323525.0 324736.0 326037.0 57365.4 57430.1 57867.4 57934.0 57996.4 64840.4 65127.0 66467.7 66893.7 66998.3 16312.8 16401.8 16455.5 16470.8 16484.2 12575.0 12575.3 12617.8 12622.2 12623.0 20496.9 20548.4 20677.7 20723.8 20778.3 7392.5 7473.4 7502.6 7732.8 7780.2 896.4 980.0 986.0 1045.5 1048.3 28960.9 29483.6 29613.0 29751.0 30157.5 1081.6 1115.6 1124.3 1130.3 1146.4 15213.4 15528.9 15874.0 17286.0 17600.7 471934.0 477741.0 478089.0 479421.0 482998.0 58177.7 58705.0 58710.7 58735.7 58738.4 1191.7 1392.5 1396.4 1398.7 1423.9 27810.6 30484.8 30535.0 30993.7 31335.0 44471.3 44825.3 45246.5 45297.5 45326.0 272717.0 274796.0 275872.0 276161.0 276670.0 29697.3 34780.1 34876.0 34973.0 35089.6 40071.6 40144.0 40316.2 41070.0 41391.4 36525.0 37869.2 37889.2 38113.2 38113.4 35702.1 37076.8 37353.8 37564.6 37970.6 36253.8 36822.8 37096.8 37135.4 37602.8 31737.4 33099.8 33330.8 33426.5 33591.1 25315.0 25431.7 25451.0 25611.2 26116.3 18:08:45 INFO - PROCESS | 12883 | 18:08:45 INFO - PROCESS | 12883 | [#2] jquery.html Cycles:180 Average:26859.60 Median:21317.07 stddev:74859.02 (351.2%) stddev-sans-first:75042.57 18:08:45 INFO - PROCESS | 12883 | Values: 355.3 362.6 371.3 372.5 373.2 17530.3 18138.2 19104.7 19564.6 19585.6 17539.4 17750.9 18579.9 18598.3 18600.9 5576.4 5749.7 5784.8 5788.7 5792.3 4151.3 5712.8 6037.1 6308.0 6317.6 6230.4 6252.3 6258.0 6268.0 6273.1 6043.7 6365.6 6371.4 6382.3 6384.7 3737.8 5337.9 5530.1 5535.0 5614.7 20424.5 20497.5 20567.7 22066.4 22080.4 2237.6 2311.4 2354.6 2391.6 2776.9 13596.5 13624.6 13659.1 14082.6 14165.4 1795.5 1859.8 1881.3 1889.7 1922.8 68988.3 71481.0 71596.6 71826.3 72304.6 10578.9 10609.5 10738.7 10750.0 10757.6 14535.3 14623.0 14632.6 14652.7 14670.3 8067.7 8105.1 8111.6 8126.6 8281.2 7772.9 7893.0 7907.7 7933.8 8169.6 4485.0 4591.0 4591.5 4604.6 4618.8 1731.9 1795.7 1816.8 1840.2 1894.3 864.8 984.2 1002.2 1017.5 1082.6 16784.9 16920.4 17148.7 17356.6 17558.3 914.0 922.0 981.8 993.3 1005.7 10132.7 10228.8 10251.0 10289.8 10350.7 449941.0 453931.0 458307.0 459448.0 460042.0 75627.6 76131.0 77607.0 78204.0 78439.0 1042.9 1046.4 1095.1 1113.7 1121.6 16079.7 16098.1 16139.4 16199.8 16287.3 35676.8 36053.3 36707.8 37439.6 37758.0 47756.3 49918.3 49953.0 50161.7 50463.7 7965.4 7981.0 7996.9 8004.3 8073.4 12234.9 12567.9 12757.9 13165.5 13253.0 10600.5 10650.8 10761.5 11173.6 11209.3 10879.8 10928.2 11268.2 11288.2 11541.1 10649.8 10705.9 10862.8 11050.7 11125.2 8590.4 11220.6 11253.4 11299.9 11554.1 10838.2 11134.0 11139.4 11171.1 11348.4 18:08:45 INFO - PROCESS | 12883 | 18:08:45 INFO - PROCESS | 12883 | [#3] mootools.html Cycles:180 Average:5540.96 Median:6515.61 stddev:2870.78 (44.1%) stddev-sans-first:2861.49 18:08:45 INFO - PROCESS | 12883 | Values: 1342.5 1477.9 1478.0 1628.7 1808.9 7511.6 7698.5 7718.7 7725.0 7727.7 7632.1 7793.0 7794.7 7800.9 7814.9 1903.1 1949.6 2228.8 2238.4 2262.6 2316.9 2318.8 2322.6 2326.0 2328.7 2145.1 2197.0 2211.7 2217.0 2218.0 2217.1 2222.6 2225.5 2225.8 2227.5 2251.5 2258.2 2262.4 2262.5 2270.4 7804.6 7854.0 7891.6 7891.6 7895.2 4793.7 4919.2 4931.4 4944.8 4946.2 3128.3 3153.8 3257.9 3276.4 3289.9 971.2 979.1 1008.5 1040.1 1057.9 10786.5 10795.9 10830.8 10864.4 10877.6 4203.1 4240.0 4285.4 4302.1 4364.4 9442.5 9451.1 9474.3 9474.8 9477.1 4966.8 4981.9 4983.1 4984.8 4992.6 3880.7 3991.8 4417.8 4493.4 4577.2 3743.0 3751.2 3814.7 3843.6 3848.2 1255.3 1256.8 1259.1 1279.0 1280.3 1338.1 1342.9 1344.1 1353.3 1356.3 7205.3 7338.3 7350.5 7353.0 7582.9 1107.9 1116.6 1140.8 1150.9 1154.3 5929.4 5954.1 6011.8 6012.6 6019.2 8948.6 9507.9 9511.7 9513.1 9638.0 9597.0 9665.5 9713.9 9721.1 9739.0 7351.7 7589.7 7606.4 7639.8 7671.3 6974.1 7004.4 7007.2 7026.8 7029.2 8562.7 8644.6 8664.4 8726.9 8787.0 8781.6 8844.4 8845.3 9045.5 9081.5 6000.8 6554.6 6696.2 6899.0 7006.6 7519.3 7564.6 7579.9 7599.5 7641.0 6805.5 6964.2 6976.1 7013.8 7078.0 6853.0 6888.5 6944.4 6988.9 6991.0 7031.4 7100.5 7110.6 7215.6 7234.9 6509.7 6539.5 6573.6 6582.3 6584.4 6392.2 6521.5 6578.5 6579.2 6583.9 18:08:45 INFO - PROCESS | 12883 | 18:08:45 INFO - PROCESS | 12883 | [#4] prototype.html Cycles:180 Average:5373.21 Median:6219.88 stddev:1650.66 (26.5%) stddev-sans-first:1611.18 18:08:45 INFO - PROCESS | 12883 | Values: 323.1 325.1 327.2 330.4 332.0 6085.4 6142.1 6157.1 6167.2 6180.2 6062.1 6063.2 6063.2 6075.3 6076.2 4364.1 4539.0 4565.9 4601.8 4616.2 4561.2 4596.4 4611.1 4612.6 4613.5 4391.8 4565.7 4582.6 4582.7 4583.3 4478.4 4571.1 4575.7 4589.4 4592.0 3989.8 3994.0 3995.0 3999.7 4003.8 5773.1 5778.1 5782.5 5791.7 5866.0 5345.1 5349.3 5350.6 5357.5 5359.4 6371.5 6378.2 6382.6 6387.5 6390.3 4359.7 4444.5 4448.8 4456.1 4458.8 6662.2 6672.2 6673.4 6679.4 6684.3 4541.8 4548.9 4553.7 4555.4 4556.9 4609.8 4610.2 4614.8 4617.6 4619.4 5325.7 5327.1 5327.2 5336.3 5346.1 6279.8 6441.6 6445.3 6446.3 6459.2 1601.0 1609.5 1619.3 1620.7 1621.7 966.3 971.0 971.0 971.9 1057.4 6117.0 6210.6 6211.4 6228.3 6313.2 6694.1 6703.1 6703.5 6706.0 6710.1 6279.9 6300.7 6304.1 6308.5 6312.8 3553.6 3587.7 3597.3 3599.3 3604.4 6660.7 6880.4 6881.1 6885.0 6889.8 6772.6 6783.7 6786.2 6793.8 6804.9 6864.7 6873.8 6922.5 6964.4 6970.9 6623.9 6655.2 6658.5 6659.7 6668.8 6312.7 6596.1 6616.6 6635.3 6636.3 6834.3 6859.2 6864.9 6885.8 6897.4 4258.1 4258.3 4260.1 4263.4 4264.6 6671.4 6684.3 6706.1 6713.1 6769.6 6279.9 6504.9 6527.2 6529.2 6544.7 6473.8 6479.7 6514.1 6533.9 6549.2 6336.1 6346.0 6353.4 6355.5 6357.8 6520.7 6522.0 6527.8 6538.7 6543.5 6080.8 6167.3 6260.0 6265.5 6369.7 18:08:45 INFO - PROCESS | 12883 | 18:08:45 INFO - PROCESS | 12883 | [#5] yui.html Cycles:180 Average:14801.44 Median:4675.71 stddev:17134.01 (366.4%) stddev-sans-first:17149.21 18:08:45 INFO - PROCESS | 12883 | Values: 670.2 763.3 777.9 794.6 798.7 14487.9 14614.8 14634.9 14640.7 14654.1 13239.7 13647.7 13824.1 13945.2 14004.6 807.6 813.6 817.8 818.6 821.1 678.0 813.9 836.4 839.0 843.5 859.3 866.3 866.5 868.1 868.3 701.0 863.2 864.1 864.4 864.4 623.9 626.0 626.4 627.5 627.7 14389.1 14434.0 14448.9 14535.6 14542.1 13387.4 13935.4 14000.9 14010.9 14073.9 11110.4 11242.7 11490.4 11521.1 11964.0 3776.3 3800.7 3837.7 3918.6 3941.4 52993.5 53033.0 53102.2 53483.2 53670.0 10208.1 10626.0 10705.5 10910.6 10963.6 18911.7 18952.6 19117.7 19143.1 19193.9 8115.8 8116.1 8128.2 8180.2 8311.0 4603.0 4650.4 4701.0 4781.4 4813.4 3286.3 3298.2 3310.4 3311.5 3315.6 589.2 600.5 608.4 610.5 619.1 702.7 711.7 717.9 725.3 733.8 8362.1 8778.4 9350.6 9381.6 9496.0 700.3 702.2 713.7 718.7 742.3 4368.5 4382.0 4385.8 4425.7 4456.6 59524.4 60751.0 61389.7 61969.7 62017.7 53886.7 54733.7 55158.4 55729.4 56214.4 49940.5 50593.0 50964.7 51373.0 51665.0 8367.2 8370.5 8549.0 8635.4 9285.7 35900.6 36206.3 36965.3 37651.0 38491.8 44586.6 45167.8 45674.0 47400.3 47571.3 11521.9 11683.6 11697.9 11721.9 12149.0 12836.9 13202.1 13227.9 13568.0 13833.5 11857.3 11863.9 11937.2 11965.0 12285.9 12562.1 12609.0 12727.7 13060.2 13095.0 11992.7 12103.4 12111.1 12266.9 12660.1 9477.4 9520.3 9794.2 9877.0 10021.4 10424.8 10588.7 10714.5 10730.8 10747.1 18:08:45 INFO - PROCESS | 12883 | -------- Summary: end -------- 18:08:45 INFO - PROCESS | 12883 | 18:08:46 INFO - TEST-INFO | 12883: exit 0 18:08:46 INFO - TEST-OK | dromaeo_css | took 1110658ms 18:08:46 INFO - TEST-START | kraken 18:08:46 INFO - operating with platform_type : linux_ 18:08:46 INFO - Initialising browser for kraken test... 18:08:46 INFO - TEST-INFO | started process 13066 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpag3t8S/profile http://localhost:34920/getInfo.html) 18:08:50 INFO - PROCESS | 13066 | __metrics Screen width/height:1600/1200 18:08:50 INFO - PROCESS | 13066 | colorDepth:24 18:08:50 INFO - PROCESS | 13066 | Browser inner width/height: 1024/697 18:08:50 INFO - PROCESS | 13066 | __metrics 18:08:51 ERROR - PROCESS | 13066 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:08:51 INFO - TEST-INFO | 13066: exit 0 18:08:51 INFO - Browser initialized. 18:08:51 INFO - Running cycle 1/1 for kraken test... 18:08:51 INFO - TEST-INFO | started process 13149 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpag3t8S/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:09:03 INFO - PROCESS | 13149 | RSS: Main: 153460736 18:09:03 INFO - PROCESS | 13149 | 18:09:06 INFO - PROCESS | 13149 | Cycle 1(1): loaded http://localhost:34920/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34920/tests/kraken/driver.html?testName=audio-beat-detection) 18:09:06 INFO - PROCESS | 13149 | RSS: Main: 195678208 18:09:06 INFO - PROCESS | 13149 | 18:09:09 INFO - PROCESS | 13149 | Cycle 1(1): loaded http://localhost:34920/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34920/tests/kraken/driver.html?testName=audio-dft) 18:09:09 INFO - PROCESS | 13149 | RSS: Main: 185171968 18:09:09 INFO - PROCESS | 13149 | 18:09:12 INFO - PROCESS | 13149 | Cycle 1(1): loaded http://localhost:34920/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34920/tests/kraken/driver.html?testName=audio-fft) 18:09:13 INFO - PROCESS | 13149 | RSS: Main: 167976960 18:09:13 INFO - PROCESS | 13149 | 18:09:15 INFO - PROCESS | 13149 | Cycle 1(1): loaded http://localhost:34920/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34920/tests/kraken/driver.html?testName=audio-oscillator) 18:09:16 INFO - PROCESS | 13149 | RSS: Main: 171159552 18:09:16 INFO - PROCESS | 13149 | 18:09:18 INFO - PROCESS | 13149 | Cycle 1(1): loaded http://localhost:34920/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34920/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:09:18 INFO - PROCESS | 13149 | RSS: Main: 172515328 18:09:18 INFO - PROCESS | 13149 | 18:09:21 INFO - PROCESS | 13149 | Cycle 1(1): loaded http://localhost:34920/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34920/tests/kraken/driver.html?testName=imaging-darkroom) 18:09:22 INFO - PROCESS | 13149 | RSS: Main: 173445120 18:09:22 INFO - PROCESS | 13149 | 18:09:25 INFO - PROCESS | 13149 | Cycle 1(1): loaded http://localhost:34920/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34920/tests/kraken/driver.html?testName=imaging-desaturate) 18:09:26 INFO - PROCESS | 13149 | RSS: Main: 174292992 18:09:26 INFO - PROCESS | 13149 | 18:09:29 INFO - PROCESS | 13149 | Cycle 1(1): loaded http://localhost:34920/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34920/tests/kraken/driver.html?testName=json-parse-financial) 18:09:29 INFO - PROCESS | 13149 | RSS: Main: 173969408 18:09:29 INFO - PROCESS | 13149 | 18:09:31 INFO - PROCESS | 13149 | Cycle 1(1): loaded http://localhost:34920/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34920/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:09:31 INFO - PROCESS | 13149 | RSS: Main: 186146816 18:09:31 INFO - PROCESS | 13149 | 18:09:33 INFO - PROCESS | 13149 | Cycle 1(1): loaded http://localhost:34920/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34920/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:09:34 INFO - PROCESS | 13149 | RSS: Main: 182751232 18:09:34 INFO - PROCESS | 13149 | 18:09:36 INFO - PROCESS | 13149 | Cycle 1(1): loaded http://localhost:34920/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34920/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:09:36 INFO - PROCESS | 13149 | RSS: Main: 196624384 18:09:36 INFO - PROCESS | 13149 | 18:09:39 INFO - PROCESS | 13149 | Cycle 1(1): loaded http://localhost:34920/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34920/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:09:39 INFO - PROCESS | 13149 | RSS: Main: 203644928 18:09:39 INFO - PROCESS | 13149 | 18:09:42 INFO - PROCESS | 13149 | Cycle 1(1): loaded http://localhost:34920/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34920/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:09:42 INFO - PROCESS | 13149 | RSS: Main: 202670080 18:09:42 INFO - PROCESS | 13149 | 18:09:44 INFO - PROCESS | 13149 | Cycle 1(1): loaded http://localhost:34920/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34920/tests/kraken/driver.html?testName=ai-astar) 18:09:44 INFO - PROCESS | 13149 | RSS: Main: 266072064 18:09:44 INFO - PROCESS | 13149 | 18:09:44 INFO - PROCESS | 13149 | __start_tp_report 18:09:44 INFO - PROCESS | 13149 | _x_x_mozilla_page_load 18:09:44 INFO - PROCESS | 13149 | _x_x_mozilla_page_load_details 18:09:44 INFO - PROCESS | 13149 | |i|pagename|runs| 18:09:44 INFO - PROCESS | 13149 | |0;ai-astar;109;111;105;110;108;110;100;109;112;108 18:09:44 INFO - PROCESS | 13149 | |1;audio-beat-detection;152;126;155;166;128;150;156;127;179;128 18:09:44 INFO - PROCESS | 13149 | |2;audio-dft;163;162;162;162;161;162;163;164;162;161 18:09:44 INFO - PROCESS | 13149 | |3;audio-fft;75;77;95;95;72;72;76;132;100;76 18:09:44 INFO - PROCESS | 13149 | |4;audio-oscillator;93;93;141;93;93;93;141;92;93;140 18:09:44 INFO - PROCESS | 13149 | |5;imaging-gaussian-blur;117;117;117;118;117;117;117;117;117;117 18:09:44 INFO - PROCESS | 13149 | |6;imaging-darkroom;146;147;146;147;146;146;147;147;146;148 18:09:44 INFO - PROCESS | 13149 | |7;imaging-desaturate;95;96;95;96;95;95;95;96;96;95 18:09:44 INFO - PROCESS | 13149 | |8;json-parse-financial;56;60;58;58;59;57;57;66;55;55 18:09:44 INFO - PROCESS | 13149 | |9;json-stringify-tinderbox;61;60;62;63;62;62;62;61;61;62 18:09:44 INFO - PROCESS | 13149 | |10;stanford-crypto-aes;78;84;78;78;79;79;78;78;78;79 18:09:44 INFO - PROCESS | 13149 | |11;stanford-crypto-ccm;117;113;119;124;108;115;109;123;113;112 18:09:44 INFO - PROCESS | 13149 | |12;stanford-crypto-pbkdf2;144;134;139;145;144;134;156;142;142;143 18:09:44 INFO - PROCESS | 13149 | |13;stanford-crypto-sha256-iterative;69;63;64;63;65;64;63;65;64;62 18:09:44 INFO - PROCESS | 13149 | __end_tp_report 18:09:44 INFO - PROCESS | 13149 | __start_cc_report 18:09:44 INFO - PROCESS | 13149 | _x_x_mozilla_cycle_collect,1049 18:09:44 INFO - PROCESS | 13149 | __end_cc_report 18:09:44 INFO - PROCESS | 13149 | __startTimestamp1458868184784__endTimestamp 18:09:44 INFO - PROCESS | 13149 | 18:09:44 INFO - PROCESS | 13149 | ------- Summary: start ------- 18:09:44 INFO - PROCESS | 13149 | Number of tests: 14 18:09:44 INFO - PROCESS | 13149 | 18:09:44 INFO - PROCESS | 13149 | [#0] ai-astar Cycles:10 Average:108.20 Median:109.50 stddev:3.46 (3.2%) stddev-sans-first:3.66 18:09:44 INFO - PROCESS | 13149 | Values: 109.0 111.0 105.0 110.0 108.0 110.0 100.0 109.0 112.0 108.0 18:09:44 INFO - PROCESS | 13149 | 18:09:44 INFO - PROCESS | 13149 | [#1] audio-beat-detection Cycles:10 Average:146.70 Median:153.50 stddev:18.64 (12.1%) stddev-sans-first:19.67 18:09:44 INFO - PROCESS | 13149 | Values: 152.0 126.0 155.0 166.0 128.0 150.0 156.0 127.0 179.0 128.0 18:09:44 INFO - PROCESS | 13149 | 18:09:44 INFO - PROCESS | 13149 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 18:09:44 INFO - PROCESS | 13149 | Values: 163.0 162.0 162.0 162.0 161.0 162.0 163.0 164.0 162.0 161.0 18:09:44 INFO - PROCESS | 13149 | 18:09:44 INFO - PROCESS | 13149 | [#3] audio-fft Cycles:10 Average:87.00 Median:76.00 stddev:19.03 (25.0%) stddev-sans-first:19.68 18:09:44 INFO - PROCESS | 13149 | Values: 75.0 77.0 95.0 95.0 72.0 72.0 76.0 132.0 100.0 76.0 18:09:44 INFO - PROCESS | 13149 | 18:09:44 INFO - PROCESS | 13149 | [#4] audio-oscillator Cycles:10 Average:107.20 Median:93.00 stddev:23.10 (24.8%) stddev-sans-first:23.92 18:09:44 INFO - PROCESS | 13149 | Values: 93.0 93.0 141.0 93.0 93.0 93.0 141.0 92.0 93.0 140.0 18:09:44 INFO - PROCESS | 13149 | 18:09:44 INFO - PROCESS | 13149 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 18:09:44 INFO - PROCESS | 13149 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 18:09:44 INFO - PROCESS | 13149 | 18:09:44 INFO - PROCESS | 13149 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 18:09:44 INFO - PROCESS | 13149 | Values: 146.0 147.0 146.0 147.0 146.0 146.0 147.0 147.0 146.0 148.0 18:09:44 INFO - PROCESS | 13149 | 18:09:44 INFO - PROCESS | 13149 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 18:09:44 INFO - PROCESS | 13149 | Values: 95.0 96.0 95.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 18:09:44 INFO - PROCESS | 13149 | 18:09:44 INFO - PROCESS | 13149 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:58.00 stddev:3.21 (5.5%) stddev-sans-first:3.32 18:09:44 INFO - PROCESS | 13149 | Values: 56.0 60.0 58.0 58.0 59.0 57.0 57.0 66.0 55.0 55.0 18:09:44 INFO - PROCESS | 13149 | 18:09:44 INFO - PROCESS | 13149 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.84 (1.4%) stddev-sans-first:0.87 18:09:44 INFO - PROCESS | 13149 | Values: 61.0 60.0 62.0 63.0 62.0 62.0 62.0 61.0 61.0 62.0 18:09:44 INFO - PROCESS | 13149 | 18:09:44 INFO - PROCESS | 13149 | [#10] stanford-crypto-aes Cycles:10 Average:78.90 Median:78.50 stddev:1.85 (2.4%) stddev-sans-first:1.94 18:09:44 INFO - PROCESS | 13149 | Values: 78.0 84.0 78.0 78.0 79.0 79.0 78.0 78.0 78.0 79.0 18:09:44 INFO - PROCESS | 13149 | 18:09:44 INFO - PROCESS | 13149 | [#11] stanford-crypto-ccm Cycles:10 Average:115.30 Median:116.00 stddev:5.44 (4.7%) stddev-sans-first:5.73 18:09:44 INFO - PROCESS | 13149 | Values: 117.0 113.0 119.0 124.0 108.0 115.0 109.0 123.0 113.0 112.0 18:09:44 INFO - PROCESS | 13149 | 18:09:44 INFO - PROCESS | 13149 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.30 Median:143.50 stddev:6.24 (4.3%) stddev-sans-first:6.58 18:09:44 INFO - PROCESS | 13149 | Values: 144.0 134.0 139.0 145.0 144.0 134.0 156.0 142.0 142.0 143.0 18:09:44 INFO - PROCESS | 13149 | 18:09:44 INFO - PROCESS | 13149 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.00 stddev:1.93 (3.0%) stddev-sans-first:1.00 18:09:44 INFO - PROCESS | 13149 | Values: 69.0 63.0 64.0 63.0 65.0 64.0 63.0 65.0 64.0 62.0 18:09:44 INFO - PROCESS | 13149 | -------- Summary: end -------- 18:09:44 INFO - PROCESS | 13149 | 18:09:45 INFO - TEST-INFO | 13149: exit 0 18:09:45 INFO - TEST-OK | kraken | took 59424ms 18:09:45 INFO - SUITE-END | took 1170s 18:09:45 INFO - Completed test suite (00:19:30) 18:09:45 INFO - javascript benchmark 18:09:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2936.897208597699, 3033.2568520712402, 3065.5861458703084, 3067.9233019174517, 3095.767817413693, 5047.293378926953, 5054.317667114948, 5161.245385526226, 5204.531592156705, 5238.135707608245, 5042.949570504294, 5091.567216786569, 5105.897882042357, 5226.55574276187, 5231.686098834072, 4678.97660511697, 4711.670183087185, 4819.397575303087, 4828.324034635154, 4877.5366340197625, 4640.883977900563, 4785.569298763111, 4821.927671084936, 4839.177339852216, 4855.32025516428, 4697.013627138305, 4722.787474563653, 4726.196546587088, 4733.0533893221145, 4761.500042495522, 4730.62155027597, 4734.0, 4735.57379835813, 4744.122337367598, 4770.427548694144, 4600.5629465200755, 4697.295405689139, 4705.529447055302, 4712.0, 4790.712557246577, 5113.105206588869, 5134.8202812901745, 5139.17773156297, 5139.280500729901, 5149.356330458692, 5478.0, 5491.313585801775, 5500.28496295479, 5548.611597188198, 5549.334079910396, 5384.1923711443205, 5419.187121931703, 5524.972375138139, 5586.581006424534, 5614.494695477427, 5137.948620513822, 5176.663516871391, 5178.119719647707, 5179.974100129513, 5182.093133701587, 5657.745401456944, 5661.830145095653, 5664.26364572603, 5664.405237450009, 5708.20085188074, 5263.657862239019, 5323.547498462674, 5413.377461591888, 5461.699606521679, 5480.123180291134, 5467.890642187213, 5507.394186639466, 5508.55931525477, 5511.145772405283, 5512.0905050667, 5234.555062819627, 5454.263674403984, 5488.890222195613, 5491.478309560585, 5542.473465020817, 5391.32608423947, 5422.0511410503, 5431.402545719968, 5441.102218133963, 5470.343558772973, 4216.620504154641, 4227.0, 4229.048464095554, 4234.026173980002, 4275.5296917339065, 3693.649103335179, 3760.7179461540495, 3779.527559055118, 3807.0, 3835.4055121456217, 5167.689938603696, 5174.715390653475, 5188.740562971836, 5216.66091704038, 5233.895322093536, 5477.370102438271, 5493.09363954943, 5495.313085864267, 5497.560195184456, 5503.9174412383845, 5107.106256405114, 5187.974060129751, 5192.143296356059, 5196.45437229093, 5202.583793296527, 4761.309610106515, 4773.952260477351, 4786.473487916326, 4806.8077276909235, 4836.951630483721, 5620.353659329229, 5625.099984002622, 5630.97184514083, 5634.774609015593, 5669.829905102853, 5300.681959082467, 5483.862903427446, 5501.4223506532835, 5502.367227768857, 5515.145152501369, 5639.520640745583, 5656.1233008882045, 5669.829905102853, 5689.146628005832, 5707.058335374617, 5413.810516631899, 5429.864253393696, 5436.728163591725, 5438.293021907127, 5447.509724124848, 5382.0, 5507.146392309199, 5510.228568000563, 5529.889402212014, 5582.7766889323975, 5473.28847249855, 5475.698836564027, 5476.04169270384, 5480.0, 5525.336959564878, 5411.945880541301, 5412.864678383072, 5434.809781657623, 5435.701036443033, 5490.203920431435, 5220.3735551734035, 5299.205119231991, 5302.946970530245, 5366.114591092426, 5369.97315013438, 5418.972905135449, 5425.755840987086, 5427.810026649048, 5434.972825135849, 5483.040467918178, 5321.36143662763, 5328.600354973315, 5330.573554115584, 5335.813246536352, 5378.489043540857], "unit": "score", "name": "dojo.html", "value": 5091.184279501948}, {"lowerIsBetter": false, "replicates": [522.2636083122798, 561.859535116221, 569.237222122356, 582.4350380131272, 593.4510577715612, 30038.249043773918, 38036.23927521452, 38127.23745525095, 38263.808680956594, 38300.0, 40464.595354046454, 40714.52140264569, 40897.0, 40932.18135637286, 41034.17931641373, 7794.220577942188, 8463.153684631534, 8643.913560864405, 8655.0, 10000.849987250198, 10054.145397641209, 10215.080642742189, 10215.693529194135, 10224.0, 10229.897701023006, 10162.0, 10277.229207809407, 10282.485875706223, 10285.434301113435, 10294.485275736184, 10061.647842325483, 10194.745131371737, 10199.4390308533, 10217.080462758313, 10241.77098748155, 10041.698749037541, 10079.496025198783, 10209.744756381077, 10217.744556386075, 10519.421431821247, 41268.79365603153, 41576.1684766306, 41582.0, 41668.791656041525, 41730.0, 3429.6227414984583, 3508.4912687660403, 3539.5752509698746, 3563.679268865789, 3909.902252443683, 30907.497363221628, 31263.531047034314, 31291.578132136565, 31332.0, 31957.360852783047, 4163.625273725379, 4199.097194103252, 4230.280852255124, 4242.787860606957, 4274.700770946035, 322498.0, 322617.0, 323525.0, 324736.0, 326037.0, 57365.42634573601, 57430.138547921815, 57867.42132578704, 57934.0, 57996.42003579994, 64840.378990524674, 65127.0, 66467.66766166234, 66893.66553167203, 66998.33001670019, 16312.75530867038, 16401.83598164027, 16455.506334809976, 16470.83529164693, 16484.175791210393, 12575.0, 12575.308358040213, 12617.810732839014, 12622.242665439919, 12623.0, 20496.897515512625, 20548.38354849357, 20677.689834652192, 20723.792762072488, 20778.272760453612, 7392.519486233377, 7473.439492038119, 7502.62486875654, 7732.806679833049, 7780.215167671841, 896.3680605173337, 979.9608015679436, 986.0386123529645, 1045.5242864496636, 1048.2662136504478, 28960.855195724307, 29483.557746633818, 29613.0, 29751.0, 30157.547636785464, 1081.561967403203, 1115.5649296774266, 1124.3085502416118, 1130.2596799096605, 1146.3523109443138, 15213.391464341525, 15528.922355388377, 15874.0, 17286.0, 17600.735988960176, 471934.0, 477741.0, 478089.0, 479421.0, 482998.0, 58177.70911145502, 58705.0, 58710.70644646835, 58735.70632146898, 58738.41261587329, 1191.6544202181271, 1392.526540976073, 1396.3925692323871, 1398.7342404943029, 1423.9359228834935, 27810.582841256994, 30484.7806087754, 30535.0, 30993.69006309908, 31335.0, 44471.33293000543, 44825.327620085074, 45246.54753452555, 45297.54702453065, 45326.0, 272717.0, 274796.0, 275872.0, 276161.0, 276670.0, 29697.257568560093, 34780.13049673779, 34876.0, 34973.0, 35089.64910350864, 40071.599284006785, 40144.0, 40316.1936761269, 41070.0, 41391.37912931248, 36525.0, 37869.24261514809, 37889.2422151561, 38113.2377352457, 38113.42829857499, 35702.05351213925, 37076.81461592675, 37353.81323093367, 37564.55830371017, 37970.62029379671, 36253.818730906176, 36822.8158859204, 37096.814515927246, 37135.44296835604, 37602.81198594099, 31737.36525269528, 33099.83450082734, 33330.83334583312, 33426.49860252049, 33591.144752696295, 25315.0, 25431.745682542936, 25451.0, 25611.231663050137, 26116.34709132211], "unit": "score", "name": "ext.html", "value": 19530.138933710157}, {"lowerIsBetter": false, "replicates": [355.34261616010383, 362.60476081071624, 371.272999816349, 372.5175897213108, 373.20507319409654, 17530.29878804848, 18138.183781729822, 19104.713429298572, 19564.608707825835, 19585.608287834235, 17539.38612148575, 17750.911245443756, 18579.907100464512, 18598.34905778298, 18600.906995465037, 5576.442355764421, 5749.683767392792, 5784.768609255625, 5788.652680839163, 5792.333881603607, 4151.294279972412, 5712.771489140429, 6037.094435834616, 6307.968460157693, 6317.557770956035, 6230.408111229426, 6252.2809876864285, 6257.968710156466, 6268.0, 6273.12176295319, 6043.697815109249, 6365.554411191219, 6371.39471750183, 6382.266039405481, 6384.744610215585, 3737.7570457920147, 5337.946620533823, 5530.142827861688, 5535.03136951032, 5614.747336369873, 20424.489387765425, 20497.4875628109, 20567.691484627743, 22066.4483387915, 22080.44798880041, 2237.6196046672103, 2311.352821210047, 2354.6232602783643, 2391.5814732421754, 2776.912772909035, 13596.456141754417, 13624.591262262147, 13659.112157709716, 14082.647933801634, 14165.362558684885, 1795.5152108930515, 1859.758231429919, 1881.3227238194238, 1889.6787546117193, 1922.7788804287545, 68988.31011689869, 71481.0, 71596.64201679011, 71826.281737183, 72304.6384768078, 10578.894211057945, 10609.522571484302, 10738.731531711614, 10750.0, 10757.569697212024, 14535.345909433889, 14623.04950178235, 14632.561023169323, 14652.706945861022, 14670.266486675624, 8067.677292908335, 8105.148959359182, 8111.634976426075, 8126.593670316461, 8281.171882811792, 7772.922270777333, 7893.0, 7907.683692652345, 7933.841323173504, 8169.63236654352, 4484.977575112169, 4591.0, 4591.540845915449, 4604.608608268268, 4618.838340658061, 1731.9348600610533, 1795.6828254984998, 1816.7547381103645, 1840.190316260841, 1894.2801735340759, 864.8140649760331, 984.1929617713406, 1002.1882275356984, 1017.4861694844204, 1082.5994382078525, 16784.916075419544, 16920.407785727686, 17148.657026859393, 17356.566085847702, 17558.29766809313, 913.977150571241, 921.9677311294073, 981.7594689301167, 993.2649839119144, 1005.703317521333, 10132.696019119438, 10228.795424091477, 10251.0, 10289.845652315222, 10350.741231469123, 449941.0, 453931.0, 458307.0, 459448.0, 460042.0, 75627.62186189034, 76131.0, 77607.0, 78204.0, 78439.0, 1042.9374237545924, 1046.3930920066343, 1095.1129585036147, 1113.6993011886746, 1121.6018313498753, 16079.67840643204, 16098.11460369644, 16139.354425823305, 16199.838001619833, 16287.267072981507, 35676.82161589176, 36053.27893442064, 36707.81646091752, 37439.62560374361, 37758.0, 47756.28365574589, 49918.25122623091, 49953.0, 50161.74919125381, 50463.74768126136, 7965.402594805297, 7980.960095199487, 7996.880046799186, 8004.319632831041, 8073.39449541275, 12234.938825305817, 12567.87432125667, 12757.936210318889, 13165.53920612774, 13253.0, 10600.46997650099, 10650.8402373966, 10761.46192690378, 11173.608923687632, 11209.327440353605, 10879.78240435171, 10928.235023548275, 11268.154888383568, 11288.209825312479, 11541.134414918746, 10649.787004260026, 10705.9464702676, 10862.837057444303, 11050.668479945614, 11125.221234513507, 8590.441621294596, 11220.607278745205, 11253.381064041556, 11299.887001130212, 11554.133439991867, 10838.187135964992, 11134.0, 11139.443027848412, 11171.106311494897, 11348.375839328586], "unit": "score", "name": "jquery.html", "value": 8974.514157079484}, {"lowerIsBetter": false, "replicates": [1342.5301144599398, 1477.8743806776424, 1478.0466599043616, 1628.7312593422087, 1808.8824226425281, 7511.62441877906, 7698.4611077224545, 7718.6912523498995, 7725.0, 7727.72952946647, 7632.122305934819, 7793.025871766029, 7794.727184548542, 7800.921990780091, 7814.882776758353, 1903.0674969265099, 1949.5905859769466, 2228.821694264463, 2238.3620668109593, 2262.592733308004, 2316.918907838226, 2318.7797159269844, 2322.605157123293, 2325.9534809303805, 2328.685627440291, 2145.0776166248506, 2197.04428573571, 2211.6793065005563, 2216.9556608867815, 2217.966730499044, 2217.1131547381015, 2222.5777102350585, 2225.5326381459913, 2225.8441909066373, 2227.509947811479, 2251.4934139818574, 2258.153192552793, 2262.3665373695226, 2262.5474905019064, 2270.3983444387086, 7804.648790804427, 7853.96073019637, 7891.644875980594, 7891.644875980594, 7895.249951254622, 4793.688410253322, 4919.237518184687, 4931.408231012301, 4944.777485013183, 4946.233333833262, 3128.311771410286, 3153.8423078845967, 3257.9348413031844, 3276.410246155691, 3289.8848540301215, 971.2375785008734, 979.1090108001684, 1008.5159123620704, 1040.095117247999, 1057.8730552333768, 10786.46067696612, 10795.892041079645, 10830.78338433227, 10864.402457864815, 10877.619283325124, 4203.07532342884, 4239.957600423956, 4285.400043993844, 4302.139572085595, 4364.432623758955, 9442.527873606292, 9451.102145296185, 9474.289428292906, 9474.763130921645, 9477.147056764925, 4966.776495057731, 4981.850544483671, 4983.127952608279, 4984.825531106394, 4992.625553083533, 3880.728349015542, 3991.840326386912, 4417.757023363682, 4493.393391892053, 4577.198990176706, 3743.0455233915723, 3751.174741556853, 3814.6566808987322, 3843.557990831034, 3848.191879705237, 1255.2782150263636, 1256.7549327880974, 1259.118616968126, 1279.0, 1280.2766436963086, 1338.1101567457727, 1342.8858547023417, 1344.1263178933575, 1353.282760137109, 1356.2811709793825, 7205.279472052857, 7338.339549440576, 7350.52221605594, 7353.0, 7582.886256706154, 1107.8781334053247, 1116.625930313338, 1140.8288756686397, 1150.896419322265, 1154.2958795134962, 5929.37741537141, 5954.136650185699, 6011.819645410645, 6012.579119461683, 6019.187409699634, 8948.597313120925, 9507.904920950841, 9511.66709165176, 9513.143817056498, 9638.0, 9596.95201523988, 9665.516724163763, 9713.854292185622, 9721.076497732704, 9739.0, 7351.705931762776, 7589.696412143563, 7606.3914886808925, 7639.770806875803, 7671.2712292332135, 6974.128233970754, 7004.4046256068805, 7007.229204787572, 7026.789196324118, 7029.226785053538, 8562.657493700432, 8644.56777161152, 8664.35017373687, 8726.912730872864, 8787.0, 8781.604827782638, 8844.425112367675, 8845.336599754915, 9045.547722613712, 9081.500517471603, 6000.849978750566, 6554.573952693059, 6696.229933557508, 6899.0, 7006.579605223703, 7519.323260906544, 7564.583947882919, 7579.924200757921, 7599.506032107895, 7641.044869391326, 6805.523613347018, 6964.233934267328, 6976.093107895941, 7013.754518591825, 7077.964610176916, 6853.0, 6888.517803753689, 6944.375006249462, 6988.8951665724035, 6991.0, 7031.367176954099, 7100.538464999759, 7110.57336559808, 7215.567065976058, 7234.927650723425, 6509.73961041572, 6539.542232043902, 6573.605583664996, 6582.275949645439, 6584.407403333723, 6392.169018027626, 6521.478281737544, 6578.5395022347975, 6579.17760279965, 6583.901241481286], "unit": "score", "name": "mootools.html", "value": 4560.9374465574965}, {"lowerIsBetter": false, "replicates": [323.1001660375854, 325.1400046876013, 327.2163169209742, 330.4448526475522, 332.0420586607639, 6085.391460853913, 6142.109394137853, 6157.107219453176, 6167.167432396625, 6180.1656776335185, 6062.060380640996, 6063.181470501481, 6063.211782468284, 6075.33171351151, 6076.179715738374, 4364.127174565084, 4539.0, 4565.863024109282, 4601.769911504428, 4616.192166370888, 4561.247394179956, 4596.402467679197, 4611.054733779584, 4612.561806628365, 4613.492515823256, 4391.780410979454, 4565.748883811406, 4582.587567118959, 4582.7250364978045, 4583.289590113538, 4478.373027776114, 4571.131485017836, 4575.702579332333, 4589.403377560929, 4591.977040114794, 3989.780562069085, 3994.0, 3994.981279773668, 3999.7200195986293, 4003.799810009488, 5773.134029895507, 5778.104393818923, 5782.537397008229, 5791.65250084992, 5866.032104702719, 5345.118055520835, 5349.251104845324, 5350.571954243651, 5357.5446087082255, 5359.356877174764, 6371.490280777527, 6378.234611846562, 6382.648954307511, 6387.489000879918, 6390.297067322591, 4359.716618419824, 4444.466664000341, 4448.799804008828, 4456.086502267028, 4458.754768487732, 6662.200535935719, 6672.232693240291, 6673.399394054559, 6679.398854103106, 6684.2647308795995, 4541.75020373876, 4548.931766023512, 4553.681242313072, 4555.430571178603, 4556.88607784808, 4609.792559334838, 4610.239310513794, 4614.838480653161, 4617.561331673485, 4619.353290539327, 5325.733713314319, 5327.067763141435, 5327.227552004938, 5336.252924590561, 5346.091164502044, 6279.780207692709, 6441.64570948593, 6445.258795238514, 6446.290908000116, 6459.160309159779, 1600.9839901601067, 1609.5090997245952, 1619.327978888748, 1620.7082725109358, 1621.659451515195, 966.3284017607696, 970.9805803883883, 971.048372594861, 971.931964762474, 1057.4289883462843, 6117.0, 6210.596311239755, 6211.440970312694, 6228.314885362606, 6313.210848643919, 6694.09629699994, 6703.095082163943, 6703.463722902254, 6706.0, 6710.127683401127, 6279.874402511924, 6300.653464059429, 6304.085907543472, 6308.495320374359, 6312.810615681537, 3553.591336996227, 3587.677109060197, 3597.3165098631175, 3599.298136863339, 3604.351216780952, 6660.733570657119, 6880.415164711056, 6881.13985751781, 6885.036094946711, 6889.758858439931, 6772.627505487246, 6783.728650854009, 6786.219584747817, 6793.762218322335, 6804.897926531106, 6864.656767161622, 6873.759418420432, 6922.480813938874, 6964.373206411447, 6970.930290697028, 6623.933760662524, 6655.2346480153465, 6658.500612453989, 6659.733610655713, 6668.799936001928, 6312.715927783169, 6596.109525214227, 6616.569922954993, 6635.336466353326, 6636.2700102987665, 6834.316568343126, 6859.245482996766, 6864.862702745817, 6885.794985877552, 6897.41371983387, 4258.127083947845, 4258.254805408979, 4260.126674031878, 4263.424437700871, 4264.6375058119165, 6671.432928201158, 6684.298148694317, 6706.094677218513, 6713.093732346071, 6769.593824370553, 6279.932411489966, 6504.869902602016, 6527.2167339919515, 6529.151210342625, 6544.6727663617585, 6473.805785826433, 6479.676016199265, 6514.088027676224, 6533.934660653333, 6549.24683661366, 6336.081268216175, 6346.048092786119, 6353.428191462605, 6355.459785918064, 6357.809265722036, 6520.739170433129, 6522.0, 6527.836804079936, 6538.738450462119, 6543.509236807164, 6080.787172448943, 6167.290761562298, 6260.0, 6265.530085243716, 6369.7452101915405], "unit": "score", "name": "prototype.html", "value": 4824.288261200627}, {"lowerIsBetter": false, "replicates": [670.249320760748, 763.3206446262825, 777.9377649788021, 794.614611913222, 798.6925033861963, 14487.927560362197, 14614.780778288334, 14634.926825365872, 14640.707185856303, 14654.120752754816, 13239.669008274797, 13647.727045459085, 13824.101433406822, 13945.163290202596, 14004.64988375291, 807.5719868469721, 813.5606772342928, 817.7546735979182, 818.615250832111, 821.0885916632562, 678.0338018323894, 813.8535063688533, 836.3977935886152, 838.9790255243606, 843.5065486690294, 859.3297228162044, 866.3156106675718, 866.4584634603373, 868.0581568997645, 868.2533021601417, 701.0150738212768, 863.2360361080489, 864.062492195965, 864.394923553512, 864.4251572704144, 623.8627501949563, 626.0452809465602, 626.4455956478504, 627.5199472403615, 627.6641996531879, 14389.13665180082, 14434.0, 14448.855511444961, 14535.563933082025, 14542.054766440147, 13387.397567109503, 13935.372908219155, 14000.929995349958, 14010.929945350208, 14073.929630351886, 11110.44447777616, 11242.718932026683, 11490.42547872603, 11521.135914806424, 11964.042876569854, 3776.2825063237897, 3800.6959443244473, 3837.6737977271964, 3918.608139186087, 3941.4481972523868, 52993.470065299625, 53033.0, 53102.20346694841, 53483.19775203375, 53670.0, 10208.132308753691, 10626.0, 10705.464726763787, 10910.618128365628, 10963.61627343055, 18911.716324255147, 18952.62094758097, 19117.713234301496, 19143.138558764887, 19193.90403047976, 8115.75652730419, 8116.066652334939, 8128.227818357246, 8180.222878826502, 8310.958445207856, 4602.976985115053, 4650.4186976627925, 4701.0, 4781.426228852491, 4813.3983252093485, 3286.3263031078573, 3298.241404476984, 3310.4372256715933, 3311.519829624691, 3315.635280119185, 589.1633879890566, 600.5435868739789, 608.3855306140741, 610.4597431273266, 619.1146660275759, 702.6943279673359, 711.7437722419925, 717.8636059148745, 725.3399406540128, 733.8202140475618, 8362.12197719243, 8778.429402088845, 9350.625974961062, 9381.62473501066, 9496.0, 700.3346820520526, 702.2135208566439, 713.7216485570632, 718.6981467783544, 742.3022358982647, 4368.521996641155, 4382.0, 4385.846495372647, 4425.668074894395, 4456.64346852251, 59524.40475595189, 60751.0, 61389.69305153535, 61969.69015154895, 62017.68991155015, 53886.7305663477, 54733.72633136809, 55158.44841551533, 55729.44270557324, 56214.43785562174, 49940.500594994315, 50593.0, 50964.74517627388, 51373.0, 51665.0, 8367.246947774729, 8370.539620320696, 8548.957255213683, 8635.395522313378, 9285.72142835716, 35900.64099358973, 36206.27587448289, 36965.26069478649, 37651.0, 38491.80754096324, 44586.55413445954, 45167.77416112898, 45674.0, 47400.28899566578, 47571.28643070426, 11521.942390287995, 11683.649490515298, 11697.883021169679, 11721.88278117242, 12149.0, 12836.935815321238, 13202.141860779018, 13227.867721322664, 13568.0, 13833.515826946008, 11857.347845868215, 11863.940680296544, 11937.16439849237, 11965.0, 12285.877141228473, 12562.120651554304, 12609.0, 12727.681807954876, 13060.151090179108, 13095.0, 11992.700182495508, 12103.394830258276, 12111.091668124749, 12266.938665306616, 12660.11379203447, 9477.431354118775, 9520.285978551497, 9794.21646268311, 9877.012298770353, 10021.448820314952, 10424.791504170025, 10588.682339529518, 10714.464276786286, 10730.839037414602, 10747.140228781522], "unit": "score", "name": "yui.html", "value": 6695.186569756455}], "name": "dromaeo_css", "value": 7130.789650282593}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 105.0, 110.0, 108.0, 110.0, 100.0, 109.0, 112.0, 108.0], "unit": "score", "name": "ai-astar", "value": 108.2}, {"lowerIsBetter": true, "replicates": [152.0, 126.0, 155.0, 166.0, 128.0, 150.0, 156.0, 127.0, 179.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 146.7}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 162.0, 162.0, 161.0, 162.0, 163.0, 164.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.2}, {"lowerIsBetter": true, "replicates": [75.0, 77.0, 95.0, 95.0, 72.0, 72.0, 76.0, 132.0, 100.0, 76.0], "unit": "score", "name": "audio-fft", "value": 87.0}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 141.0, 93.0, 93.0, 93.0, 141.0, 92.0, 93.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 107.2}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.1}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [56.0, 60.0, 58.0, 58.0, 59.0, 57.0, 57.0, 66.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.1}, {"lowerIsBetter": true, "replicates": [61.0, 60.0, 62.0, 63.0, 62.0, 62.0, 62.0, 61.0, 61.0, 62.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 61.6}, {"lowerIsBetter": true, "replicates": [78.0, 84.0, 78.0, 78.0, 79.0, 79.0, 78.0, 78.0, 78.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.9}, {"lowerIsBetter": true, "replicates": [117.0, 113.0, 119.0, 124.0, 108.0, 115.0, 109.0, 123.0, 113.0, 112.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.3}, {"lowerIsBetter": true, "replicates": [144.0, 134.0, 139.0, 145.0, 144.0, 134.0, 156.0, 142.0, 142.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.3}, {"lowerIsBetter": true, "replicates": [69.0, 63.0, 64.0, 63.0, 65.0, 64.0, 63.0, 65.0, 64.0, 62.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 64.2}], "name": "kraken", "value": 1490.8}]} 18:09:46 INFO - Return code: 0 18:09:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 18:09:46 ERROR - # TBPL SUCCESS # 18:09:46 INFO - Running post-action listener: _resource_record_post_action 18:09:46 INFO - Running post-run listener: _resource_record_post_run 18:09:47 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 544137216; Read time: 4; Write time: 546320 18:09:47 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 252198912; Read time: 0; Write time: 321056 18:09:47 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291938304; Read time: 4; Write time: 225264 18:09:47 INFO - Running post-run listener: _upload_blobber_files 18:09:47 INFO - Blob upload gear active. 18:09:47 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 18:09:47 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:09:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 18:09:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 18:09:47 INFO - (blobuploader) - INFO - Open directory for files ... 18:09:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 18:09:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:09:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:09:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:09:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:09:49 INFO - (blobuploader) - INFO - Done attempting. 18:09:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:09:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:09:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:09:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:09:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:09:50 INFO - (blobuploader) - INFO - Done attempting. 18:09:50 INFO - (blobuploader) - INFO - Iteration through files over. 18:09:50 INFO - Return code: 0 18:09:50 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 18:09:50 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 18:09:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/549d91b6aaa212de4852d85cc584a20bdbe491180a8c1b045abe996215226f3f307fbaa152848cd4dc417f2657d2b44abcb0633783c6172f1bf9e346ecf371b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/49d7cb658f9ab21fea730fdf5c8bb1c59a7aed4b23a226162cbf688b62af346485a5ae2536dc5603c5222ea0a025c4d789bed1b45aaa035d6ad76024b2d998cc"} 18:09:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 18:09:50 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 18:09:50 INFO - Contents: 18:09:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/549d91b6aaa212de4852d85cc584a20bdbe491180a8c1b045abe996215226f3f307fbaa152848cd4dc417f2657d2b44abcb0633783c6172f1bf9e346ecf371b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/49d7cb658f9ab21fea730fdf5c8bb1c59a7aed4b23a226162cbf688b62af346485a5ae2536dc5603c5222ea0a025c4d789bed1b45aaa035d6ad76024b2d998cc"} 18:09:50 INFO - Running post-run listener: copy_logs_to_upload_dir 18:09:50 INFO - Copying logs to upload dir... 18:09:50 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 18:09:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.942428 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-03-24 18:09:50.096906) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-24 18:09:50.100173) ========= 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-1458866960.888627-767165492 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/549d91b6aaa212de4852d85cc584a20bdbe491180a8c1b045abe996215226f3f307fbaa152848cd4dc417f2657d2b44abcb0633783c6172f1bf9e346ecf371b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/49d7cb658f9ab21fea730fdf5c8bb1c59a7aed4b23a226162cbf688b62af346485a5ae2536dc5603c5222ea0a025c4d789bed1b45aaa035d6ad76024b2d998cc"} build_url:https://queue.taskcluster.net/v1/task/dc8QqAQzSFOhg69W2mlQOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011172 build_url: 'https://queue.taskcluster.net/v1/task/dc8QqAQzSFOhg69W2mlQOA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/549d91b6aaa212de4852d85cc584a20bdbe491180a8c1b045abe996215226f3f307fbaa152848cd4dc417f2657d2b44abcb0633783c6172f1bf9e346ecf371b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/49d7cb658f9ab21fea730fdf5c8bb1c59a7aed4b23a226162cbf688b62af346485a5ae2536dc5603c5222ea0a025c4d789bed1b45aaa035d6ad76024b2d998cc"}' ========= master_lag: 0.08 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-24 18:09:50.195562) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 18:09:50.195962) ========= 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-1458866960.888627-767165492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004549 ========= master_lag: 0.13 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 18:09:50.333897) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-24 18:09:50.334471) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-24 18:09:50.335187) ========= ========= Total master_lag: 0.41 =========