builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-035 starttime: 1459821440.47 results: success (0) buildid: 20160404155841 builduid: 3095fd53a4c54f1f979ffd5ed691cdfd revision: a57a4c6df00d0ffaa35b2abc1e388c691c9eb514 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-04 18:57:20.471614) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-04 18:57:20.472119) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-04 18:57:20.472528) ========= 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=ed14279e38b05397cf4aa391000001a4-1459821047.534352-1654095597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006271 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-04 18:57:20.495811) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-04 18:57:20.496098) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-04 18:57:20.509111) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 18:57:20.509433) ========= 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=ed14279e38b05397cf4aa391000001a4-1459821047.534352-1654095597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004647 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 18:57:20.557992) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-04 18:57:20.558299) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-04 18:57:20.558680) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 18:57:20.558997) ========= 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=ed14279e38b05397cf4aa391000001a4-1459821047.534352-1654095597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-04 18:57: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% 223M=0s 2016-04-04 18:57:22 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114601 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 18:57:20.686563) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 18:57:20.686878) ========= 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=ed14279e38b05397cf4aa391000001a4-1459821047.534352-1654095597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022194 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 18:57:20.736296) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 18:57:20.736696) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a57a4c6df00d0ffaa35b2abc1e388c691c9eb514 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a57a4c6df00d0ffaa35b2abc1e388c691c9eb514 --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=ed14279e38b05397cf4aa391000001a4-1459821047.534352-1654095597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-04 18:57:22,202 truncating revision to first 12 chars 2016-04-04 18:57:22,203 Setting DEBUG logging. 2016-04-04 18:57:22,203 attempt 1/10 2016-04-04 18:57:22,203 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a57a4c6df00d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-04 18:57:22,627 unpacking tar archive at: mozilla-aurora-a57a4c6df00d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.714504 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 18:57:21.465149) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-04 18:57:21.465506) ========= echo a57a4c6df00d0ffaa35b2abc1e388c691c9eb514 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a57a4c6df00d0ffaa35b2abc1e388c691c9eb514'] 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=ed14279e38b05397cf4aa391000001a4-1459821047.534352-1654095597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False a57a4c6df00d0ffaa35b2abc1e388c691c9eb514 program finished with exit code 0 elapsedTime=0.004675 script_repo_revision: 'a57a4c6df00d0ffaa35b2abc1e388c691c9eb514' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-04 18:57:21.516274) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-04 18:57:21.516607) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-04 18:57:21.526696) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-04-04 18:57:21.526992) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=ed14279e38b05397cf4aa391000001a4-1459821047.534352-1654095597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:57:23 INFO - MultiFileLogger online at 20160404 18:57:23 in /builds/slave/test-pgo 18:57:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 18:57:23 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:57:23 INFO - {'append_to_log': False, 18:57:23 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:57:23 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:57:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:57:23 INFO - 'branch': 'Mozilla-Aurora', 18:57:23 INFO - 'buildbot_json_path': 'buildprops.json', 18:57:23 INFO - 'config_files': ('talos/linux_config.py',), 18:57:23 INFO - 'default_actions': ('clobber', 18:57:23 INFO - 'read-buildbot-config', 18:57:23 INFO - 'download-and-extract', 18:57:23 INFO - 'populate-webroot', 18:57:23 INFO - 'create-virtualenv', 18:57:23 INFO - 'install', 18:57:23 INFO - 'run-tests'), 18:57:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:57:23 INFO - 'download_minidump_stackwalk': True, 18:57:23 INFO - 'download_symbols': 'ondemand', 18:57:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:57:23 INFO - 'tooltool.py': '/tools/tooltool.py', 18:57:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:57:23 INFO - '/tools/misc-python/virtualenv.py')}, 18:57:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:57:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:57:23 INFO - 'installer_path': 'installer.exe', 18:57:23 INFO - 'log_level': 'info', 18:57:23 INFO - 'log_name': 'talos', 18:57:23 INFO - 'log_to_console': True, 18:57:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:57:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:57:23 INFO - 'opt_config_files': (), 18:57:23 INFO - 'pip_index': False, 18:57:23 INFO - 'sps_profile': False, 18:57:23 INFO - 'sps_profile_interval': 0, 18:57:23 INFO - 'suite': 'dromaeojs-e10s', 18:57:23 INFO - 'system_bits': '32', 18:57:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:57:23 INFO - 'title': 'talos-linux64-ix-035', 18:57:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:57:23 INFO - 'use_talos_json': True, 18:57:23 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:57:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:57:23 INFO - 'work_dir': 'build'} 18:57:23 INFO - ##### 18:57:23 INFO - ##### Running clobber step. 18:57:23 INFO - ##### 18:57:23 INFO - Running pre-action listener: _resource_record_pre_action 18:57:23 INFO - Running main action method: clobber 18:57:23 INFO - rmtree: /builds/slave/test-pgo/build 18:57:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:57:24 INFO - Running post-action listener: _resource_record_post_action 18:57:24 INFO - ##### 18:57:24 INFO - ##### Running read-buildbot-config step. 18:57:24 INFO - ##### 18:57:24 INFO - Running pre-action listener: _resource_record_pre_action 18:57:24 INFO - Running main action method: read_buildbot_config 18:57:24 INFO - Using buildbot properties: 18:57:24 INFO - { 18:57:24 INFO - "project": "", 18:57:24 INFO - "product": "firefox", 18:57:24 INFO - "script_repo_revision": "production", 18:57:24 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 18:57:24 INFO - "repository": "", 18:57:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 18:57:24 INFO - "buildid": "20160404155841", 18:57:24 INFO - "pgo_build": "True", 18:57:24 INFO - "basedir": "/builds/slave/test-pgo", 18:57:24 INFO - "buildnumber": 170, 18:57:24 INFO - "slavename": "talos-linux64-ix-035", 18:57:24 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:57:24 INFO - "platform": "ubuntu64_hw", 18:57:24 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 18:57:24 INFO - "branch": "mozilla-aurora", 18:57:24 INFO - "repo_path": "releases/mozilla-aurora", 18:57:24 INFO - "revision": "a57a4c6df00d0ffaa35b2abc1e388c691c9eb514", 18:57:24 INFO - "stage_platform": "linux64-pgo", 18:57:24 INFO - "builduid": "3095fd53a4c54f1f979ffd5ed691cdfd", 18:57:24 INFO - "slavebuilddir": "test" 18:57:24 INFO - } 18:57:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/QOOfiPNnQsub7A2VqoDgGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 18:57:24 INFO - Running post-action listener: _resource_record_post_action 18:57:24 INFO - ##### 18:57:24 INFO - ##### Running download-and-extract step. 18:57:24 INFO - ##### 18:57:24 INFO - Running pre-action listener: _resource_record_pre_action 18:57:24 INFO - Running main action method: download_and_extract 18:57:24 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:57:24 INFO - https://queue.taskcluster.net/v1/task/QOOfiPNnQsub7A2VqoDgGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:57:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QOOfiPNnQsub7A2VqoDgGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 18:57:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QOOfiPNnQsub7A2VqoDgGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 18:57:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QOOfiPNnQsub7A2VqoDgGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 18:57:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QOOfiPNnQsub7A2VqoDgGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:57:24 INFO - Downloaded 1448 bytes. 18:57:24 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 18:57:24 INFO - Using the following test package requirements: 18:57:24 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 18:57:24 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 18:57:24 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 18:57:24 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 18:57:24 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 18:57:24 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 18:57:24 INFO - u'jsshell-linux-x86_64.zip'], 18:57:24 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 18:57:24 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 18:57:24 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 18:57:24 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 18:57:24 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 18:57:24 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 18:57:24 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 18:57:24 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 18:57:24 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 18:57:24 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 18:57:24 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 18:57:24 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 18:57:24 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:57:24 INFO - https://queue.taskcluster.net/v1/task/QOOfiPNnQsub7A2VqoDgGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:57:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QOOfiPNnQsub7A2VqoDgGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 18:57:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QOOfiPNnQsub7A2VqoDgGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 18:57:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QOOfiPNnQsub7A2VqoDgGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 18:57:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QOOfiPNnQsub7A2VqoDgGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:57:25 INFO - Downloaded 23344554 bytes. 18:57:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:57:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 18:57:27 INFO - Return code: 0 18:57:27 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:57:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:57:27 INFO - https://queue.taskcluster.net/v1/task/QOOfiPNnQsub7A2VqoDgGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:57:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QOOfiPNnQsub7A2VqoDgGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 18:57:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QOOfiPNnQsub7A2VqoDgGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 18:57:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QOOfiPNnQsub7A2VqoDgGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 18:57:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QOOfiPNnQsub7A2VqoDgGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:57:29 INFO - Downloaded 23344554 bytes. 18:57:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:57:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 18:57:30 INFO - Return code: 0 18:57: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')]} 18:57:30 INFO - https://queue.taskcluster.net/v1/task/QOOfiPNnQsub7A2VqoDgGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:57:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QOOfiPNnQsub7A2VqoDgGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 18:57:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QOOfiPNnQsub7A2VqoDgGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 18:57:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QOOfiPNnQsub7A2VqoDgGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 18:57:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QOOfiPNnQsub7A2VqoDgGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:57:32 INFO - Downloaded 10845161 bytes. 18:57:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:57:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 18:57:32 INFO - Return code: 0 18:57:32 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')]} 18:57:32 INFO - https://queue.taskcluster.net/v1/task/QOOfiPNnQsub7A2VqoDgGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:57:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QOOfiPNnQsub7A2VqoDgGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 18:57:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QOOfiPNnQsub7A2VqoDgGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 18:57:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QOOfiPNnQsub7A2VqoDgGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 18:57:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QOOfiPNnQsub7A2VqoDgGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:57:33 INFO - Downloaded 60569432 bytes. 18:57:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QOOfiPNnQsub7A2VqoDgGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 18:57:33 INFO - mkdir: /builds/slave/test-pgo/properties 18:57:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:57:33 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:57:33 INFO - Contents: 18:57:33 INFO - build_url:https://queue.taskcluster.net/v1/task/QOOfiPNnQsub7A2VqoDgGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 18:57:34 INFO - Running post-action listener: _resource_record_post_action 18:57:34 INFO - Running post-action listener: set_extra_try_arguments 18:57:34 INFO - ##### 18:57:34 INFO - ##### Running populate-webroot step. 18:57:34 INFO - ##### 18:57:34 INFO - Running pre-action listener: _resource_record_pre_action 18:57:34 INFO - Running main action method: populate_webroot 18:57:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:57:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:57:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:57:34 INFO - '--tppagecycles', 18:57:34 INFO - '7'], 18:57:34 INFO - 'tests': ['tsvgm']}}, 18:57:34 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:57:34 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:57:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:57:34 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:57:34 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:57:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:57:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:57:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:34 INFO - 'talos_options': ['--e10s'], 18:57:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:57:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:34 INFO - 'tests': ['damp', 'tps']}, 18:57:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:34 INFO - 'talos_options': ['--e10s'], 18:57:34 INFO - 'tests': ['damp', 'tps']}, 18:57:34 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:57:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:57:34 INFO - 'other': {'tests': ['a11yr', 18:57:34 INFO - 'ts_paint', 18:57:34 INFO - 'tpaint', 18:57:34 INFO - 'sessionrestore', 18:57:34 INFO - 'sessionrestore_no_auto_restore', 18:57:34 INFO - 'tabpaint']}, 18:57:34 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:57:34 INFO - 'tests': ['a11yr', 18:57:34 INFO - 'ts_paint', 18:57:34 INFO - 'tpaint', 18:57:34 INFO - 'sessionrestore', 18:57:34 INFO - 'sessionrestore_no_auto_restore', 18:57:34 INFO - 'tabpaint']}, 18:57:34 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:57:34 INFO - 'tests': ['a11yr', 18:57:34 INFO - 'ts_paint', 18:57:34 INFO - 'tpaint', 18:57:34 INFO - 'sessionrestore', 18:57:34 INFO - 'sessionrestore_no_auto_restore', 18:57:34 INFO - 'tabpaint']}, 18:57:34 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:57:34 INFO - 'tests': ['a11yr', 18:57:34 INFO - 'ts_paint', 18:57:34 INFO - 'tpaint', 18:57:34 INFO - 'sessionrestore', 18:57:34 INFO - 'sessionrestore_no_auto_restore', 18:57:34 INFO - 'tabpaint']}, 18:57:34 INFO - 'other_l64': {'tests': ['a11yr', 18:57:34 INFO - 'ts_paint', 18:57:34 INFO - 'tpaint', 18:57:34 INFO - 'sessionrestore', 18:57:34 INFO - 'sessionrestore_no_auto_restore', 18:57:34 INFO - 'tabpaint']}, 18:57:34 INFO - 'other_nol64': {'tests': ['a11yr', 18:57:34 INFO - 'ts_paint', 18:57:34 INFO - 'tpaint', 18:57:34 INFO - 'sessionrestore', 18:57:34 INFO - 'sessionrestore_no_auto_restore', 18:57:34 INFO - 'tabpaint']}, 18:57:34 INFO - 'svgr': {'tests': ['tsvgx', 18:57:34 INFO - 'tsvgr_opacity', 18:57:34 INFO - 'tart', 18:57:34 INFO - 'tscrollx', 18:57:34 INFO - 'cart']}, 18:57:34 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:57:34 INFO - 'tests': ['tsvgx', 18:57:34 INFO - 'tsvgr_opacity', 18:57:34 INFO - 'tart', 18:57:34 INFO - 'tscrollx', 18:57:34 INFO - 'cart']}, 18:57:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:34 INFO - 'tests': ['tp5o']}, 18:57:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:34 INFO - 'talos_options': ['--e10s'], 18:57:34 INFO - 'tests': ['tp5o']}, 18:57:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:34 INFO - 'talos_options': ['--xperf_path', 18:57:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:57:34 INFO - 'tests': ['tp5n']}, 18:57:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:34 INFO - 'talos_options': ['--e10s', 18:57:34 INFO - '--xperf_path', 18:57:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:57:34 INFO - 'tests': ['tp5n']}}, 18:57:34 INFO - 'talos.zip': {'path': '', 18:57:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:57:34 INFO - Running post-action listener: _resource_record_post_action 18:57:34 INFO - ##### 18:57:34 INFO - ##### Running create-virtualenv step. 18:57:34 INFO - ##### 18:57:34 INFO - Running pre-action listener: _resource_record_pre_action 18:57:34 INFO - Running main action method: create_virtualenv 18:57:34 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:57:34 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 18:57:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:57:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:57:34 INFO - Using real prefix '/usr' 18:57:34 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:57:35 INFO - Installing distribute.............................................................................................................................................................................................done. 18:57:37 INFO - Installing pip.................done. 18:57:37 INFO - Return code: 0 18:57:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:57:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:37 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7d76477f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24386d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c7920>, '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 0x24c8820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c8cb0>, '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': 'ed14279e38b05397cf4aa391000001a4-1459821047.534352-1654095597', '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 18:57:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 18:57:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:57:37 INFO - Using env: {'DISPLAY': ':0', 18:57:37 INFO - 'HOME': '/home/cltbld', 18:57:37 INFO - 'LANG': 'en_US.UTF-8', 18:57:37 INFO - 'LANGUAGE': 'en_US:en', 18:57:37 INFO - 'LOGNAME': 'cltbld', 18:57:37 INFO - 'MAIL': '/var/mail/cltbld', 18:57:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:37 INFO - 'MOZ_NO_REMOTE': '1', 18:57:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:37 INFO - 'NO_EM_RESTART': '1', 18:57:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:57:37 INFO - 'PWD': '/builds/slave/test-pgo', 18:57:37 INFO - 'SHELL': '/bin/bash', 18:57:37 INFO - 'SHLVL': '1', 18:57:37 INFO - 'TERM': 'linux', 18:57:37 INFO - 'TMOUT': '86400', 18:57:37 INFO - 'USER': 'cltbld', 18:57:37 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459821047.534352-1654095597', 18:57:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:37 INFO - '_': '/tools/buildbot/bin/python'} 18:57:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:37 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 18:57:37 INFO - Cleaning up... 18:57:37 INFO - Return code: 0 18:57:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:57:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:37 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7d76477f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24386d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c7920>, '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 0x24c8820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c8cb0>, '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': 'ed14279e38b05397cf4aa391000001a4-1459821047.534352-1654095597', '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 18:57:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 18:57:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:57:37 INFO - Using env: {'DISPLAY': ':0', 18:57:37 INFO - 'HOME': '/home/cltbld', 18:57:37 INFO - 'LANG': 'en_US.UTF-8', 18:57:37 INFO - 'LANGUAGE': 'en_US:en', 18:57:37 INFO - 'LOGNAME': 'cltbld', 18:57:37 INFO - 'MAIL': '/var/mail/cltbld', 18:57:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:37 INFO - 'MOZ_NO_REMOTE': '1', 18:57:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:37 INFO - 'NO_EM_RESTART': '1', 18:57:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:57:37 INFO - 'PWD': '/builds/slave/test-pgo', 18:57:37 INFO - 'SHELL': '/bin/bash', 18:57:37 INFO - 'SHLVL': '1', 18:57:37 INFO - 'TERM': 'linux', 18:57:37 INFO - 'TMOUT': '86400', 18:57:37 INFO - 'USER': 'cltbld', 18:57:37 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459821047.534352-1654095597', 18:57:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:37 INFO - '_': '/tools/buildbot/bin/python'} 18:57:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:37 INFO - Downloading/unpacking psutil>=0.7.1 18:57:37 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 18:57:37 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 18:57:37 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 18:57:37 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 18:57:37 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 18:57:37 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 18:57:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:57:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:57:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:57:39 INFO - Installing collected packages: psutil 18:57:39 INFO - Running setup.py install for psutil 18:57:39 INFO - building 'psutil._psutil_linux' extension 18:57:39 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 18:57:39 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 18:57:39 INFO - building 'psutil._psutil_posix' extension 18:57:39 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 18:57:39 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 18:57:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:57:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:57:39 INFO - Successfully installed psutil 18:57:39 INFO - Cleaning up... 18:57:40 INFO - Return code: 0 18:57:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:57:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7d76477f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24386d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c7920>, '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 0x24c8820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c8cb0>, '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': 'ed14279e38b05397cf4aa391000001a4-1459821047.534352-1654095597', '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 18:57:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 18:57:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:57:40 INFO - Using env: {'DISPLAY': ':0', 18:57:40 INFO - 'HOME': '/home/cltbld', 18:57:40 INFO - 'LANG': 'en_US.UTF-8', 18:57:40 INFO - 'LANGUAGE': 'en_US:en', 18:57:40 INFO - 'LOGNAME': 'cltbld', 18:57:40 INFO - 'MAIL': '/var/mail/cltbld', 18:57:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:40 INFO - 'MOZ_NO_REMOTE': '1', 18:57:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:40 INFO - 'NO_EM_RESTART': '1', 18:57:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:57:40 INFO - 'PWD': '/builds/slave/test-pgo', 18:57:40 INFO - 'SHELL': '/bin/bash', 18:57:40 INFO - 'SHLVL': '1', 18:57:40 INFO - 'TERM': 'linux', 18:57:40 INFO - 'TMOUT': '86400', 18:57:40 INFO - 'USER': 'cltbld', 18:57:40 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459821047.534352-1654095597', 18:57:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:40 INFO - '_': '/tools/buildbot/bin/python'} 18:57:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:57:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:57:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:57:42 INFO - Installing collected packages: mozsystemmonitor 18:57:42 INFO - Running setup.py install for mozsystemmonitor 18:57:42 INFO - Successfully installed mozsystemmonitor 18:57:42 INFO - Cleaning up... 18:57:42 INFO - Return code: 0 18:57:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:57:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:57:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:42 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 0x7f7d76477f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24386d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c7920>, '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 0x24c8820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c8cb0>, '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': 'ed14279e38b05397cf4aa391000001a4-1459821047.534352-1654095597', '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 18:57:42 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 18:57:42 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 18:57:42 INFO - Using env: {'DISPLAY': ':0', 18:57:42 INFO - 'HOME': '/home/cltbld', 18:57:42 INFO - 'LANG': 'en_US.UTF-8', 18:57:42 INFO - 'LANGUAGE': 'en_US:en', 18:57:42 INFO - 'LOGNAME': 'cltbld', 18:57:42 INFO - 'MAIL': '/var/mail/cltbld', 18:57:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:42 INFO - 'MOZ_NO_REMOTE': '1', 18:57:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:42 INFO - 'NO_EM_RESTART': '1', 18:57:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:57:42 INFO - 'PWD': '/builds/slave/test-pgo', 18:57:42 INFO - 'SHELL': '/bin/bash', 18:57:42 INFO - 'SHLVL': '1', 18:57:42 INFO - 'TERM': 'linux', 18:57:42 INFO - 'TMOUT': '86400', 18:57:42 INFO - 'USER': 'cltbld', 18:57:42 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459821047.534352-1654095597', 18:57:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:42 INFO - '_': '/tools/buildbot/bin/python'} 18:57:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:42 INFO - Downloading/unpacking blobuploader==1.2.4 18:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:44 INFO - Downloading blobuploader-1.2.4.tar.gz 18:57:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:57:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:57:44 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 18:57:44 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 18:57:44 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 18:57:44 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 18:57:44 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 18:57:44 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 18:57:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:57:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:57:44 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 18:57:44 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 18:57:44 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 18:57:44 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 18:57:44 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 18:57:44 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 18:57:45 INFO - Downloading docopt-0.6.1.tar.gz 18:57:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:57:45 INFO - Installing collected packages: blobuploader, requests, docopt 18:57:45 INFO - Running setup.py install for blobuploader 18:57:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:57:45 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:57:45 INFO - Running setup.py install for requests 18:57:45 INFO - Running setup.py install for docopt 18:57:45 INFO - Successfully installed blobuploader requests docopt 18:57:45 INFO - Cleaning up... 18:57:45 INFO - Return code: 0 18:57:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:57:45 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')]} 18:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:45 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')]} 18:57:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:45 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 0x7f7d76477f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24386d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c7920>, '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 0x24c8820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c8cb0>, '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': 'ed14279e38b05397cf4aa391000001a4-1459821047.534352-1654095597', '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 18:57:45 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 18:57:45 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 18:57:45 INFO - Using env: {'DISPLAY': ':0', 18:57:45 INFO - 'HOME': '/home/cltbld', 18:57:45 INFO - 'LANG': 'en_US.UTF-8', 18:57:45 INFO - 'LANGUAGE': 'en_US:en', 18:57:45 INFO - 'LOGNAME': 'cltbld', 18:57:45 INFO - 'MAIL': '/var/mail/cltbld', 18:57:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:45 INFO - 'MOZ_NO_REMOTE': '1', 18:57:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:45 INFO - 'NO_EM_RESTART': '1', 18:57:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:57:45 INFO - 'PWD': '/builds/slave/test-pgo', 18:57:45 INFO - 'SHELL': '/bin/bash', 18:57:45 INFO - 'SHLVL': '1', 18:57:45 INFO - 'TERM': 'linux', 18:57:45 INFO - 'TMOUT': '86400', 18:57:45 INFO - 'USER': 'cltbld', 18:57:45 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459821047.534352-1654095597', 18:57:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:45 INFO - '_': '/tools/buildbot/bin/python'} 18:57:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:57:45 INFO - Running setup.py (path:/tmp/pip-lOOtN_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:57:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:57:46 INFO - Running setup.py (path:/tmp/pip-tZQPn9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:57:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:57:46 INFO - Running setup.py (path:/tmp/pip-XZ2X5V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:57:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:57:46 INFO - Running setup.py (path:/tmp/pip-3T1Chy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:57:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:57:46 INFO - Running setup.py (path:/tmp/pip-eoY62K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:57:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:57:46 INFO - Running setup.py (path:/tmp/pip-LDB4le-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:57:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:57:46 INFO - Running setup.py (path:/tmp/pip-7jNu7o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:57:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:57:46 INFO - Running setup.py (path:/tmp/pip-FP_d4Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:57:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:57:46 INFO - Running setup.py (path:/tmp/pip-Chvusy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:57:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:57:46 INFO - Running setup.py (path:/tmp/pip-2HDIPr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:57:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:57:46 INFO - Running setup.py (path:/tmp/pip-sCi2Pp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:57:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:57:46 INFO - Running setup.py (path:/tmp/pip-GCWpZY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:57:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:57:46 INFO - Running setup.py (path:/tmp/pip-YvTDVR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:57:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:57:46 INFO - Running setup.py (path:/tmp/pip-X8d5Yf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:57:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:57:46 INFO - Running setup.py (path:/tmp/pip-y_o2Rb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:57:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:57:47 INFO - Running setup.py (path:/tmp/pip-CFi9iK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:57:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:57:47 INFO - Running setup.py (path:/tmp/pip-Vh4xtI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:57:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:57:47 INFO - Running setup.py install for manifestparser 18:57:47 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:57:47 INFO - Running setup.py install for mozcrash 18:57:47 INFO - Running setup.py install for mozdebug 18:57:47 INFO - Running setup.py install for mozdevice 18:57:47 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:57:47 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:57:47 INFO - Running setup.py install for mozfile 18:57:47 INFO - Running setup.py install for mozhttpd 18:57:47 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:57:47 INFO - Running setup.py install for mozinfo 18:57:47 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:57:47 INFO - Running setup.py install for mozInstall 18:57:47 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:57:47 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:57:47 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:57:47 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:57:47 INFO - Running setup.py install for mozleak 18:57:48 INFO - Running setup.py install for mozlog 18:57:48 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:57:48 INFO - Running setup.py install for moznetwork 18:57:48 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:57:48 INFO - Running setup.py install for mozprocess 18:57:48 INFO - Running setup.py install for mozprofile 18:57:48 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:57:48 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:57:48 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:57:48 INFO - Running setup.py install for mozrunner 18:57:48 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:57:48 INFO - Running setup.py install for mozscreenshot 18:57:48 INFO - Running setup.py install for moztest 18:57:48 INFO - Running setup.py install for mozversion 18:57:48 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:57:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:57:48 INFO - Cleaning up... 18:57:48 INFO - Return code: 0 18:57:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:57: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')]} 18:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57: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')]} 18:57:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57: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 0x7f7d76477f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24386d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c7920>, '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 0x24c8820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c8cb0>, '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': 'ed14279e38b05397cf4aa391000001a4-1459821047.534352-1654095597', '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 18:57: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 18:57: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 18:57:48 INFO - Using env: {'DISPLAY': ':0', 18:57:48 INFO - 'HOME': '/home/cltbld', 18:57:48 INFO - 'LANG': 'en_US.UTF-8', 18:57:48 INFO - 'LANGUAGE': 'en_US:en', 18:57:48 INFO - 'LOGNAME': 'cltbld', 18:57:48 INFO - 'MAIL': '/var/mail/cltbld', 18:57:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:48 INFO - 'MOZ_NO_REMOTE': '1', 18:57:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:48 INFO - 'NO_EM_RESTART': '1', 18:57:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:57:48 INFO - 'PWD': '/builds/slave/test-pgo', 18:57:48 INFO - 'SHELL': '/bin/bash', 18:57:48 INFO - 'SHLVL': '1', 18:57:48 INFO - 'TERM': 'linux', 18:57:48 INFO - 'TMOUT': '86400', 18:57:48 INFO - 'USER': 'cltbld', 18:57:48 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459821047.534352-1654095597', 18:57:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:48 INFO - '_': '/tools/buildbot/bin/python'} 18:57:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:57:49 INFO - Running setup.py (path:/tmp/pip-RQnXm1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:57:49 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)) 18:57:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:57:49 INFO - Running setup.py (path:/tmp/pip-NBZZDC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:57:49 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)) 18:57:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:57:49 INFO - Running setup.py (path:/tmp/pip-J94u16-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:57:49 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)) 18:57:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:57:49 INFO - Running setup.py (path:/tmp/pip-Q4lx3N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:57:49 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)) 18:57:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:57:49 INFO - Running setup.py (path:/tmp/pip-SYU1i0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:57:49 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)) 18:57:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:57:49 INFO - Running setup.py (path:/tmp/pip-USUmN2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:57:49 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)) 18:57:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:57:49 INFO - Running setup.py (path:/tmp/pip-q6xjgH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:57:49 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)) 18:57:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:57:49 INFO - Running setup.py (path:/tmp/pip-IorbQB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:57:49 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)) 18:57:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:57:49 INFO - Running setup.py (path:/tmp/pip-WXsmuQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:57:49 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)) 18:57:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:57:49 INFO - Running setup.py (path:/tmp/pip-Erkemw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:57: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)) 18:57:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:57:49 INFO - Running setup.py (path:/tmp/pip-RPvctS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:57: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)) 18:57:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:57:49 INFO - Running setup.py (path:/tmp/pip-Fm3YUq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:57:50 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)) 18:57:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:57:50 INFO - Running setup.py (path:/tmp/pip-bpiUcH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:57:50 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)) 18:57:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:57:50 INFO - Running setup.py (path:/tmp/pip-nWUmTt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:57:50 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)) 18:57:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:57:50 INFO - Running setup.py (path:/tmp/pip-zzMV4Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:57:50 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)) 18:57:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:57:50 INFO - Running setup.py (path:/tmp/pip-2GuymJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:57:50 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)) 18:57:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:57:50 INFO - Running setup.py (path:/tmp/pip-Zm9XUH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:57:50 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)) 18:57:50 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)) 18:57:50 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)) 18:57:50 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)) 18:57:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:57:50 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)) 18:57:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:57:50 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 18:57:50 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 18:57:50 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 18:57:50 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 18:57:50 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 18:57:50 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 18:57:52 INFO - Downloading blessings-1.6.tar.gz 18:57:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:57:52 INFO - Installing collected packages: blessings 18:57:52 INFO - Running setup.py install for blessings 18:57:52 INFO - Successfully installed blessings 18:57:52 INFO - Cleaning up... 18:57:52 INFO - Return code: 0 18:57:52 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:57:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:57:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:57:52 INFO - Reading from file tmpfile_stdout 18:57:52 INFO - Current package versions: 18:57:52 INFO - argparse == 1.2.1 18:57:52 INFO - blessings == 1.6 18:57:52 INFO - blobuploader == 1.2.4 18:57:52 INFO - docopt == 0.6.1 18:57:52 INFO - manifestparser == 1.1 18:57:52 INFO - mozInstall == 1.12 18:57:52 INFO - mozcrash == 0.17 18:57:52 INFO - mozdebug == 0.1 18:57:52 INFO - mozdevice == 0.48 18:57:52 INFO - mozfile == 1.2 18:57:52 INFO - mozhttpd == 0.7 18:57:52 INFO - mozinfo == 0.9 18:57:52 INFO - mozleak == 0.1 18:57:52 INFO - mozlog == 3.1 18:57:52 INFO - moznetwork == 0.27 18:57:52 INFO - mozprocess == 0.22 18:57:52 INFO - mozprofile == 0.28 18:57:52 INFO - mozrunner == 6.11 18:57:52 INFO - mozscreenshot == 0.1 18:57:52 INFO - mozsystemmonitor == 0.0 18:57:52 INFO - moztest == 0.7 18:57:52 INFO - mozversion == 1.4 18:57:52 INFO - psutil == 3.1.1 18:57:52 INFO - requests == 1.2.3 18:57:52 INFO - wsgiref == 0.1.2 18:57:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:57: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')]} 18:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57: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')]} 18:57:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:52 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 0x7f7d76477f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24386d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c7920>, '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 0x24c8820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c8cb0>, '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': 'ed14279e38b05397cf4aa391000001a4-1459821047.534352-1654095597', '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 18:57:52 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 18:57:52 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 18:57:52 INFO - Using env: {'DISPLAY': ':0', 18:57:52 INFO - 'HOME': '/home/cltbld', 18:57:52 INFO - 'LANG': 'en_US.UTF-8', 18:57:52 INFO - 'LANGUAGE': 'en_US:en', 18:57:52 INFO - 'LOGNAME': 'cltbld', 18:57:52 INFO - 'MAIL': '/var/mail/cltbld', 18:57:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:52 INFO - 'MOZ_NO_REMOTE': '1', 18:57:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:52 INFO - 'NO_EM_RESTART': '1', 18:57:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:57:52 INFO - 'PWD': '/builds/slave/test-pgo', 18:57:52 INFO - 'SHELL': '/bin/bash', 18:57:52 INFO - 'SHLVL': '1', 18:57:52 INFO - 'TERM': 'linux', 18:57:52 INFO - 'TMOUT': '86400', 18:57:52 INFO - 'USER': 'cltbld', 18:57:52 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459821047.534352-1654095597', 18:57:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:52 INFO - '_': '/tools/buildbot/bin/python'} 18:57:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57: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)) 18:57: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)) 18:57: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)) 18:57: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)) 18:57: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)) 18:57: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)) 18:57: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)) 18:57: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)) 18:57: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)) 18:57: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)) 18:57: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)) 18:57:52 INFO - Cleaning up... 18:57:52 INFO - Return code: 0 18:57:52 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 18:57: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')]} 18:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57: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')]} 18:57:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57: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 0x7f7d76477f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24386d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c7920>, '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 0x24c8820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c8cb0>, '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': 'ed14279e38b05397cf4aa391000001a4-1459821047.534352-1654095597', '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 18:57: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 18:57: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 18:57:52 INFO - Using env: {'DISPLAY': ':0', 18:57:52 INFO - 'HOME': '/home/cltbld', 18:57:52 INFO - 'LANG': 'en_US.UTF-8', 18:57:52 INFO - 'LANGUAGE': 'en_US:en', 18:57:52 INFO - 'LOGNAME': 'cltbld', 18:57:52 INFO - 'MAIL': '/var/mail/cltbld', 18:57:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:52 INFO - 'MOZ_NO_REMOTE': '1', 18:57:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:52 INFO - 'NO_EM_RESTART': '1', 18:57:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:57:52 INFO - 'PWD': '/builds/slave/test-pgo', 18:57:52 INFO - 'SHELL': '/bin/bash', 18:57:52 INFO - 'SHLVL': '1', 18:57:52 INFO - 'TERM': 'linux', 18:57:52 INFO - 'TMOUT': '86400', 18:57:52 INFO - 'USER': 'cltbld', 18:57:52 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459821047.534352-1654095597', 18:57:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:52 INFO - '_': '/tools/buildbot/bin/python'} 18:57:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:53 INFO - Downloading/unpacking jsonschema 18:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:57:55 INFO - Downloading/unpacking functools32 (from jsonschema) 18:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:55 INFO - Downloading functools32-3.2.3-2.tar.gz 18:57:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 18:57:55 INFO - warning: no files found matching '*.txt' 18:57:55 INFO - no previously-included directories found matching 'build' 18:57:55 INFO - no previously-included directories found matching 'dist' 18:57:55 INFO - no previously-included directories found matching '.git*' 18:57:55 INFO - Installing collected packages: jsonschema, functools32 18:57:55 INFO - Running setup.py install for functools32 18:57:55 INFO - warning: no files found matching '*.txt' 18:57:55 INFO - no previously-included directories found matching 'build' 18:57:55 INFO - no previously-included directories found matching 'dist' 18:57:55 INFO - no previously-included directories found matching '.git*' 18:57:55 INFO - Successfully installed jsonschema functools32 18:57:55 INFO - Cleaning up... 18:57:55 INFO - Return code: 0 18:57:55 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 18:57:55 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')]} 18:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:55 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')]} 18:57:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:55 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 0x7f7d76477f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24386d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24c7920>, '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 0x24c8820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c8cb0>, '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': 'ed14279e38b05397cf4aa391000001a4-1459821047.534352-1654095597', '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 18:57:55 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 18:57:55 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 18:57:55 INFO - Using env: {'DISPLAY': ':0', 18:57:55 INFO - 'HOME': '/home/cltbld', 18:57:55 INFO - 'LANG': 'en_US.UTF-8', 18:57:55 INFO - 'LANGUAGE': 'en_US:en', 18:57:55 INFO - 'LOGNAME': 'cltbld', 18:57:55 INFO - 'MAIL': '/var/mail/cltbld', 18:57:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:55 INFO - 'MOZ_NO_REMOTE': '1', 18:57:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:55 INFO - 'NO_EM_RESTART': '1', 18:57:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:57:55 INFO - 'PWD': '/builds/slave/test-pgo', 18:57:55 INFO - 'SHELL': '/bin/bash', 18:57:55 INFO - 'SHLVL': '1', 18:57:55 INFO - 'TERM': 'linux', 18:57:55 INFO - 'TMOUT': '86400', 18:57:55 INFO - 'USER': 'cltbld', 18:57:55 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459821047.534352-1654095597', 18:57:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:55 INFO - '_': '/tools/buildbot/bin/python'} 18:57:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:55 INFO - Downloading/unpacking flake8 18:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:57:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:57: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 18:57: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 18:57: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 18:57: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 18:57: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 18:57: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 18:57:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:57:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:57: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 18:57: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 18:57: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 18:57: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 18:57: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 18:57: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 18:57:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:57:58 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 18:57:58 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 18:57:58 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 18:57:58 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 18:57:58 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 18:57:58 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 18:57:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 18:57:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:57:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:57:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:57:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:57:58 INFO - no previously-included directories found matching 'docs/_build' 18:57:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:57:58 INFO - Running setup.py install for pep8 18:57:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:57:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:57:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:57:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:57:58 INFO - no previously-included directories found matching 'docs/_build' 18:57:58 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 18:57:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:57:58 INFO - Cleaning up... 18:57:58 INFO - Return code: 0 18:57:58 INFO - Running post-action listener: _resource_record_post_action 18:57:58 INFO - Running post-action listener: _start_resource_monitoring 18:57:58 INFO - Starting resource monitoring. 18:57:58 INFO - ##### 18:57:58 INFO - ##### Running install step. 18:57:58 INFO - ##### 18:57:58 INFO - Running pre-action listener: _resource_record_pre_action 18:57:58 INFO - Running main action method: install 18:57:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:57:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:57:58 INFO - Reading from file tmpfile_stdout 18:57:58 INFO - Detecting whether we're running mozinstall >=1.0... 18:57:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:57:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:57:58 INFO - Reading from file tmpfile_stdout 18:57:58 INFO - Output received: 18:57:58 INFO - Usage: mozinstall [options] installer 18:57:58 INFO - Options: 18:57:58 INFO - -h, --help show this help message and exit 18:57:58 INFO - -d DEST, --destination=DEST 18:57:58 INFO - Directory to install application into. [default: 18:57:58 INFO - "/builds/slave/test-pgo"] 18:57:58 INFO - --app=APP Application being installed. [default: firefox] 18:57:58 INFO - mkdir: /builds/slave/test-pgo/build/application 18:57:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 18:57:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 18:58:14 INFO - Reading from file tmpfile_stdout 18:58:14 INFO - Output received: 18:58:14 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:58:14 INFO - Running post-action listener: _resource_record_post_action 18:58:14 INFO - ##### 18:58:14 INFO - ##### Running run-tests step. 18:58:14 INFO - ##### 18:58:14 INFO - Running pre-action listener: _resource_record_pre_action 18:58:14 INFO - Running main action method: run_tests 18:58:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:58:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:58:14 INFO - Python 2.7.3 18:58:14 INFO - Return code: 0 18:58:14 INFO - grabbing minidump binary from tooltool 18:58: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')]} 18:58: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 0x24c7920>, '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 0x24c8820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24c8cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:58: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 18:58: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 18:58:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:58:14 INFO - Return code: 0 18:58:14 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:58:14 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:58:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:58:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:58:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:58:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 18:58:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 18:58:15 INFO - Return code: 0 18:58:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QOOfiPNnQsub7A2VqoDgGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 18:58:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QOOfiPNnQsub7A2VqoDgGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:58:15 INFO - Using env: {'DISPLAY': ':0', 18:58:15 INFO - 'HOME': '/home/cltbld', 18:58:15 INFO - 'LANG': 'en_US.UTF-8', 18:58:15 INFO - 'LANGUAGE': 'en_US:en', 18:58:15 INFO - 'LOGNAME': 'cltbld', 18:58:15 INFO - 'MAIL': '/var/mail/cltbld', 18:58:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:58:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:58:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:15 INFO - 'MOZ_NO_REMOTE': '1', 18:58:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:58:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:15 INFO - 'NO_EM_RESTART': '1', 18:58:15 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:58:15 INFO - 'PWD': '/builds/slave/test-pgo', 18:58:15 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:58:15 INFO - 'SHELL': '/bin/bash', 18:58:15 INFO - 'SHLVL': '1', 18:58:15 INFO - 'TERM': 'linux', 18:58:15 INFO - 'TMOUT': '86400', 18:58:15 INFO - 'USER': 'cltbld', 18:58:15 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459821047.534352-1654095597', 18:58:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:15 INFO - '_': '/tools/buildbot/bin/python'} 18:58:15 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QOOfiPNnQsub7A2VqoDgGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:58:15 INFO - mozversion application_buildid: 20160404155841 18:58:15 INFO - mozversion application_changeset: a57a4c6df00d0ffaa35b2abc1e388c691c9eb514 18:58:15 INFO - mozversion application_display_name: FirefoxDeveloperEdition 18:58:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:58:15 INFO - mozversion application_name: Firefox 18:58:15 INFO - mozversion application_remotingname: firefox-dev 18:58:15 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:58:15 INFO - mozversion application_vendor: Mozilla 18:58:15 INFO - mozversion application_version: 47.0a2 18:58:15 INFO - mozversion platform_buildid: 20160404155841 18:58:15 INFO - mozversion platform_changeset: a57a4c6df00d0ffaa35b2abc1e388c691c9eb514 18:58:15 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:58:15 INFO - mozversion platform_version: 47.0a2 18:58:15 INFO - using testdate: 1459821495 18:58:15 INFO - actual date: 1459821495 18:58:15 INFO - starting webserver on 'localhost:41203' 18:58:15 INFO - SUITE-START | Running 2 tests 18:58:15 INFO - TEST-START | dromaeo_css 18:58:15 INFO - operating with platform_type : linux_ 18:58:15 INFO - Initialising browser for dromaeo_css test... 18:58:15 INFO - TEST-INFO | started process 2298 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCi6MHV/profile http://localhost:41203/getInfo.html) 18:58:18 INFO - PROCESS | 2298 | 18:58:18 INFO - PROCESS | 2298 | (process:2448): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:58:19 INFO - PROCESS | 2298 | __metrics Screen width/height:1600/1200 18:58:19 INFO - PROCESS | 2298 | colorDepth:24 18:58:19 INFO - PROCESS | 2298 | Browser inner width/height: 1024/697 18:58:19 INFO - PROCESS | 2298 | __metrics 18:58:20 ERROR - PROCESS | 2298 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 18:58:21 INFO - TEST-INFO | 2298: exit 0 18:58:21 INFO - Browser initialized. 18:58:21 INFO - Running cycle 1/1 for dromaeo_css test... 18:58:21 INFO - TEST-INFO | started process 2517 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCi6MHV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:58:23 INFO - PROCESS | 2517 | 18:58:23 INFO - PROCESS | 2517 | (process:2588): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:58:33 INFO - PROCESS | 2517 | RSS: Main: 151379968 18:58:33 INFO - PROCESS | 2517 | 18:59:22 INFO - PROCESS | 2517 | 1459821562638 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] 19:01:30 INFO - PROCESS | 2517 | Cycle 1(1): loaded http://localhost:41203/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41203/tests/dromaeo/cssquery-ext.html) 19:01:31 INFO - PROCESS | 2517 | RSS: Main: 155045888 19:01:31 INFO - PROCESS | 2517 | 19:04:33 INFO - PROCESS | 2517 | Cycle 1(1): loaded http://localhost:41203/tests/dromaeo/cssquery-ext.html (next: http://localhost:41203/tests/dromaeo/cssquery-jquery.html) 19:04:34 INFO - PROCESS | 2517 | RSS: Main: 153030656 19:04:34 INFO - PROCESS | 2517 | 19:07:35 INFO - PROCESS | 2517 | Cycle 1(1): loaded http://localhost:41203/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41203/tests/dromaeo/cssquery-mootools.html) 19:07:36 INFO - PROCESS | 2517 | RSS: Main: 152854528 19:07:36 INFO - PROCESS | 2517 | 19:10:38 INFO - PROCESS | 2517 | Cycle 1(1): loaded http://localhost:41203/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41203/tests/dromaeo/cssquery-prototype.html) 19:10:38 INFO - PROCESS | 2517 | RSS: Main: 152584192 19:10:38 INFO - PROCESS | 2517 | 19:13:41 INFO - PROCESS | 2517 | Cycle 1(1): loaded http://localhost:41203/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41203/tests/dromaeo/cssquery-yui.html) 19:13:41 INFO - PROCESS | 2517 | RSS: Main: 154468352 19:13:41 INFO - PROCESS | 2517 | 19:16:43 INFO - PROCESS | 2517 | Cycle 1(1): loaded http://localhost:41203/tests/dromaeo/cssquery-yui.html (next: http://localhost:41203/tests/dromaeo/cssquery-dojo.html) 19:16:44 INFO - PROCESS | 2517 | RSS: Main: 155279360 19:16:44 INFO - PROCESS | 2517 | 19:16:44 INFO - PROCESS | 2517 | __start_tp_report 19:16:44 INFO - PROCESS | 2517 | _x_x_mozilla_page_load 19:16:44 INFO - PROCESS | 2517 | _x_x_mozilla_page_load_details 19:16:44 INFO - PROCESS | 2517 | |i|pagename|runs| 19:16:44 INFO - PROCESS | 2517 | |0;dojo.html;3347.9665203347968;3409.607895092064;3426.914327141823;3432.399330117229;3438.312337532494;5507.807226747064;5516.7517461714215;5528.391876893538;5528.419515950827;5563.554915606752;5538.418466061066;5551.250581171541;5587.552995760339;5591.832245032645;5595.160725891118;5023.547880690746;5080.263361812554;5129.333186685725;5154.742262886841;5176.896462070757;5008.449070602231;5075.4163271223915;5103.438621751604;5143.8456846294675;5192.1952097424955;5161.819336323229;5178.326817513718;5225.764840582164;5248.868778280555;5252;5201.8439446816465;5213.661112027706;5215.58275337972;5223.425423203445;5273.367195936512;4966.255061740731;5024.924626130611;5081.5426611605135;5110.514501122388;5112.156494178456;5423.647462914937;5463.617546771728;5481.342238931314;5483.616146869721;5492.203630473559;6075;6081.817545473598;6102.1151932969915;6104.298005729309;6106.084087386883;5923.08192230205;6079.726412311456;6104.38956104386;6136.8772624547255;6137.598912956614;5667;5680.11958146488;5681.147827825818;5699.74351154199;5704.914426283609;6155.569110162335;6186.350433204449;6206.379362063757;6209.441150296495;6240.594361366497;5846.035404158351;5849.415058494202;5896.1450589664255;5907.556933230025;5937.198478205473;6041.667708276087;6053.878922421527;6056;6057.7879774207695;6065.4541091302;5827.825165244964;5992.520598352121;6011.7595296187665;6014.368491308437;6022.5784195105925;5989.341172471025;6020.488258497989;6055.455009049207;6071.544634152457;6094.8171554853425;4579.450465944108;4603.95396046042;4611.2852507861335;4615.584597386184;4635.443746750411;4064.06526498901;4081.428599996003;4132.33882578786;4141.7100802943505;4196.81114349855;5613.7193140342815;5668.773249070074;5736.1682556029145;5746.367899531048;5800.216970708984;5990.221271234799;6001.339852616209;6009.819705408845;6010.579259451883;6023.518118550505;5565.526930210977;5685.431456854281;5698.857528561736;5700;5813.3895940925595;5161.148410512224;5238.1618940969265;5255.39562950258;5262;5266.262723218752;6193.938060619336;6246.3441338659695;6254.061890716338;6266.342034086447;6276.968615156895;5921;6024.3674414187635;6085.939140608537;6093.025115981422;6122.9471041527795;6210.503159747119;6241.594296370903;6258.186435763321;6276.905846412216;6290.150829637941;5999.970000149971;6024.759009639565;6026.367231440811;6035.426634469718;6039.48664363534;5879.059350503899;5980.37206093354;6062.484688801324;6107.511399088151;6131.110988906673;5906.202662640489;5955.612885162451;5960.493358064613;5973.5519836013345;5987.461128498282;5901.852453688693;5936.376680448663;5957.463828255304;5977.252843394575;5995.910061348996;5671.234383358194;5763.308402991668;5880.470757631833;5900.9673307170215;5904.409559044061;6028.608140471031;6032.426919442646;6036.336003039574;6041.456268935817;6043.939560604514;5894.587378883437;5899.970500147472;5912.526997840077;5913.231279933581;5914.408559144051 19:16:44 INFO - PROCESS | 2517 | |1;ext.html;524.2817340243864;544.5262621519274;560.8709996700759;598.3537779198467;610.6885488400915;39708;39779;39959.80020099896;39983.400248996215;39988.800055999716;43508.34737478932;44045.55954440455;44066.559334406644;44083.77958110205;44123;8929.062448442917;9033.774155646095;9137.131972462605;9143.451392916446;9165.358424910259;8975.461472311683;9069.59186836594;9070.319726020542;9089.454632722025;9106.225970792491;9230.169284764403;9277;9310.72067837966;9312.674056408026;9330.720078397659;9170.633174673005;9187.494687792168;9212.355135140542;9263.722088337361;9271;9114.77213069672;9231.492267925261;9293.163615274658;9296.442213467213;9303.860442093373;43681;44100.3384949226;44248.3362749559;44263;44327.77836110799;3059.265776213715;3669.559652841676;3799.4680744695765;3823.445600387928;3877.9030524236837;30084.84957575198;30137.397252054838;30302;30552.8472357639;30854.84572577123;3902.765834049966;3905.921881562353;3922.4900762900925;3943.64507194351;4084.7344922579937;198955;199143;199848.00075999674;200172;200412;46223.76888115605;63243;63395;63415.365846340945;63612.36387636157;45318;45394.54605453969;45529.317060244124;45553.77223113929;45661.77169114133;14535.78196327056;14745.557633271019;14768.483103091341;14772.48296309624;14829.851701483063;11200.047995920275;11266.098712103012;11277.097832173406;11319.660410187707;11346.432678366215;15288.38846446152;15464.768028479582;15733.056016639039;15878.60303492422;15897.125658088686;6218.378162183836;6348.793729191439;6369.33122022181;6443.387878151661;6445.291017988017;1068.086785798147;1109.4397329348628;1139.7720455908852;1147.7647082348265;1161.79668558002;30017.549736753965;30163.396732065237;30249.848750756544;30883;31035;1121.960731374398;1134.6028889888637;1151.614209239914;1167.0197034491068;1181.0492553494519;15174.317155728018;15257.847421525865;15309.387624495119;15605.68788624221;15826.92086539583;326793;768127;835562;841549;844611;61070.38929610647;61180.69409652923;61572.38427615756;61756.38243617596;61831.381686183464;1460.4085345434903;1463.6926245488353;1465.5163795947312;1467.992660036693;1470.117929242446;30201.546976795806;30968.225794355323;31222.734700200635;31730.841345793124;31930.68069319277;50340.49659503358;50753.746231268604;50949.23576146286;50951.490485096154;50963;323515;326978;327365.3631731826;329074;329297;34847.47728784121;48402.5159748398;48757.756211218715;48795.5120448791;49069;43817.78091109652;43866.78066609646;43875.56124438715;44497;44640;39546.80226598849;39993;40387.3941890866;40475.3928691064;40801;39325.01687457837;39470.40794388029;40064.3990340151;40125.598744013354;40320;38328.2334353317;38751.80624096862;39021.2195756089;39323;39351.80324098361;34576.654233457346;34810.12974675653;35007.299854003286;35203.82398088096;35212.11969700778;27234.5914811274;27292.181234562995;27528.724712753417;27702.722972770014;27731.44537109287 19:16:44 INFO - PROCESS | 2517 | |2;jquery.html;381.43421255745164;382.38436117850273;388.5143570536829;395.2963724570266;398.71491883303435;17430.734004579404;19002.80997190028;19458.708119378203;19867.701984470226;19886.403407897786;18222.544436389064;18483.168257428413;18515;18823.71764423535;18878.811211887878;5597.888042239153;5794.39158888317;5796.855078623047;5800.129980502916;5835.387284335147;5299.629025968165;5502.889942201154;5542.528885044756;5546.91679624806;5550.69471179085;5381.865453363677;5512.007838589052;5532;5792.420757924216;5817.709114544277;5741.196232527408;5748.338941021794;5757.337906140785;5769.1923130761725;5821.359650438449;5492.890142197134;5511.58663100265;5540.307461567304;5563.499285064323;5648.717564121777;14405.927970360186;14678.339474723556;18878;21994.230201943014;22284.220052298253;2416.7099948006176;2459.963100553493;2517.446161844391;2589.3656054266635;2845.5447128459346;10247.84628230577;10404.843927341097;10473.581056757721;10551.947240263826;10710.625128120557;1945.3774792066545;1951.5023668964466;1967.7245185674017;2011.3764732932837;2046.5804510075548;68958.31041689619;68982;69881.95177072348;70289.94565081528;72780;10368.274220804471;10605;10818.67543973682;10850.728731781768;10895.07391871684;15387.38450461969;15400.07599544031;15527.456539021307;15531.689366212839;15596.610084747745;7561;7571;7625.580593067323;7676.309132178131;7779.338756205786;6979.546329488567;7053;7069.469789765788;7151.89272160918;7165.176004759415;4584.839530616412;4679.859604211879;4710.411198600175;4808.206645903387;4941.876453088702;1993.880367177974;2031.796820317986;2048.5083579940706;2059.1454546363393;2087.4259578615697;984.837501812193;986.6102889358663;1020.7601213714771;1041.5209003858158;1055.4933631856752;16749.07880066608;16862.915685421496;16925.069121198205;17242;17501.124943753017;985.3152059318704;1019.9949000254951;1031.7111208861531;1063.5161001744189;1075.3762817565794;9601.423914565148;9934.701958941243;9942.652007179713;9967.601295948225;10023.34848234877;428743;429099;432628;436508;437579;77210.61394693103;77925;79138;79894;80481.59759201284;1050.3592808386877;1050.6847945616285;1060.5174645536417;1064.1752641702587;1068.385678235018;15618.765718514003;15635.76546351783;15675.921620391826;15708.293126809549;15710.450134245246;34813.82593087018;34950.47574286337;35528;35902.64097358993;36994.26011479701;49760.50239497703;50213.49786502088;50414.24378634397;50479.49520504895;50759.49240507548;8335;8338.958305208678;8503.489790612583;8522.27560657351;8578.056413794602;11442.256253343507;11898.464569094238;11978.64064078079;12138.635840924786;12329.568465103679;10391.272610917164;10969.23215374916;11023.379002708223;11082.279651822606;11182.776344473228;10928.781424371628;10952.561897524329;11159.051480624237;11163.553457861595;11167.832482512606;11134.164937629872;11233.49449274801;11504.94247528757;11520.539178433104;11799;7743.5353878767455;8073.39449541275;8113.675452982051;8448.23965843077;8473.533955632252;9953.353032052893;10510;10735.355878647306;11004.174686898354;11205.60780372683 19:16:44 INFO - PROCESS | 2517 | |3;mootools.html;1521.4446726944666;1533.4019732304403;1737.7480265361523;1864.7482589850365;1881.39795265515;7317.012203352546;7958.3633309335255;8139.552324622144;8299.460535065216;8314.085450600436;8310.667573297076;8325.375596830247;8328.08391076981;8387.329013678906;8397.664093436271;2404.0504000919627;2425.854448733082;2436.5857804173334;2437.098273638756;2437.6465412515176;2435.1355268879556;2443.3402981195068;2473.6413220083077;2498.6626805381225;2499.0628514307136;2475.665785119004;2478.6405971134263;2479.6404521344393;2481.416867036254;2483.2301986384277;2458.188797696756;2486.825922185448;2497.275790020901;2499.7750202481866;2501.537215615099;2444.2545023767743;2467.111839737693;2472.1718224394667;2473.6042233242774;2512.3091149933916;8488.83022339556;8490.490570565724;8530.189631984951;8535.189157030072;8563.571821408905;5236.293100431431;5380.650257733235;5392.514673679388;5395.406505284415;5397.62216644835;3203.343314620497;3220.1949512621845;3232.773705840592;3332.150301673082;3394.8811791587177;1069.6844430892904;1155.5089087138017;1161.5353858456685;1161.790877642024;1166.1370585766472;11830.88169118315;11831.290122592585;11894.167408281424;11971.401429928555;11995.88004119965;4718.363020992122;4758.405199350082;4761.857144285607;4812.951870481251;4954.504549545089;10047.899521004696;10101.242406819518;10106.242031847642;10111.292209545409;10134.23993200513;5317.8936421271355;5322.973385133049;5343.946560534423;5348;5353.518183363438;4747.762611869462;4767.928481072787;4899.314096026559;4922.507749225048;4940.1601727706375;3614.150674591469;3657.6708096271464;3666.944995825065;3696.242270334575;3786.450964610116;1070.2080460459204;1091.841682955967;1112.8608923884515;1116.3971455413985;1118.4687273545164;1413.0603148906068;1422.2604245792131;1429.492530151802;1447.370393878645;1458.9927050364893;8151.959240203761;8195.344372450309;8241.917580824234;8251.711190108317;8263.173682631808;527.1433919880195;527.7862465701397;550.3093617510079;551.9779208831602;556.5742207211487;6145.26256849172;6146.231721034871;6164.753409863645;6180.196574445294;6207.472364848948;10029.197664186848;10301.227407944434;10312.02035806597;10348.896511034944;10395.896041039492;9619.422834629944;10185.439800811026;10277.075063244194;10295.742606434898;10306.278560500694;7902.4863383879865;8039.83920321602;8040.959795200986;8041.47730397534;8145.389095817837;7837.451378403457;7883.802904927194;7948.960255198687;7991.960040199994;8066.23370779775;9028.18746312835;9077.546122693706;9091.54542272897;9107.908920910706;9155.267578593563;9327.906720932704;9399.06009399082;9436.811263774549;9583.472908990072;9826.5086745661;6592.80221593353;6890.724371025103;7021.4031807294905;7473.701051957861;7581.279778421042;7830.72592459284;7860.135385107519;7862.174471680391;7898.131205567268;7906.881396779168;7014.158301003912;7131.2155662876;7152.642367881481;7153.856922861618;7267.527610705287;7009.193942696451;7109.21798602143;7148.17795953472;7171.211166771546;7248.89126663111;7600.125985511516;7619.31426171625;7635.503692259986;7652.426068044808;7685.654145563351;7019.859602807813;7052.365287123978;7088.291170882871;7096.7516136934955;7101.396381307647;6923.688434020582;7067.964660176872;7223.747168849065;7231.9276807233355;7263.927360726537 19:16:44 INFO - PROCESS | 2517 | |4;prototype.html;364.13154626216465;365.4992660055724;371.3612586351476;375.18210301542643;378.32091395944275;6388.64862432566;6390.073439351291;6390.4568111710505;6425.9678701606545;6438.967805160979;6336.778212762554;6337.873242535158;6344.429001389874;6345.777897773579;6352.174217351738;4727.243641017438;4824.951750482503;4873.5613794758465;4876.0247950409885;4878.048780487807;4838.87902802431;4852.830150944717;4859.781309841065;4869.074875773609;4870.853874383774;4812.639052071091;4816.710997340171;4824.44518880328;4827.662063655545;4831.565159135677;4815.855524334275;4821.831235906744;4830.444498882638;4831.565159135659;4838.250071238964;4226;4230.450041494617;4235.470566179228;4237.745735255895;4245.066085461193;5881.558883083786;5955.642661440327;5992.460678538952;5999.160117583542;6005.369436209179;5599.188117722907;5626.071698169797;5627.943720562783;5629.8592535186535;5629.915551266693;6618.735250589971;6638;6681.899771503383;6685.364890335411;6687.866242675168;4634.351190833286;4638.930416043762;4640.955784948394;4648.930266046012;4659.510751371091;6888.345607167311;6890.276520965327;6907.792766217021;6937.340952609494;6959.164900212007;4671.696339737974;4784.712917224978;4794.208955522369;4794.520547945247;4797.208460603962;4830.9275360869615;4859;4861.854144375674;4863.319135321058;4866.197077482176;5576.749046292926;5614.747336369873;5616.382197958222;5620.690862002547;5622.100463925753;6705.195376554747;6752.155980502437;6761.256261811197;6762.019507171432;6764.864702706017;1701.574606348413;1707.7011522983428;1722.4143791111082;1726.5165753589015;1726.7927848658242;1106.7122548137543;1140.914431417647;1143.3540049871797;1144.2219290882113;1150.4132892225025;6512.316206798313;6515.51133664977;6522.119513865662;6541.509386795914;6547.345265473415;6809.727610895508;6933.0986971693355;6934.653267336613;6936.375726184567;6945.340192681687;6468.708908099147;6523.054157147282;6605.24039735427;6606.108175396356;6617.205935287796;3718.888433347004;3757.1734218471893;3761.3417651911354;3778.5843557208686;3799.829007694605;7227.530210536298;7232.240614735482;7242.855142897112;7243.5653860768525;7249.673764680497;7098.183708873546;7132.536385135053;7160.785176444715;7165.964170179116;7178.856422871513;7064.858702825914;7245.529040612343;7301.634918254066;7309.5248808827255;7313.890291645736;6975.407090397373;7033.507654464139;7035.5426897253565;7078;7102;6891.173059232924;6898.275681053417;6918.238993710788;6920.238773734985;6923.89614155778;7153.463490238149;7162.570245785269;7164.068671072727;7170.713171473291;7182.784516464514;4688.578027977362;4796.784144713426;4800.879978000578;4827.25177597473;4827.903441931212;6937.306269373023;6981.3367730065565;6981.406580440719;6984.126984126984;7001.334873187243;6753.86492270142;6757.695903684445;6771.221309549464;6772.221194562689;6777.830554236183;6714.966425167843;6751.291114432914;6772.661366931535;6778.356056174655;6779.18649762012;6497.285298617054;6672.332766723289;6691.732330706717;6742.42689371409;6766.391024807791;6784.694688739118;6803.217629972616;6827.761028363983;6847.691853866688;6857.931420685929;6695.196576410667;6696.531242812956;6697.330266973264;6697.799066028027;6739.73041078371 19:16:44 INFO - PROCESS | 2517 | |5;yui.html;771.4628428654619;787.7085478373003;823.8228780812124;865.8311629232294;901.1394118616721;13401.46394144233;13488.19070855748;13578.049536532446;13684.726305473885;13708.657283567904;13440.462381504729;14355.64110897228;14367.066140700847;14468.348924298405;14502.92748536256;897.5063714956764;905.5698543191997;907.3603109807569;909.7862002429457;910.6767097680328;910.4901255297054;917.1424717888796;920.5627327019679;920.5949382271779;920.7145784806731;970.8398114311166;977.0717818072824;977.9511024448749;978.2467500024976;980.0542476510167;958.2956526952685;963.3449254506933;965.8696076029717;965.888922773883;968.4431451915142;709.7870638808337;714.4391652552773;714.5676865496351;715.8353578676933;715.9212486626467;12519.311437870914;12538;12586.937065314614;12594.43325050375;13975.301234938212;11608;11976.520939162423;12409.503619855195;12428.254304741744;12444.440000200013;10746.194035447374;11051.557937682483;11112.11103111749;11196.104311655048;11258.943705281421;3837.9040523986846;3862.7296089273764;3908.745931514471;3936.9015774605864;3979.1245925896255;50328.99342013176;51979.22031169535;52323;52760.73619631877;52823;10931.726706832393;10970.122390208764;11014.118870490342;11265.380404077854;11347.375894325725;19858.801411985696;19893.502662433555;19930.70103948442;19968.600627987358;19978.70031949522;8393.916060839314;8424.53665048416;8429.915700842914;8441.366897482714;8694.304455643532;4576.954230457719;4581.610563102107;4704.458987216514;4720.929186062212;4773.546513081252;3450.1374656335915;3496.667816557423;3516.6307537708685;3522.18989632386;3528.770629909048;641.9550631455753;651.7002178997619;652.6149571752688;661.5137873662854;662.860799232157;545.6180673528546;557.239368262319;635.139386131794;645.8546826963895;657.6054367379534;8825.558722063872;8907.331950103639;9036.954815225881;9038.367314287936;9149.085091490932;557.2338035201598;676.8138761840435;697.7767114523303;711.6699037762972;719.3022767915114;4080.591940805896;4288.378185163134;4308.46144231971;4325.307950727868;4349.043210493686;57862.421375786544;59487;59517.70241148766;59709.402905971256;59947.400525994184;44636.3304550432;52194.47805521896;52419.73790131101;52634;53493.7325313371;43101.56898431038;46737.53262467332;46943.29585056227;47159.29261061087;47196;8122.228388303101;8244.628991695268;8445.577721113797;8530.70142545008;9128.85889263842;36549;38106.809465952494;38116.809415952746;38398.61601384062;38504.807475963564;45292;46244.30633540567;46407.303890441;46892;47769.76115119541;12032;12259.387030648253;12303.200291980993;12393.132480726263;12673.556425525063;11862.644120676394;12856.357182141042;13283;14049.929750351183;14052.929735351257;12774.489020439078;12806;12860.678483037998;12991.805122922975;13041.282729449591;12028.398580071136;12509.687257818627;12586.622401327975;13038.608841734764;13286.468541258628;11490.827637585277;11683.123765717435;11974.401279936143;12188.939055304667;12331.198472099284;10563.788724225626;10996.06533444634;11122.06096079968;11150.498227579616;11247.88752112501;10882.891171088504;11118;11189.888101118884;11265.831012534654;11304.378259195495 19:16:44 INFO - PROCESS | 2517 | __end_tp_report 19:16:44 INFO - PROCESS | 2517 | __start_cc_report 19:16:44 INFO - PROCESS | 2517 | _x_x_mozilla_cycle_collect,334 19:16:44 INFO - PROCESS | 2517 | __end_cc_report 19:16:44 INFO - PROCESS | 2517 | __startTimestamp1459822604064__endTimestamp 19:16:44 INFO - PROCESS | 2517 | 19:16:44 INFO - PROCESS | 2517 | ------- Summary: start ------- 19:16:44 INFO - PROCESS | 2517 | Number of tests: 6 19:16:44 INFO - PROCESS | 2517 | 19:16:44 INFO - PROCESS | 2517 | [#0] dojo.html Cycles:165 Average:5617.75 Median:5894.59 stddev:626.97 (10.6%) stddev-sans-first:603.08 19:16:44 INFO - PROCESS | 2517 | Values: 3348.0 3409.6 3426.9 3432.4 3438.3 5507.8 5516.8 5528.4 5528.4 5563.6 5538.4 5551.3 5587.6 5591.8 5595.2 5023.5 5080.3 5129.3 5154.7 5176.9 5008.4 5075.4 5103.4 5143.8 5192.2 5161.8 5178.3 5225.8 5248.9 5252.0 5201.8 5213.7 5215.6 5223.4 5273.4 4966.3 5024.9 5081.5 5110.5 5112.2 5423.6 5463.6 5481.3 5483.6 5492.2 6075.0 6081.8 6102.1 6104.3 6106.1 5923.1 6079.7 6104.4 6136.9 6137.6 5667.0 5680.1 5681.1 5699.7 5704.9 6155.6 6186.4 6206.4 6209.4 6240.6 5846.0 5849.4 5896.1 5907.6 5937.2 6041.7 6053.9 6056.0 6057.8 6065.5 5827.8 5992.5 6011.8 6014.4 6022.6 5989.3 6020.5 6055.5 6071.5 6094.8 4579.5 4604.0 4611.3 4615.6 4635.4 4064.1 4081.4 4132.3 4141.7 4196.8 5613.7 5668.8 5736.2 5746.4 5800.2 5990.2 6001.3 6009.8 6010.6 6023.5 5565.5 5685.4 5698.9 5700.0 5813.4 5161.1 5238.2 5255.4 5262.0 5266.3 6193.9 6246.3 6254.1 6266.3 6277.0 5921.0 6024.4 6085.9 6093.0 6122.9 6210.5 6241.6 6258.2 6276.9 6290.2 6000.0 6024.8 6026.4 6035.4 6039.5 5879.1 5980.4 6062.5 6107.5 6131.1 5906.2 5955.6 5960.5 5973.6 5987.5 5901.9 5936.4 5957.5 5977.3 5995.9 5671.2 5763.3 5880.5 5901.0 5904.4 6028.6 6032.4 6036.3 6041.5 6043.9 5894.6 5900.0 5912.5 5913.2 5914.4 19:16:44 INFO - PROCESS | 2517 | 19:16:44 INFO - PROCESS | 2517 | [#1] ext.html Cycles:180 Average:57804.78 Median:39869.40 stddev:131863.48 (330.7%) stddev-sans-first:132163.26 19:16:44 INFO - PROCESS | 2517 | Values: 524.3 544.5 560.9 598.4 610.7 39708.0 39779.0 39959.8 39983.4 39988.8 43508.3 44045.6 44066.6 44083.8 44123.0 8929.1 9033.8 9137.1 9143.5 9165.4 8975.5 9069.6 9070.3 9089.5 9106.2 9230.2 9277.0 9310.7 9312.7 9330.7 9170.6 9187.5 9212.4 9263.7 9271.0 9114.8 9231.5 9293.2 9296.4 9303.9 43681.0 44100.3 44248.3 44263.0 44327.8 3059.3 3669.6 3799.5 3823.4 3877.9 30084.8 30137.4 30302.0 30552.8 30854.8 3902.8 3905.9 3922.5 3943.6 4084.7 198955.0 199143.0 199848.0 200172.0 200412.0 46223.8 63243.0 63395.0 63415.4 63612.4 45318.0 45394.5 45529.3 45553.8 45661.8 14535.8 14745.6 14768.5 14772.5 14829.9 11200.0 11266.1 11277.1 11319.7 11346.4 15288.4 15464.8 15733.1 15878.6 15897.1 6218.4 6348.8 6369.3 6443.4 6445.3 1068.1 1109.4 1139.8 1147.8 1161.8 30017.5 30163.4 30249.8 30883.0 31035.0 1122.0 1134.6 1151.6 1167.0 1181.0 15174.3 15257.8 15309.4 15605.7 15826.9 326793.0 768127.0 835562.0 841549.0 844611.0 61070.4 61180.7 61572.4 61756.4 61831.4 1460.4 1463.7 1465.5 1468.0 1470.1 30201.5 30968.2 31222.7 31730.8 31930.7 50340.5 50753.7 50949.2 50951.5 50963.0 323515.0 326978.0 327365.4 329074.0 329297.0 34847.5 48402.5 48757.8 48795.5 49069.0 43817.8 43866.8 43875.6 44497.0 44640.0 39546.8 39993.0 40387.4 40475.4 40801.0 39325.0 39470.4 40064.4 40125.6 40320.0 38328.2 38751.8 39021.2 39323.0 39351.8 34576.7 34810.1 35007.3 35203.8 35212.1 27234.6 27292.2 27528.7 27702.7 27731.4 19:16:44 INFO - PROCESS | 2517 | 19:16:44 INFO - PROCESS | 2517 | [#2] jquery.html Cycles:180 Average:25941.48 Median:2717.46 stddev:71183.29 (2619.5%) stddev-sans-first:71357.11 19:16:44 INFO - PROCESS | 2517 | Values: 381.4 382.4 388.5 395.3 398.7 17430.7 19002.8 19458.7 19867.7 19886.4 18222.5 18483.2 18515.0 18823.7 18878.8 5597.9 5794.4 5796.9 5800.1 5835.4 5299.6 5502.9 5542.5 5546.9 5550.7 5381.9 5512.0 5532.0 5792.4 5817.7 5741.2 5748.3 5757.3 5769.2 5821.4 5492.9 5511.6 5540.3 5563.5 5648.7 14405.9 14678.3 18878.0 21994.2 22284.2 2416.7 2460.0 2517.4 2589.4 2845.5 10247.8 10404.8 10473.6 10551.9 10710.6 1945.4 1951.5 1967.7 2011.4 2046.6 68958.3 68982.0 69882.0 70289.9 72780.0 10368.3 10605.0 10818.7 10850.7 10895.1 15387.4 15400.1 15527.5 15531.7 15596.6 7561.0 7571.0 7625.6 7676.3 7779.3 6979.5 7053.0 7069.5 7151.9 7165.2 4584.8 4679.9 4710.4 4808.2 4941.9 1993.9 2031.8 2048.5 2059.1 2087.4 984.8 986.6 1020.8 1041.5 1055.5 16749.1 16862.9 16925.1 17242.0 17501.1 985.3 1020.0 1031.7 1063.5 1075.4 9601.4 9934.7 9942.7 9967.6 10023.3 428743.0 429099.0 432628.0 436508.0 437579.0 77210.6 77925.0 79138.0 79894.0 80481.6 1050.4 1050.7 1060.5 1064.2 1068.4 15618.8 15635.8 15675.9 15708.3 15710.5 34813.8 34950.5 35528.0 35902.6 36994.3 49760.5 50213.5 50414.2 50479.5 50759.5 8335.0 8339.0 8503.5 8522.3 8578.1 11442.3 11898.5 11978.6 12138.6 12329.6 10391.3 10969.2 11023.4 11082.3 11182.8 10928.8 10952.6 11159.1 11163.6 11167.8 11134.2 11233.5 11504.9 11520.5 11799.0 7743.5 8073.4 8113.7 8448.2 8473.5 9953.4 10510.0 10735.4 11004.2 11205.6 19:16:44 INFO - PROCESS | 2517 | 19:16:44 INFO - PROCESS | 2517 | [#3] mootools.html Cycles:180 Average:5915.99 Median:5350.76 stddev:3108.34 (58.1%) stddev-sans-first:3099.51 19:16:44 INFO - PROCESS | 2517 | Values: 1521.4 1533.4 1737.7 1864.7 1881.4 7317.0 7958.4 8139.6 8299.5 8314.1 8310.7 8325.4 8328.1 8387.3 8397.7 2404.1 2425.9 2436.6 2437.1 2437.6 2435.1 2443.3 2473.6 2498.7 2499.1 2475.7 2478.6 2479.6 2481.4 2483.2 2458.2 2486.8 2497.3 2499.8 2501.5 2444.3 2467.1 2472.2 2473.6 2512.3 8488.8 8490.5 8530.2 8535.2 8563.6 5236.3 5380.7 5392.5 5395.4 5397.6 3203.3 3220.2 3232.8 3332.2 3394.9 1069.7 1155.5 1161.5 1161.8 1166.1 11830.9 11831.3 11894.2 11971.4 11995.9 4718.4 4758.4 4761.9 4813.0 4954.5 10047.9 10101.2 10106.2 10111.3 10134.2 5317.9 5323.0 5343.9 5348.0 5353.5 4747.8 4767.9 4899.3 4922.5 4940.2 3614.2 3657.7 3666.9 3696.2 3786.5 1070.2 1091.8 1112.9 1116.4 1118.5 1413.1 1422.3 1429.5 1447.4 1459.0 8152.0 8195.3 8241.9 8251.7 8263.2 527.1 527.8 550.3 552.0 556.6 6145.3 6146.2 6164.8 6180.2 6207.5 10029.2 10301.2 10312.0 10348.9 10395.9 9619.4 10185.4 10277.1 10295.7 10306.3 7902.5 8039.8 8041.0 8041.5 8145.4 7837.5 7883.8 7949.0 7992.0 8066.2 9028.2 9077.5 9091.5 9107.9 9155.3 9327.9 9399.1 9436.8 9583.5 9826.5 6592.8 6890.7 7021.4 7473.7 7581.3 7830.7 7860.1 7862.2 7898.1 7906.9 7014.2 7131.2 7152.6 7153.9 7267.5 7009.2 7109.2 7148.2 7171.2 7248.9 7600.1 7619.3 7635.5 7652.4 7685.7 7019.9 7052.4 7088.3 7096.8 7101.4 6923.7 7068.0 7223.7 7231.9 7263.9 19:16:44 INFO - PROCESS | 2517 | 19:16:44 INFO - PROCESS | 2517 | [#4] prototype.html Cycles:180 Average:5649.13 Median:6483.00 stddev:1706.42 (26.3%) stddev-sans-first:1664.47 19:16:44 INFO - PROCESS | 2517 | Values: 364.1 365.5 371.4 375.2 378.3 6388.6 6390.1 6390.5 6426.0 6439.0 6336.8 6337.9 6344.4 6345.8 6352.2 4727.2 4825.0 4873.6 4876.0 4878.0 4838.9 4852.8 4859.8 4869.1 4870.9 4812.6 4816.7 4824.4 4827.7 4831.6 4815.9 4821.8 4830.4 4831.6 4838.3 4226.0 4230.5 4235.5 4237.7 4245.1 5881.6 5955.6 5992.5 5999.2 6005.4 5599.2 5626.1 5627.9 5629.9 5629.9 6618.7 6638.0 6681.9 6685.4 6687.9 4634.4 4638.9 4641.0 4648.9 4659.5 6888.3 6890.3 6907.8 6937.3 6959.2 4671.7 4784.7 4794.2 4794.5 4797.2 4830.9 4859.0 4861.9 4863.3 4866.2 5576.7 5614.7 5616.4 5620.7 5622.1 6705.2 6752.2 6761.3 6762.0 6764.9 1701.6 1707.7 1722.4 1726.5 1726.8 1106.7 1140.9 1143.4 1144.2 1150.4 6512.3 6515.5 6522.1 6541.5 6547.3 6809.7 6933.1 6934.7 6936.4 6945.3 6468.7 6523.1 6605.2 6606.1 6617.2 3718.9 3757.2 3761.3 3778.6 3799.8 7227.5 7232.2 7242.9 7243.6 7249.7 7098.2 7132.5 7160.8 7166.0 7178.9 7064.9 7245.5 7301.6 7309.5 7313.9 6975.4 7033.5 7035.5 7078.0 7102.0 6891.2 6898.3 6918.2 6920.2 6923.9 7153.5 7162.6 7164.1 7170.7 7182.8 4688.6 4796.8 4800.9 4827.3 4827.9 6937.3 6981.3 6981.4 6984.1 7001.3 6753.9 6757.7 6771.2 6772.2 6777.8 6715.0 6751.3 6772.7 6778.4 6779.2 6497.3 6672.3 6691.7 6742.4 6766.4 6784.7 6803.2 6827.8 6847.7 6857.9 6695.2 6696.5 6697.3 6697.8 6739.7 19:16:44 INFO - PROCESS | 2517 | 19:16:44 INFO - PROCESS | 2517 | [#5] yui.html Cycles:180 Average:14522.89 Median:24492.69 stddev:16445.79 (67.1%) stddev-sans-first:16459.50 19:16:44 INFO - PROCESS | 2517 | Values: 771.5 787.7 823.8 865.8 901.1 13401.5 13488.2 13578.0 13684.7 13708.7 13440.5 14355.6 14367.1 14468.3 14502.9 897.5 905.6 907.4 909.8 910.7 910.5 917.1 920.6 920.6 920.7 970.8 977.1 978.0 978.2 980.1 958.3 963.3 965.9 965.9 968.4 709.8 714.4 714.6 715.8 715.9 12519.3 12538.0 12586.9 12594.4 13975.3 11608.0 11976.5 12409.5 12428.3 12444.4 10746.2 11051.6 11112.1 11196.1 11258.9 3837.9 3862.7 3908.7 3936.9 3979.1 50329.0 51979.2 52323.0 52760.7 52823.0 10931.7 10970.1 11014.1 11265.4 11347.4 19858.8 19893.5 19930.7 19968.6 19978.7 8393.9 8424.5 8429.9 8441.4 8694.3 4577.0 4581.6 4704.5 4720.9 4773.5 3450.1 3496.7 3516.6 3522.2 3528.8 642.0 651.7 652.6 661.5 662.9 545.6 557.2 635.1 645.9 657.6 8825.6 8907.3 9037.0 9038.4 9149.1 557.2 676.8 697.8 711.7 719.3 4080.6 4288.4 4308.5 4325.3 4349.0 57862.4 59487.0 59517.7 59709.4 59947.4 44636.3 52194.5 52419.7 52634.0 53493.7 43101.6 46737.5 46943.3 47159.3 47196.0 8122.2 8244.6 8445.6 8530.7 9128.9 36549.0 38106.8 38116.8 38398.6 38504.8 45292.0 46244.3 46407.3 46892.0 47769.8 12032.0 12259.4 12303.2 12393.1 12673.6 11862.6 12856.4 13283.0 14049.9 14052.9 12774.5 12806.0 12860.7 12991.8 13041.3 12028.4 12509.7 12586.6 13038.6 13286.5 11490.8 11683.1 11974.4 12188.9 12331.2 10563.8 10996.1 11122.1 11150.5 11247.9 10882.9 11118.0 11189.9 11265.8 11304.4 19:16:44 INFO - PROCESS | 2517 | -------- Summary: end -------- 19:16:44 INFO - PROCESS | 2517 | 19:16:44 INFO - TEST-INFO | 2517: exit 0 19:16:44 INFO - TEST-OK | dromaeo_css | took 1109316ms 19:16:44 INFO - TEST-START | kraken 19:16:44 INFO - operating with platform_type : linux_ 19:16:44 INFO - Initialising browser for kraken test... 19:16:44 INFO - TEST-INFO | started process 2855 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpR3nBeI/profile http://localhost:41203/getInfo.html) 19:16:48 INFO - PROCESS | 2855 | 19:16:48 INFO - PROCESS | 2855 | (process:2947): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:16:48 INFO - PROCESS | 2855 | __metrics Screen width/height:1600/1200 19:16:48 INFO - PROCESS | 2855 | colorDepth:24 19:16:48 INFO - PROCESS | 2855 | Browser inner width/height: 1024/697 19:16:48 INFO - PROCESS | 2855 | __metrics 19:16:49 ERROR - PROCESS | 2855 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 19:16:50 INFO - TEST-INFO | 2855: exit 0 19:16:50 INFO - Browser initialized. 19:16:50 INFO - Running cycle 1/1 for kraken test... 19:16:50 INFO - TEST-INFO | started process 2998 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpR3nBeI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:16:52 INFO - PROCESS | 2998 | 19:16:52 INFO - PROCESS | 2998 | (process:3063): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:17:02 INFO - PROCESS | 2998 | RSS: Main: 151166976 19:17:02 INFO - PROCESS | 2998 | 19:17:04 INFO - PROCESS | 2998 | Cycle 1(1): loaded http://localhost:41203/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41203/tests/kraken/driver.html?testName=audio-beat-detection) 19:17:05 INFO - PROCESS | 2998 | RSS: Main: 155648000 19:17:05 INFO - PROCESS | 2998 | 19:17:07 INFO - PROCESS | 2998 | Cycle 1(1): loaded http://localhost:41203/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41203/tests/kraken/driver.html?testName=audio-dft) 19:17:08 INFO - PROCESS | 2998 | RSS: Main: 155738112 19:17:08 INFO - PROCESS | 2998 | 19:17:11 INFO - PROCESS | 2998 | Cycle 1(1): loaded http://localhost:41203/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41203/tests/kraken/driver.html?testName=audio-fft) 19:17:11 INFO - PROCESS | 2998 | RSS: Main: 156303360 19:17:11 INFO - PROCESS | 2998 | 19:17:13 INFO - PROCESS | 2998 | Cycle 1(1): loaded http://localhost:41203/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41203/tests/kraken/driver.html?testName=audio-oscillator) 19:17:14 INFO - PROCESS | 2998 | RSS: Main: 156123136 19:17:14 INFO - PROCESS | 2998 | 19:17:16 INFO - PROCESS | 2998 | Cycle 1(1): loaded http://localhost:41203/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41203/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:17:17 INFO - PROCESS | 2998 | RSS: Main: 156250112 19:17:17 INFO - PROCESS | 2998 | 19:17:20 INFO - PROCESS | 2998 | Cycle 1(1): loaded http://localhost:41203/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41203/tests/kraken/driver.html?testName=imaging-darkroom) 19:17:21 INFO - PROCESS | 2998 | RSS: Main: 156348416 19:17:21 INFO - PROCESS | 2998 | 19:17:24 INFO - PROCESS | 2998 | Cycle 1(1): loaded http://localhost:41203/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41203/tests/kraken/driver.html?testName=imaging-desaturate) 19:17:25 INFO - PROCESS | 2998 | RSS: Main: 156274688 19:17:25 INFO - PROCESS | 2998 | 19:17:27 INFO - PROCESS | 2998 | Cycle 1(1): loaded http://localhost:41203/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41203/tests/kraken/driver.html?testName=json-parse-financial) 19:17:28 INFO - PROCESS | 2998 | RSS: Main: 156622848 19:17:28 INFO - PROCESS | 2998 | 19:17:30 INFO - PROCESS | 2998 | Cycle 1(1): loaded http://localhost:41203/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41203/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:17:30 INFO - PROCESS | 2998 | RSS: Main: 156450816 19:17:30 INFO - PROCESS | 2998 | 19:17:32 INFO - PROCESS | 2998 | Cycle 1(1): loaded http://localhost:41203/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41203/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:17:33 INFO - PROCESS | 2998 | RSS: Main: 156360704 19:17:33 INFO - PROCESS | 2998 | 19:17:35 INFO - PROCESS | 2998 | Cycle 1(1): loaded http://localhost:41203/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41203/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:17:35 INFO - PROCESS | 2998 | RSS: Main: 156864512 19:17:35 INFO - PROCESS | 2998 | 19:17:38 INFO - PROCESS | 2998 | Cycle 1(1): loaded http://localhost:41203/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41203/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:17:38 INFO - PROCESS | 2998 | RSS: Main: 157265920 19:17:38 INFO - PROCESS | 2998 | 19:17:41 INFO - PROCESS | 2998 | Cycle 1(1): loaded http://localhost:41203/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41203/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:17:41 INFO - PROCESS | 2998 | RSS: Main: 156958720 19:17:41 INFO - PROCESS | 2998 | 19:17:43 INFO - PROCESS | 2998 | Cycle 1(1): loaded http://localhost:41203/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41203/tests/kraken/driver.html?testName=ai-astar) 19:17:43 INFO - PROCESS | 2998 | RSS: Main: 158806016 19:17:43 INFO - PROCESS | 2998 | 19:17:43 INFO - PROCESS | 2998 | __start_tp_report 19:17:43 INFO - PROCESS | 2998 | _x_x_mozilla_page_load 19:17:43 INFO - PROCESS | 2998 | _x_x_mozilla_page_load_details 19:17:43 INFO - PROCESS | 2998 | |i|pagename|runs| 19:17:43 INFO - PROCESS | 2998 | |0;ai-astar;118;106;110;112;111;122;109;108;112;111 19:17:43 INFO - PROCESS | 2998 | |1;audio-beat-detection;155;136;160;173;136;167;156;133;172;130 19:17:43 INFO - PROCESS | 2998 | |2;audio-dft;162;163;163;164;161;162;163;164;166;163 19:17:43 INFO - PROCESS | 2998 | |3;audio-fft;76;76;73;164;77;76;74;73;160;75 19:17:43 INFO - PROCESS | 2998 | |4;audio-oscillator;94;94;141;93;93;93;148;93;93;142 19:17:43 INFO - PROCESS | 2998 | |5;imaging-gaussian-blur;118;118;118;118;119;116;117;116;117;117 19:17:43 INFO - PROCESS | 2998 | |6;imaging-darkroom;146;146;146;147;147;147;148;147;147;146 19:17:43 INFO - PROCESS | 2998 | |7;imaging-desaturate;96;96;96;97;96;96;97;102;97;97 19:17:43 INFO - PROCESS | 2998 | |8;json-parse-financial;58;57;61;56;57;56;57;65;60;54 19:17:43 INFO - PROCESS | 2998 | |9;json-stringify-tinderbox;65;65;66;64;65;67;66;66;66;67 19:17:43 INFO - PROCESS | 2998 | |10;stanford-crypto-aes;79;77;79;78;86;85;79;78;78;87 19:17:43 INFO - PROCESS | 2998 | |11;stanford-crypto-ccm;113;113;111;113;112;123;122;122;124;114 19:17:43 INFO - PROCESS | 2998 | |12;stanford-crypto-pbkdf2;140;152;152;151;150;139;144;150;148;139 19:17:43 INFO - PROCESS | 2998 | |13;stanford-crypto-sha256-iterative;70;68;69;72;66;66;69;70;70;66 19:17:43 INFO - PROCESS | 2998 | __end_tp_report 19:17:43 INFO - PROCESS | 2998 | __start_cc_report 19:17:43 INFO - PROCESS | 2998 | _x_x_mozilla_cycle_collect,826 19:17:43 INFO - PROCESS | 2998 | __end_cc_report 19:17:43 INFO - PROCESS | 2998 | __startTimestamp1459822663830__endTimestamp 19:17:43 INFO - PROCESS | 2998 | 19:17:43 INFO - PROCESS | 2998 | ------- Summary: start ------- 19:17:43 INFO - PROCESS | 2998 | Number of tests: 14 19:17:43 INFO - PROCESS | 2998 | 19:17:43 INFO - PROCESS | 2998 | [#0] ai-astar Cycles:10 Average:111.90 Median:111.50 stddev:4.75 (4.3%) stddev-sans-first:4.49 19:17:43 INFO - PROCESS | 2998 | Values: 118.0 106.0 110.0 112.0 111.0 122.0 109.0 108.0 112.0 111.0 19:17:43 INFO - PROCESS | 2998 | 19:17:43 INFO - PROCESS | 2998 | [#1] audio-beat-detection Cycles:10 Average:151.80 Median:158.00 stddev:16.71 (10.6%) stddev-sans-first:17.68 19:17:43 INFO - PROCESS | 2998 | Values: 155.0 136.0 160.0 173.0 136.0 167.0 156.0 133.0 172.0 130.0 19:17:43 INFO - PROCESS | 2998 | 19:17:43 INFO - PROCESS | 2998 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:1.37 (0.8%) stddev-sans-first:1.39 19:17:43 INFO - PROCESS | 2998 | Values: 162.0 163.0 163.0 164.0 161.0 162.0 163.0 164.0 166.0 163.0 19:17:43 INFO - PROCESS | 2998 | 19:17:43 INFO - PROCESS | 2998 | [#3] audio-fft Cycles:10 Average:92.40 Median:75.50 stddev:36.72 (48.6%) stddev-sans-first:38.46 19:17:43 INFO - PROCESS | 2998 | Values: 76.0 76.0 73.0 164.0 77.0 76.0 74.0 73.0 160.0 75.0 19:17:43 INFO - PROCESS | 2998 | 19:17:43 INFO - PROCESS | 2998 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:93.00 stddev:24.40 (26.2%) stddev-sans-first:25.32 19:17:43 INFO - PROCESS | 2998 | Values: 94.0 94.0 141.0 93.0 93.0 93.0 148.0 93.0 93.0 142.0 19:17:43 INFO - PROCESS | 2998 | 19:17:43 INFO - PROCESS | 2998 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:118.00 stddev:0.97 (0.8%) stddev-sans-first:1.00 19:17:43 INFO - PROCESS | 2998 | Values: 118.0 118.0 118.0 118.0 119.0 116.0 117.0 116.0 117.0 117.0 19:17:43 INFO - PROCESS | 2998 | 19:17:43 INFO - PROCESS | 2998 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 19:17:43 INFO - PROCESS | 2998 | Values: 146.0 146.0 146.0 147.0 147.0 147.0 148.0 147.0 147.0 146.0 19:17:43 INFO - PROCESS | 2998 | 19:17:43 INFO - PROCESS | 2998 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:96.50 stddev:1.83 (1.9%) stddev-sans-first:1.90 19:17:43 INFO - PROCESS | 2998 | Values: 96.0 96.0 96.0 97.0 96.0 96.0 97.0 102.0 97.0 97.0 19:17:43 INFO - PROCESS | 2998 | 19:17:43 INFO - PROCESS | 2998 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:57.50 stddev:3.14 (5.5%) stddev-sans-first:3.33 19:17:43 INFO - PROCESS | 2998 | Values: 58.0 57.0 61.0 56.0 57.0 56.0 57.0 65.0 60.0 54.0 19:17:43 INFO - PROCESS | 2998 | 19:17:43 INFO - PROCESS | 2998 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.95 (1.4%) stddev-sans-first:0.97 19:17:43 INFO - PROCESS | 2998 | Values: 65.0 65.0 66.0 64.0 65.0 67.0 66.0 66.0 66.0 67.0 19:17:43 INFO - PROCESS | 2998 | 19:17:43 INFO - PROCESS | 2998 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:79.00 stddev:3.81 (4.8%) stddev-sans-first:3.99 19:17:43 INFO - PROCESS | 2998 | Values: 79.0 77.0 79.0 78.0 86.0 85.0 79.0 78.0 78.0 87.0 19:17:43 INFO - PROCESS | 2998 | 19:17:43 INFO - PROCESS | 2998 | [#11] stanford-crypto-ccm Cycles:10 Average:116.70 Median:118.00 stddev:5.29 (4.5%) stddev-sans-first:5.44 19:17:43 INFO - PROCESS | 2998 | Values: 113.0 113.0 111.0 113.0 112.0 123.0 122.0 122.0 124.0 114.0 19:17:43 INFO - PROCESS | 2998 | 19:17:43 INFO - PROCESS | 2998 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.50 Median:150.00 stddev:5.46 (3.6%) stddev-sans-first:5.26 19:17:43 INFO - PROCESS | 2998 | Values: 140.0 152.0 152.0 151.0 150.0 139.0 144.0 150.0 148.0 139.0 19:17:43 INFO - PROCESS | 2998 | 19:17:43 INFO - PROCESS | 2998 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.50 stddev:2.07 (3.0%) stddev-sans-first:2.13 19:17:43 INFO - PROCESS | 2998 | Values: 70.0 68.0 69.0 72.0 66.0 66.0 69.0 70.0 70.0 66.0 19:17:43 INFO - PROCESS | 2998 | -------- Summary: end -------- 19:17:43 INFO - PROCESS | 2998 | 19:17:44 INFO - TEST-INFO | 2998: exit 0 19:17:44 INFO - TEST-OK | kraken | took 60009ms 19:17:44 INFO - SUITE-END | took 1169s 19:17:44 INFO - Completed test suite (00:19:29) 19:17:44 INFO - javascript benchmark 19:17:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3347.9665203347968, 3409.607895092064, 3426.914327141823, 3432.399330117229, 3438.312337532494, 5507.807226747064, 5516.7517461714215, 5528.391876893538, 5528.419515950827, 5563.554915606752, 5538.418466061066, 5551.250581171541, 5587.552995760339, 5591.832245032645, 5595.160725891118, 5023.547880690746, 5080.263361812554, 5129.333186685725, 5154.742262886841, 5176.896462070757, 5008.449070602231, 5075.4163271223915, 5103.438621751604, 5143.8456846294675, 5192.1952097424955, 5161.819336323229, 5178.326817513718, 5225.764840582164, 5248.868778280555, 5252.0, 5201.8439446816465, 5213.661112027706, 5215.58275337972, 5223.425423203445, 5273.367195936512, 4966.255061740731, 5024.924626130611, 5081.5426611605135, 5110.514501122388, 5112.156494178456, 5423.647462914937, 5463.617546771728, 5481.342238931314, 5483.616146869721, 5492.203630473559, 6075.0, 6081.817545473598, 6102.1151932969915, 6104.298005729309, 6106.084087386883, 5923.08192230205, 6079.726412311456, 6104.38956104386, 6136.8772624547255, 6137.598912956614, 5667.0, 5680.11958146488, 5681.147827825818, 5699.74351154199, 5704.914426283609, 6155.569110162335, 6186.350433204449, 6206.379362063757, 6209.441150296495, 6240.594361366497, 5846.035404158351, 5849.415058494202, 5896.1450589664255, 5907.556933230025, 5937.198478205473, 6041.667708276087, 6053.878922421527, 6056.0, 6057.7879774207695, 6065.4541091302, 5827.825165244964, 5992.520598352121, 6011.7595296187665, 6014.368491308437, 6022.5784195105925, 5989.341172471025, 6020.488258497989, 6055.455009049207, 6071.544634152457, 6094.8171554853425, 4579.450465944108, 4603.95396046042, 4611.2852507861335, 4615.584597386184, 4635.443746750411, 4064.06526498901, 4081.428599996003, 4132.33882578786, 4141.7100802943505, 4196.81114349855, 5613.7193140342815, 5668.773249070074, 5736.1682556029145, 5746.367899531048, 5800.216970708984, 5990.221271234799, 6001.339852616209, 6009.819705408845, 6010.579259451883, 6023.518118550505, 5565.526930210977, 5685.431456854281, 5698.857528561736, 5700.0, 5813.3895940925595, 5161.148410512224, 5238.1618940969265, 5255.39562950258, 5262.0, 5266.262723218752, 6193.938060619336, 6246.3441338659695, 6254.061890716338, 6266.342034086447, 6276.968615156895, 5921.0, 6024.3674414187635, 6085.939140608537, 6093.025115981422, 6122.9471041527795, 6210.503159747119, 6241.594296370903, 6258.186435763321, 6276.905846412216, 6290.150829637941, 5999.970000149971, 6024.759009639565, 6026.367231440811, 6035.426634469718, 6039.48664363534, 5879.059350503899, 5980.37206093354, 6062.484688801324, 6107.511399088151, 6131.110988906673, 5906.202662640489, 5955.612885162451, 5960.493358064613, 5973.5519836013345, 5987.461128498282, 5901.852453688693, 5936.376680448663, 5957.463828255304, 5977.252843394575, 5995.910061348996, 5671.234383358194, 5763.308402991668, 5880.470757631833, 5900.9673307170215, 5904.409559044061, 6028.608140471031, 6032.426919442646, 6036.336003039574, 6041.456268935817, 6043.939560604514, 5894.587378883437, 5899.970500147472, 5912.526997840077, 5913.231279933581, 5914.408559144051], "unit": "score", "name": "dojo.html", "value": 5576.942195295034}, {"lowerIsBetter": false, "replicates": [524.2817340243864, 544.5262621519274, 560.8709996700759, 598.3537779198467, 610.6885488400915, 39708.0, 39779.0, 39959.80020099896, 39983.400248996215, 39988.800055999716, 43508.34737478932, 44045.55954440455, 44066.559334406644, 44083.77958110205, 44123.0, 8929.062448442917, 9033.774155646095, 9137.131972462605, 9143.451392916446, 9165.358424910259, 8975.461472311683, 9069.59186836594, 9070.319726020542, 9089.454632722025, 9106.225970792491, 9230.169284764403, 9277.0, 9310.72067837966, 9312.674056408026, 9330.720078397659, 9170.633174673005, 9187.494687792168, 9212.355135140542, 9263.722088337361, 9271.0, 9114.77213069672, 9231.492267925261, 9293.163615274658, 9296.442213467213, 9303.860442093373, 43681.0, 44100.3384949226, 44248.3362749559, 44263.0, 44327.77836110799, 3059.265776213715, 3669.559652841676, 3799.4680744695765, 3823.445600387928, 3877.9030524236837, 30084.84957575198, 30137.397252054838, 30302.0, 30552.8472357639, 30854.84572577123, 3902.765834049966, 3905.921881562353, 3922.4900762900925, 3943.64507194351, 4084.7344922579937, 198955.0, 199143.0, 199848.00075999674, 200172.0, 200412.0, 46223.76888115605, 63243.0, 63395.0, 63415.365846340945, 63612.36387636157, 45318.0, 45394.54605453969, 45529.317060244124, 45553.77223113929, 45661.77169114133, 14535.78196327056, 14745.557633271019, 14768.483103091341, 14772.48296309624, 14829.851701483063, 11200.047995920275, 11266.098712103012, 11277.097832173406, 11319.660410187707, 11346.432678366215, 15288.38846446152, 15464.768028479582, 15733.056016639039, 15878.60303492422, 15897.125658088686, 6218.378162183836, 6348.793729191439, 6369.33122022181, 6443.387878151661, 6445.291017988017, 1068.086785798147, 1109.4397329348628, 1139.7720455908852, 1147.7647082348265, 1161.79668558002, 30017.549736753965, 30163.396732065237, 30249.848750756544, 30883.0, 31035.0, 1121.960731374398, 1134.6028889888637, 1151.614209239914, 1167.0197034491068, 1181.0492553494519, 15174.317155728018, 15257.847421525865, 15309.387624495119, 15605.68788624221, 15826.92086539583, 326793.0, 768127.0, 835562.0, 841549.0, 844611.0, 61070.38929610647, 61180.69409652923, 61572.38427615756, 61756.38243617596, 61831.381686183464, 1460.4085345434903, 1463.6926245488353, 1465.5163795947312, 1467.992660036693, 1470.117929242446, 30201.546976795806, 30968.225794355323, 31222.734700200635, 31730.841345793124, 31930.68069319277, 50340.49659503358, 50753.746231268604, 50949.23576146286, 50951.490485096154, 50963.0, 323515.0, 326978.0, 327365.3631731826, 329074.0, 329297.0, 34847.47728784121, 48402.5159748398, 48757.756211218715, 48795.5120448791, 49069.0, 43817.78091109652, 43866.78066609646, 43875.56124438715, 44497.0, 44640.0, 39546.80226598849, 39993.0, 40387.3941890866, 40475.3928691064, 40801.0, 39325.01687457837, 39470.40794388029, 40064.3990340151, 40125.598744013354, 40320.0, 38328.2334353317, 38751.80624096862, 39021.2195756089, 39323.0, 39351.80324098361, 34576.654233457346, 34810.12974675653, 35007.299854003286, 35203.82398088096, 35212.11969700778, 27234.5914811274, 27292.181234562995, 27528.724712753417, 27702.722972770014, 27731.44537109287], "unit": "score", "name": "ext.html", "value": 19517.72833978533}, {"lowerIsBetter": false, "replicates": [381.43421255745164, 382.38436117850273, 388.5143570536829, 395.2963724570266, 398.71491883303435, 17430.734004579404, 19002.80997190028, 19458.708119378203, 19867.701984470226, 19886.403407897786, 18222.544436389064, 18483.168257428413, 18515.0, 18823.71764423535, 18878.811211887878, 5597.888042239153, 5794.39158888317, 5796.855078623047, 5800.129980502916, 5835.387284335147, 5299.629025968165, 5502.889942201154, 5542.528885044756, 5546.91679624806, 5550.69471179085, 5381.865453363677, 5512.007838589052, 5532.0, 5792.420757924216, 5817.709114544277, 5741.196232527408, 5748.338941021794, 5757.337906140785, 5769.1923130761725, 5821.359650438449, 5492.890142197134, 5511.58663100265, 5540.307461567304, 5563.499285064323, 5648.717564121777, 14405.927970360186, 14678.339474723556, 18878.0, 21994.230201943014, 22284.220052298253, 2416.7099948006176, 2459.963100553493, 2517.446161844391, 2589.3656054266635, 2845.5447128459346, 10247.84628230577, 10404.843927341097, 10473.581056757721, 10551.947240263826, 10710.625128120557, 1945.3774792066545, 1951.5023668964466, 1967.7245185674017, 2011.3764732932837, 2046.5804510075548, 68958.31041689619, 68982.0, 69881.95177072348, 70289.94565081528, 72780.0, 10368.274220804471, 10605.0, 10818.67543973682, 10850.728731781768, 10895.07391871684, 15387.38450461969, 15400.07599544031, 15527.456539021307, 15531.689366212839, 15596.610084747745, 7561.0, 7571.0, 7625.580593067323, 7676.309132178131, 7779.338756205786, 6979.546329488567, 7053.0, 7069.469789765788, 7151.89272160918, 7165.176004759415, 4584.839530616412, 4679.859604211879, 4710.411198600175, 4808.206645903387, 4941.876453088702, 1993.880367177974, 2031.796820317986, 2048.5083579940706, 2059.1454546363393, 2087.4259578615697, 984.837501812193, 986.6102889358663, 1020.7601213714771, 1041.5209003858158, 1055.4933631856752, 16749.07880066608, 16862.915685421496, 16925.069121198205, 17242.0, 17501.124943753017, 985.3152059318704, 1019.9949000254951, 1031.7111208861531, 1063.5161001744189, 1075.3762817565794, 9601.423914565148, 9934.701958941243, 9942.652007179713, 9967.601295948225, 10023.34848234877, 428743.0, 429099.0, 432628.0, 436508.0, 437579.0, 77210.61394693103, 77925.0, 79138.0, 79894.0, 80481.59759201284, 1050.3592808386877, 1050.6847945616285, 1060.5174645536417, 1064.1752641702587, 1068.385678235018, 15618.765718514003, 15635.76546351783, 15675.921620391826, 15708.293126809549, 15710.450134245246, 34813.82593087018, 34950.47574286337, 35528.0, 35902.64097358993, 36994.26011479701, 49760.50239497703, 50213.49786502088, 50414.24378634397, 50479.49520504895, 50759.49240507548, 8335.0, 8338.958305208678, 8503.489790612583, 8522.27560657351, 8578.056413794602, 11442.256253343507, 11898.464569094238, 11978.64064078079, 12138.635840924786, 12329.568465103679, 10391.272610917164, 10969.23215374916, 11023.379002708223, 11082.279651822606, 11182.776344473228, 10928.781424371628, 10952.561897524329, 11159.051480624237, 11163.553457861595, 11167.832482512606, 11134.164937629872, 11233.49449274801, 11504.94247528757, 11520.539178433104, 11799.0, 7743.5353878767455, 8073.39449541275, 8113.675452982051, 8448.23965843077, 8473.533955632252, 9953.353032052893, 10510.0, 10735.355878647306, 11004.174686898354, 11205.60780372683], "unit": "score", "name": "jquery.html", "value": 8811.220736127385}, {"lowerIsBetter": false, "replicates": [1521.4446726944666, 1533.4019732304403, 1737.7480265361523, 1864.7482589850365, 1881.39795265515, 7317.012203352546, 7958.3633309335255, 8139.552324622144, 8299.460535065216, 8314.085450600436, 8310.667573297076, 8325.375596830247, 8328.08391076981, 8387.329013678906, 8397.664093436271, 2404.0504000919627, 2425.854448733082, 2436.5857804173334, 2437.098273638756, 2437.6465412515176, 2435.1355268879556, 2443.3402981195068, 2473.6413220083077, 2498.6626805381225, 2499.0628514307136, 2475.665785119004, 2478.6405971134263, 2479.6404521344393, 2481.416867036254, 2483.2301986384277, 2458.188797696756, 2486.825922185448, 2497.275790020901, 2499.7750202481866, 2501.537215615099, 2444.2545023767743, 2467.111839737693, 2472.1718224394667, 2473.6042233242774, 2512.3091149933916, 8488.83022339556, 8490.490570565724, 8530.189631984951, 8535.189157030072, 8563.571821408905, 5236.293100431431, 5380.650257733235, 5392.514673679388, 5395.406505284415, 5397.62216644835, 3203.343314620497, 3220.1949512621845, 3232.773705840592, 3332.150301673082, 3394.8811791587177, 1069.6844430892904, 1155.5089087138017, 1161.5353858456685, 1161.790877642024, 1166.1370585766472, 11830.88169118315, 11831.290122592585, 11894.167408281424, 11971.401429928555, 11995.88004119965, 4718.363020992122, 4758.405199350082, 4761.857144285607, 4812.951870481251, 4954.504549545089, 10047.899521004696, 10101.242406819518, 10106.242031847642, 10111.292209545409, 10134.23993200513, 5317.8936421271355, 5322.973385133049, 5343.946560534423, 5348.0, 5353.518183363438, 4747.762611869462, 4767.928481072787, 4899.314096026559, 4922.507749225048, 4940.1601727706375, 3614.150674591469, 3657.6708096271464, 3666.944995825065, 3696.242270334575, 3786.450964610116, 1070.2080460459204, 1091.841682955967, 1112.8608923884515, 1116.3971455413985, 1118.4687273545164, 1413.0603148906068, 1422.2604245792131, 1429.492530151802, 1447.370393878645, 1458.9927050364893, 8151.959240203761, 8195.344372450309, 8241.917580824234, 8251.711190108317, 8263.173682631808, 527.1433919880195, 527.7862465701397, 550.3093617510079, 551.9779208831602, 556.5742207211487, 6145.26256849172, 6146.231721034871, 6164.753409863645, 6180.196574445294, 6207.472364848948, 10029.197664186848, 10301.227407944434, 10312.02035806597, 10348.896511034944, 10395.896041039492, 9619.422834629944, 10185.439800811026, 10277.075063244194, 10295.742606434898, 10306.278560500694, 7902.4863383879865, 8039.83920321602, 8040.959795200986, 8041.47730397534, 8145.389095817837, 7837.451378403457, 7883.802904927194, 7948.960255198687, 7991.960040199994, 8066.23370779775, 9028.18746312835, 9077.546122693706, 9091.54542272897, 9107.908920910706, 9155.267578593563, 9327.906720932704, 9399.06009399082, 9436.811263774549, 9583.472908990072, 9826.5086745661, 6592.80221593353, 6890.724371025103, 7021.4031807294905, 7473.701051957861, 7581.279778421042, 7830.72592459284, 7860.135385107519, 7862.174471680391, 7898.131205567268, 7906.881396779168, 7014.158301003912, 7131.2155662876, 7152.642367881481, 7153.856922861618, 7267.527610705287, 7009.193942696451, 7109.21798602143, 7148.17795953472, 7171.211166771546, 7248.89126663111, 7600.125985511516, 7619.31426171625, 7635.503692259986, 7652.426068044808, 7685.654145563351, 7019.859602807813, 7052.365287123978, 7088.291170882871, 7096.7516136934955, 7101.396381307647, 6923.688434020582, 7067.964660176872, 7223.747168849065, 7231.9276807233355, 7263.927360726537], "unit": "score", "name": "mootools.html", "value": 4772.679818853515}, {"lowerIsBetter": false, "replicates": [364.13154626216465, 365.4992660055724, 371.3612586351476, 375.18210301542643, 378.32091395944275, 6388.64862432566, 6390.073439351291, 6390.4568111710505, 6425.9678701606545, 6438.967805160979, 6336.778212762554, 6337.873242535158, 6344.429001389874, 6345.777897773579, 6352.174217351738, 4727.243641017438, 4824.951750482503, 4873.5613794758465, 4876.0247950409885, 4878.048780487807, 4838.87902802431, 4852.830150944717, 4859.781309841065, 4869.074875773609, 4870.853874383774, 4812.639052071091, 4816.710997340171, 4824.44518880328, 4827.662063655545, 4831.565159135677, 4815.855524334275, 4821.831235906744, 4830.444498882638, 4831.565159135659, 4838.250071238964, 4226.0, 4230.450041494617, 4235.470566179228, 4237.745735255895, 4245.066085461193, 5881.558883083786, 5955.642661440327, 5992.460678538952, 5999.160117583542, 6005.369436209179, 5599.188117722907, 5626.071698169797, 5627.943720562783, 5629.8592535186535, 5629.915551266693, 6618.735250589971, 6638.0, 6681.899771503383, 6685.364890335411, 6687.866242675168, 4634.351190833286, 4638.930416043762, 4640.955784948394, 4648.930266046012, 4659.510751371091, 6888.345607167311, 6890.276520965327, 6907.792766217021, 6937.340952609494, 6959.164900212007, 4671.696339737974, 4784.712917224978, 4794.208955522369, 4794.520547945247, 4797.208460603962, 4830.9275360869615, 4859.0, 4861.854144375674, 4863.319135321058, 4866.197077482176, 5576.749046292926, 5614.747336369873, 5616.382197958222, 5620.690862002547, 5622.100463925753, 6705.195376554747, 6752.155980502437, 6761.256261811197, 6762.019507171432, 6764.864702706017, 1701.574606348413, 1707.7011522983428, 1722.4143791111082, 1726.5165753589015, 1726.7927848658242, 1106.7122548137543, 1140.914431417647, 1143.3540049871797, 1144.2219290882113, 1150.4132892225025, 6512.316206798313, 6515.51133664977, 6522.119513865662, 6541.509386795914, 6547.345265473415, 6809.727610895508, 6933.0986971693355, 6934.653267336613, 6936.375726184567, 6945.340192681687, 6468.708908099147, 6523.054157147282, 6605.24039735427, 6606.108175396356, 6617.205935287796, 3718.888433347004, 3757.1734218471893, 3761.3417651911354, 3778.5843557208686, 3799.829007694605, 7227.530210536298, 7232.240614735482, 7242.855142897112, 7243.5653860768525, 7249.673764680497, 7098.183708873546, 7132.536385135053, 7160.785176444715, 7165.964170179116, 7178.856422871513, 7064.858702825914, 7245.529040612343, 7301.634918254066, 7309.5248808827255, 7313.890291645736, 6975.407090397373, 7033.507654464139, 7035.5426897253565, 7078.0, 7102.0, 6891.173059232924, 6898.275681053417, 6918.238993710788, 6920.238773734985, 6923.89614155778, 7153.463490238149, 7162.570245785269, 7164.068671072727, 7170.713171473291, 7182.784516464514, 4688.578027977362, 4796.784144713426, 4800.879978000578, 4827.25177597473, 4827.903441931212, 6937.306269373023, 6981.3367730065565, 6981.406580440719, 6984.126984126984, 7001.334873187243, 6753.86492270142, 6757.695903684445, 6771.221309549464, 6772.221194562689, 6777.830554236183, 6714.966425167843, 6751.291114432914, 6772.661366931535, 6778.356056174655, 6779.18649762012, 6497.285298617054, 6672.332766723289, 6691.732330706717, 6742.42689371409, 6766.391024807791, 6784.694688739118, 6803.217629972616, 6827.761028363983, 6847.691853866688, 6857.931420685929, 6695.196576410667, 6696.531242812956, 6697.330266973264, 6697.799066028027, 6739.73041078371], "unit": "score", "name": "prototype.html", "value": 5098.0699720702505}, {"lowerIsBetter": false, "replicates": [771.4628428654619, 787.7085478373003, 823.8228780812124, 865.8311629232294, 901.1394118616721, 13401.46394144233, 13488.19070855748, 13578.049536532446, 13684.726305473885, 13708.657283567904, 13440.462381504729, 14355.64110897228, 14367.066140700847, 14468.348924298405, 14502.92748536256, 897.5063714956764, 905.5698543191997, 907.3603109807569, 909.7862002429457, 910.6767097680328, 910.4901255297054, 917.1424717888796, 920.5627327019679, 920.5949382271779, 920.7145784806731, 970.8398114311166, 977.0717818072824, 977.9511024448749, 978.2467500024976, 980.0542476510167, 958.2956526952685, 963.3449254506933, 965.8696076029717, 965.888922773883, 968.4431451915142, 709.7870638808337, 714.4391652552773, 714.5676865496351, 715.8353578676933, 715.9212486626467, 12519.311437870914, 12538.0, 12586.937065314614, 12594.43325050375, 13975.301234938212, 11608.0, 11976.520939162423, 12409.503619855195, 12428.254304741744, 12444.440000200013, 10746.194035447374, 11051.557937682483, 11112.11103111749, 11196.104311655048, 11258.943705281421, 3837.9040523986846, 3862.7296089273764, 3908.745931514471, 3936.9015774605864, 3979.1245925896255, 50328.99342013176, 51979.22031169535, 52323.0, 52760.73619631877, 52823.0, 10931.726706832393, 10970.122390208764, 11014.118870490342, 11265.380404077854, 11347.375894325725, 19858.801411985696, 19893.502662433555, 19930.70103948442, 19968.600627987358, 19978.70031949522, 8393.916060839314, 8424.53665048416, 8429.915700842914, 8441.366897482714, 8694.304455643532, 4576.954230457719, 4581.610563102107, 4704.458987216514, 4720.929186062212, 4773.546513081252, 3450.1374656335915, 3496.667816557423, 3516.6307537708685, 3522.18989632386, 3528.770629909048, 641.9550631455753, 651.7002178997619, 652.6149571752688, 661.5137873662854, 662.860799232157, 545.6180673528546, 557.239368262319, 635.139386131794, 645.8546826963895, 657.6054367379534, 8825.558722063872, 8907.331950103639, 9036.954815225881, 9038.367314287936, 9149.085091490932, 557.2338035201598, 676.8138761840435, 697.7767114523303, 711.6699037762972, 719.3022767915114, 4080.591940805896, 4288.378185163134, 4308.46144231971, 4325.307950727868, 4349.043210493686, 57862.421375786544, 59487.0, 59517.70241148766, 59709.402905971256, 59947.400525994184, 44636.3304550432, 52194.47805521896, 52419.73790131101, 52634.0, 53493.7325313371, 43101.56898431038, 46737.53262467332, 46943.29585056227, 47159.29261061087, 47196.0, 8122.228388303101, 8244.628991695268, 8445.577721113797, 8530.70142545008, 9128.85889263842, 36549.0, 38106.809465952494, 38116.809415952746, 38398.61601384062, 38504.807475963564, 45292.0, 46244.30633540567, 46407.303890441, 46892.0, 47769.76115119541, 12032.0, 12259.387030648253, 12303.200291980993, 12393.132480726263, 12673.556425525063, 11862.644120676394, 12856.357182141042, 13283.0, 14049.929750351183, 14052.929735351257, 12774.489020439078, 12806.0, 12860.678483037998, 12991.805122922975, 13041.282729449591, 12028.398580071136, 12509.687257818627, 12586.622401327975, 13038.608841734764, 13286.468541258628, 11490.827637585277, 11683.123765717435, 11974.401279936143, 12188.939055304667, 12331.198472099284, 10563.788724225626, 10996.06533444634, 11122.06096079968, 11150.498227579616, 11247.88752112501, 10882.891171088504, 11118.0, 11189.888101118884, 11265.831012534654, 11304.378259195495], "unit": "score", "name": "yui.html", "value": 6776.443852393556}], "name": "dromaeo_css", "value": 7353.788366487954}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [118.0, 106.0, 110.0, 112.0, 111.0, 122.0, 109.0, 108.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.9}, {"lowerIsBetter": true, "replicates": [155.0, 136.0, 160.0, 173.0, 136.0, 167.0, 156.0, 133.0, 172.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 151.8}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 163.0, 164.0, 161.0, 162.0, 163.0, 164.0, 166.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.1}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 73.0, 164.0, 77.0, 76.0, 74.0, 73.0, 160.0, 75.0], "unit": "score", "name": "audio-fft", "value": 92.4}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 141.0, 93.0, 93.0, 93.0, 148.0, 93.0, 93.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 108.4}, {"lowerIsBetter": true, "replicates": [118.0, 118.0, 118.0, 118.0, 119.0, 116.0, 117.0, 116.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.4}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 97.0, 102.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 97.0}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 61.0, 56.0, 57.0, 56.0, 57.0, 65.0, 60.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 58.1}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 66.0, 64.0, 65.0, 67.0, 66.0, 66.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.7}, {"lowerIsBetter": true, "replicates": [79.0, 77.0, 79.0, 78.0, 86.0, 85.0, 79.0, 78.0, 78.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.6}, {"lowerIsBetter": true, "replicates": [113.0, 113.0, 111.0, 113.0, 112.0, 123.0, 122.0, 122.0, 124.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.7}, {"lowerIsBetter": true, "replicates": [140.0, 152.0, 152.0, 151.0, 150.0, 139.0, 144.0, 150.0, 148.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.5}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 69.0, 72.0, 66.0, 66.0, 69.0, 70.0, 70.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.6}], "name": "kraken", "value": 1524.8999999999999}]} 19:17:45 INFO - Return code: 0 19:17:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:17:45 ERROR - # TBPL SUCCESS # 19:17:45 INFO - Running post-action listener: _resource_record_post_action 19:17:45 INFO - Running post-run listener: _resource_record_post_run 19:17:46 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 512172032; Read time: 12; Write time: 505852 19:17:46 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 263024640; Read time: 0; Write time: 322476 19:17:46 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 249147392; Read time: 12; Write time: 183376 19:17:46 INFO - Running post-run listener: _upload_blobber_files 19:17:46 INFO - Blob upload gear active. 19:17:46 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:17:46 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 19:17:46 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', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 19:17:46 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 Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 19:17:46 INFO - (blobuploader) - INFO - Open directory for files ... 19:17:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:17:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:17:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:17:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:17:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:17:47 INFO - (blobuploader) - INFO - Done attempting. 19:17:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:17:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:17:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:17:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:17:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:17:48 INFO - (blobuploader) - INFO - Done attempting. 19:17:48 INFO - (blobuploader) - INFO - Iteration through files over. 19:17:48 INFO - Return code: 0 19:17:48 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:17:48 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:17:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/915bbc12dbba02667ff4f6aca7ddca20b2467aa6997df24a987191e7010bc712a5818d0a3fbafe413ec0a4e775766d6e81b7966dbf161c79b095becdc4d67f68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/99d1b6d859025486fe4ded159ea4122bfa05a00a994268a6836e5dfcfa41d075d61f3cc1c920346b6e9804dd8b2856143fdd6e96886e9bf567aa5e1db1efa4ab"} 19:17:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:17:48 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:17:48 INFO - Contents: 19:17:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/915bbc12dbba02667ff4f6aca7ddca20b2467aa6997df24a987191e7010bc712a5818d0a3fbafe413ec0a4e775766d6e81b7966dbf161c79b095becdc4d67f68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/99d1b6d859025486fe4ded159ea4122bfa05a00a994268a6836e5dfcfa41d075d61f3cc1c920346b6e9804dd8b2856143fdd6e96886e9bf567aa5e1db1efa4ab"} 19:17:48 INFO - Running post-run listener: copy_logs_to_upload_dir 19:17:48 INFO - Copying logs to upload dir... 19:17:48 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 19:17:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.414056 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-04-04 19:17:46.956697) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-04 19:17:46.960789) ========= 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=ed14279e38b05397cf4aa391000001a4-1459821047.534352-1654095597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/915bbc12dbba02667ff4f6aca7ddca20b2467aa6997df24a987191e7010bc712a5818d0a3fbafe413ec0a4e775766d6e81b7966dbf161c79b095becdc4d67f68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/99d1b6d859025486fe4ded159ea4122bfa05a00a994268a6836e5dfcfa41d075d61f3cc1c920346b6e9804dd8b2856143fdd6e96886e9bf567aa5e1db1efa4ab"} build_url:https://queue.taskcluster.net/v1/task/QOOfiPNnQsub7A2VqoDgGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011405 build_url: 'https://queue.taskcluster.net/v1/task/QOOfiPNnQsub7A2VqoDgGA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/915bbc12dbba02667ff4f6aca7ddca20b2467aa6997df24a987191e7010bc712a5818d0a3fbafe413ec0a4e775766d6e81b7966dbf161c79b095becdc4d67f68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/99d1b6d859025486fe4ded159ea4122bfa05a00a994268a6836e5dfcfa41d075d61f3cc1c920346b6e9804dd8b2856143fdd6e96886e9bf567aa5e1db1efa4ab"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-04 19:17:46.986216) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 19:17:46.986598) ========= 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=ed14279e38b05397cf4aa391000001a4-1459821047.534352-1654095597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004456 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 19:17:47.071528) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-04 19:17:47.071935) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-04 19:17:47.072316) ========= ========= Total master_lag: 0.27 =========