builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1455336022.37 results: success (0) buildid: 20160212173004 builduid: 3efe686725e649fda931305a658148f6 revision: 5de4c2e4ddd4f04e4694f7a3b20a2432e4e5fa6c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-12 20:00:22.369011) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-12 20:00:22.369640) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-12 20:00:22.369971) ========= 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=0333a256a5e4f052382dd180000001b1-1455335345.413220-2075552826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006263 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-12 20:00:22.412086) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-12 20:00:22.412425) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-12 20:00:22.430657) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 20:00:22.431100) ========= 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=0333a256a5e4f052382dd180000001b1-1455335345.413220-2075552826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004699 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 20:00:22.484420) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-12 20:00:22.484805) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-12 20:00:22.485243) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 20:00:22.485558) ========= 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=0333a256a5e4f052382dd180000001b1-1455335345.413220-2075552826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-12 20:00:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-02-12 20:00:22 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.314143 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 20:00:22.815665) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 20:00:22.815988) ========= 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=0333a256a5e4f052382dd180000001b1-1455335345.413220-2075552826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019244 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 20:00:22.872271) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 20:00:22.872663) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5de4c2e4ddd4f04e4694f7a3b20a2432e4e5fa6c --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 5de4c2e4ddd4f04e4694f7a3b20a2432e4e5fa6c --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=0333a256a5e4f052382dd180000001b1-1455335345.413220-2075552826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-12 20:00:23,082 truncating revision to first 12 chars 2016-02-12 20:00:23,082 Setting DEBUG logging. 2016-02-12 20:00:23,082 attempt 1/10 2016-02-12 20:00:23,082 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5de4c2e4ddd4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-12 20:00:23,335 unpacking tar archive at: fx-team-5de4c2e4ddd4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.530068 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 20:00:23.419086) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-12 20:00:23.419506) ========= echo 5de4c2e4ddd4f04e4694f7a3b20a2432e4e5fa6c in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5de4c2e4ddd4f04e4694f7a3b20a2432e4e5fa6c'] 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=0333a256a5e4f052382dd180000001b1-1455335345.413220-2075552826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 5de4c2e4ddd4f04e4694f7a3b20a2432e4e5fa6c program finished with exit code 0 elapsedTime=0.004279 script_repo_revision: '5de4c2e4ddd4f04e4694f7a3b20a2432e4e5fa6c' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-12 20:00:23.469032) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-12 20:00:23.469373) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-12 20:00:23.483445) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-02-12 20:00:23.483757) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1455335345.413220-2075552826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:00:23 INFO - MultiFileLogger online at 20160212 20:00:23 in /builds/slave/test-pgo 20:00:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:00:23 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 20:00:23 INFO - {'append_to_log': False, 20:00:23 INFO - 'base_work_dir': '/builds/slave/test-pgo', 20:00:23 INFO - 'blob_upload_branch': 'Fx-Team', 20:00:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 20:00:23 INFO - 'branch': 'Fx-Team', 20:00:23 INFO - 'buildbot_json_path': 'buildprops.json', 20:00:23 INFO - 'config_files': ('talos/linux_config.py',), 20:00:23 INFO - 'default_actions': ('clobber', 20:00:23 INFO - 'read-buildbot-config', 20:00:23 INFO - 'download-and-extract', 20:00:23 INFO - 'populate-webroot', 20:00:23 INFO - 'create-virtualenv', 20:00:23 INFO - 'install', 20:00:23 INFO - 'run-tests'), 20:00:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:00:23 INFO - 'download_minidump_stackwalk': True, 20:00:23 INFO - 'download_symbols': 'ondemand', 20:00:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:00:23 INFO - 'tooltool.py': '/tools/tooltool.py', 20:00:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:00:23 INFO - '/tools/misc-python/virtualenv.py')}, 20:00:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:00:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:00:23 INFO - 'installer_path': 'installer.exe', 20:00:23 INFO - 'log_level': 'info', 20:00:23 INFO - 'log_name': 'talos', 20:00:23 INFO - 'log_to_console': True, 20:00:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:00:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:00:23 INFO - 'opt_config_files': (), 20:00:23 INFO - 'pip_index': False, 20:00:23 INFO - 'sps_profile': False, 20:00:23 INFO - 'sps_profile_interval': 0, 20:00:23 INFO - 'suite': 'dromaeojs', 20:00:23 INFO - 'system_bits': '32', 20:00:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:00:23 INFO - 'title': 'talos-linux64-ix-017', 20:00:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:00:23 INFO - 'use_talos_json': True, 20:00:23 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 20:00:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:00:23 INFO - 'work_dir': 'build'} 20:00:23 INFO - ##### 20:00:23 INFO - ##### Running clobber step. 20:00:23 INFO - ##### 20:00:23 INFO - Running pre-action listener: _resource_record_pre_action 20:00:23 INFO - Running main action method: clobber 20:00:23 INFO - rmtree: /builds/slave/test-pgo/build 20:00:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 20:00:24 INFO - Running post-action listener: _resource_record_post_action 20:00:24 INFO - ##### 20:00:24 INFO - ##### Running read-buildbot-config step. 20:00:24 INFO - ##### 20:00:24 INFO - Running pre-action listener: _resource_record_pre_action 20:00:24 INFO - Running main action method: read_buildbot_config 20:00:24 INFO - Using buildbot properties: 20:00:24 INFO - { 20:00:24 INFO - "project": "", 20:00:24 INFO - "product": "firefox", 20:00:24 INFO - "script_repo_revision": "production", 20:00:24 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:00:24 INFO - "repository": "", 20:00:24 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:00:24 INFO - "buildid": "20160212173004", 20:00:24 INFO - "pgo_build": "True", 20:00:24 INFO - "basedir": "/builds/slave/test-pgo", 20:00:24 INFO - "buildnumber": 641, 20:00:24 INFO - "slavename": "talos-linux64-ix-017", 20:00:24 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:00:24 INFO - "platform": "ubuntu64_hw", 20:00:24 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:00:24 INFO - "branch": "fx-team", 20:00:24 INFO - "repo_path": "integration/fx-team", 20:00:24 INFO - "revision": "5de4c2e4ddd4f04e4694f7a3b20a2432e4e5fa6c", 20:00:24 INFO - "stage_platform": "linux64-pgo", 20:00:24 INFO - "builduid": "3efe686725e649fda931305a658148f6", 20:00:24 INFO - "slavebuilddir": "test" 20:00:24 INFO - } 20:00:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/aj-cjXBTSpWlm0oRWAdjEQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 20:00:24 INFO - Running post-action listener: _resource_record_post_action 20:00:24 INFO - ##### 20:00:24 INFO - ##### Running download-and-extract step. 20:00:24 INFO - ##### 20:00:24 INFO - Running pre-action listener: _resource_record_pre_action 20:00:24 INFO - Running main action method: download_and_extract 20:00:24 INFO - mkdir: /builds/slave/test-pgo/build/tests 20:00: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')]} 20:00:24 INFO - https://queue.taskcluster.net/v1/task/aj-cjXBTSpWlm0oRWAdjEQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 20:00:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aj-cjXBTSpWlm0oRWAdjEQ/artifacts/public/build/test_packages.json 20:00:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aj-cjXBTSpWlm0oRWAdjEQ/artifacts/public/build/test_packages.json 20:00:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aj-cjXBTSpWlm0oRWAdjEQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 20:00:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aj-cjXBTSpWlm0oRWAdjEQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 20:00:28 INFO - Downloaded 1448 bytes. 20:00:28 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 20:00:28 INFO - Using the following test package requirements: 20:00:28 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 20:00:28 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:00:28 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:00:28 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:00:28 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:00:28 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:00:28 INFO - u'jsshell-linux-x86_64.zip'], 20:00:28 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:00:28 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:00:28 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 20:00:28 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:00:28 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:00:28 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:00:28 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:00:28 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:00:28 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:00:28 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 20:00:28 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:00:28 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:00:28 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:28 INFO - https://queue.taskcluster.net/v1/task/aj-cjXBTSpWlm0oRWAdjEQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:00:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aj-cjXBTSpWlm0oRWAdjEQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 20:00:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aj-cjXBTSpWlm0oRWAdjEQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 20:00:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aj-cjXBTSpWlm0oRWAdjEQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 20:00:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aj-cjXBTSpWlm0oRWAdjEQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:00:34 INFO - Downloaded 23296083 bytes. 20:00:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 20:00:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 20:00:35 INFO - Return code: 0 20:00:35 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:00:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:35 INFO - https://queue.taskcluster.net/v1/task/aj-cjXBTSpWlm0oRWAdjEQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:00:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aj-cjXBTSpWlm0oRWAdjEQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 20:00:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aj-cjXBTSpWlm0oRWAdjEQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 20:00:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aj-cjXBTSpWlm0oRWAdjEQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 20:00:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aj-cjXBTSpWlm0oRWAdjEQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:00:38 INFO - Downloaded 23296083 bytes. 20:00:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 20:00:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 20:00:39 INFO - Return code: 0 20:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:39 INFO - https://queue.taskcluster.net/v1/task/aj-cjXBTSpWlm0oRWAdjEQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:00:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aj-cjXBTSpWlm0oRWAdjEQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 20:00:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aj-cjXBTSpWlm0oRWAdjEQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 20:00:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aj-cjXBTSpWlm0oRWAdjEQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 20:00:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aj-cjXBTSpWlm0oRWAdjEQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:00:40 INFO - Downloaded 10707070 bytes. 20:00:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 20:00:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 20:00:40 INFO - Return code: 0 20:00: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')]} 20:00:40 INFO - https://queue.taskcluster.net/v1/task/aj-cjXBTSpWlm0oRWAdjEQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:00:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aj-cjXBTSpWlm0oRWAdjEQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 20:00:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aj-cjXBTSpWlm0oRWAdjEQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 20:00:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aj-cjXBTSpWlm0oRWAdjEQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 20:00:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aj-cjXBTSpWlm0oRWAdjEQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:00:42 INFO - Downloaded 56520787 bytes. 20:00:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aj-cjXBTSpWlm0oRWAdjEQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 20:00:42 INFO - mkdir: /builds/slave/test-pgo/properties 20:00:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 20:00:43 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 20:00:43 INFO - Contents: 20:00:43 INFO - build_url:https://queue.taskcluster.net/v1/task/aj-cjXBTSpWlm0oRWAdjEQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 20:00:43 INFO - Running post-action listener: _resource_record_post_action 20:00:43 INFO - Running post-action listener: set_extra_try_arguments 20:00:43 INFO - ##### 20:00:43 INFO - ##### Running populate-webroot step. 20:00:43 INFO - ##### 20:00:43 INFO - Running pre-action listener: _resource_record_pre_action 20:00:43 INFO - Running main action method: populate_webroot 20:00:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:00:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:00:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:00:43 INFO - '--tppagecycles', 20:00:43 INFO - '7'], 20:00:43 INFO - 'tests': ['tsvgm']}}, 20:00:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:00:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:00:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:00:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 20:00:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:00:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:00:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:00:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:43 INFO - 'talos_options': ['--e10s'], 20:00:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:00:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:43 INFO - 'tests': ['damp', 'tps']}, 20:00:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:43 INFO - 'talos_options': ['--e10s'], 20:00:43 INFO - 'tests': ['damp', 'tps']}, 20:00:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:00:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:00:43 INFO - 'other': {'tests': ['a11yr', 20:00:43 INFO - 'ts_paint', 20:00:43 INFO - 'tpaint', 20:00:43 INFO - 'sessionrestore', 20:00:43 INFO - 'sessionrestore_no_auto_restore']}, 20:00:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:00:43 INFO - 'tests': ['a11yr', 20:00:43 INFO - 'ts_paint', 20:00:43 INFO - 'tpaint', 20:00:43 INFO - 'sessionrestore', 20:00:43 INFO - 'sessionrestore_no_auto_restore']}, 20:00:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:00:43 INFO - 'tests': ['a11yr', 20:00:43 INFO - 'ts_paint', 20:00:43 INFO - 'tpaint', 20:00:43 INFO - 'sessionrestore', 20:00:43 INFO - 'sessionrestore_no_auto_restore']}, 20:00:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:00:43 INFO - 'tests': ['a11yr', 20:00:43 INFO - 'ts_paint', 20:00:43 INFO - 'tpaint', 20:00:43 INFO - 'sessionrestore', 20:00:43 INFO - 'sessionrestore_no_auto_restore']}, 20:00:43 INFO - 'other_l64': {'tests': ['a11yr', 20:00:43 INFO - 'ts_paint', 20:00:43 INFO - 'tpaint', 20:00:43 INFO - 'sessionrestore', 20:00:43 INFO - 'sessionrestore_no_auto_restore']}, 20:00:43 INFO - 'other_nol64': {'tests': ['a11yr', 20:00:43 INFO - 'ts_paint', 20:00:43 INFO - 'tpaint', 20:00:43 INFO - 'sessionrestore', 20:00:43 INFO - 'sessionrestore_no_auto_restore']}, 20:00:43 INFO - 'svgr': {'tests': ['tsvgx', 20:00:43 INFO - 'tsvgr_opacity', 20:00:43 INFO - 'tart', 20:00:43 INFO - 'tscrollx', 20:00:43 INFO - 'cart']}, 20:00:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:00:43 INFO - 'tests': ['tsvgx', 20:00:43 INFO - 'tsvgr_opacity', 20:00:43 INFO - 'tart', 20:00:43 INFO - 'tscrollx', 20:00:43 INFO - 'cart']}, 20:00:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:43 INFO - 'tests': ['tp5o']}, 20:00:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:43 INFO - 'talos_options': ['--e10s'], 20:00:43 INFO - 'tests': ['tp5o']}, 20:00:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:43 INFO - 'talos_options': ['--xperf_path', 20:00:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:00:43 INFO - 'tests': ['tp5n']}, 20:00:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:43 INFO - 'talos_options': ['--e10s', 20:00:43 INFO - '--xperf_path', 20:00:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:00:43 INFO - 'tests': ['tp5n']}}, 20:00:43 INFO - 'talos.zip': {'path': '', 20:00:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:00:43 INFO - Running post-action listener: _resource_record_post_action 20:00:43 INFO - ##### 20:00:43 INFO - ##### Running create-virtualenv step. 20:00:43 INFO - ##### 20:00:43 INFO - Running pre-action listener: _resource_record_pre_action 20:00:43 INFO - Running main action method: create_virtualenv 20:00:43 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 20:00:43 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 20:00:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 20:00:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:00:43 INFO - Using real prefix '/usr' 20:00:43 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 20:00:44 INFO - Installing distribute.............................................................................................................................................................................................done. 20:00:46 INFO - Installing pip.................done. 20:00:46 INFO - Return code: 0 20:00:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 20:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:46 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 0x7f172dbecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf3a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc98c0>, '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 0xfca7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcac50>, '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': '0333a256a5e4f052382dd180000001b1-1455335345.413220-2075552826', '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 20:00:46 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 20:00:46 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 20:00:46 INFO - Using env: {'DISPLAY': ':0', 20:00:46 INFO - 'HOME': '/home/cltbld', 20:00:46 INFO - 'LANG': 'en_US.UTF-8', 20:00:46 INFO - 'LANGUAGE': 'en_US:en', 20:00:46 INFO - 'LOGNAME': 'cltbld', 20:00:46 INFO - 'MAIL': '/var/mail/cltbld', 20:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:46 INFO - 'MOZ_NO_REMOTE': '1', 20:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:46 INFO - 'NO_EM_RESTART': '1', 20:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:00:46 INFO - 'PWD': '/builds/slave/test-pgo', 20:00:46 INFO - 'SHELL': '/bin/bash', 20:00:46 INFO - 'SHLVL': '1', 20:00:46 INFO - 'TERM': 'linux', 20:00:46 INFO - 'TMOUT': '86400', 20:00:46 INFO - 'USER': 'cltbld', 20:00:46 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1455335345.413220-2075552826', 20:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:46 INFO - '_': '/tools/buildbot/bin/python'} 20:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:46 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 20:00:46 INFO - Cleaning up... 20:00:46 INFO - Return code: 0 20:00:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 20:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:46 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 0x7f172dbecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf3a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc98c0>, '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 0xfca7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcac50>, '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': '0333a256a5e4f052382dd180000001b1-1455335345.413220-2075552826', '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 20:00:46 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 20:00:46 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 20:00:46 INFO - Using env: {'DISPLAY': ':0', 20:00:46 INFO - 'HOME': '/home/cltbld', 20:00:46 INFO - 'LANG': 'en_US.UTF-8', 20:00:46 INFO - 'LANGUAGE': 'en_US:en', 20:00:46 INFO - 'LOGNAME': 'cltbld', 20:00:46 INFO - 'MAIL': '/var/mail/cltbld', 20:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:46 INFO - 'MOZ_NO_REMOTE': '1', 20:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:46 INFO - 'NO_EM_RESTART': '1', 20:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:00:46 INFO - 'PWD': '/builds/slave/test-pgo', 20:00:46 INFO - 'SHELL': '/bin/bash', 20:00:46 INFO - 'SHLVL': '1', 20:00:46 INFO - 'TERM': 'linux', 20:00:46 INFO - 'TMOUT': '86400', 20:00:46 INFO - 'USER': 'cltbld', 20:00:46 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1455335345.413220-2075552826', 20:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:46 INFO - '_': '/tools/buildbot/bin/python'} 20:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:46 INFO - Downloading/unpacking psutil>=0.7.1 20:00:46 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 20:00:46 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 20:00:46 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 20:00:46 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 20:00:46 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 20:00:46 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 20:00:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 20:00:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:00:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:00:48 INFO - Installing collected packages: psutil 20:00:48 INFO - Running setup.py install for psutil 20:00:48 INFO - building 'psutil._psutil_linux' extension 20:00:48 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 20:00:48 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 20:00:48 INFO - building 'psutil._psutil_posix' extension 20:00:48 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 20:00:49 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 20:00:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:00:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:00:49 INFO - Successfully installed psutil 20:00:49 INFO - Cleaning up... 20:00:49 INFO - Return code: 0 20:00:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 20:00:49 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')]} 20:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:49 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')]} 20:00:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:49 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 0x7f172dbecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf3a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc98c0>, '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 0xfca7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcac50>, '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': '0333a256a5e4f052382dd180000001b1-1455335345.413220-2075552826', '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 20:00:49 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 20:00:49 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 20:00:49 INFO - Using env: {'DISPLAY': ':0', 20:00:49 INFO - 'HOME': '/home/cltbld', 20:00:49 INFO - 'LANG': 'en_US.UTF-8', 20:00:49 INFO - 'LANGUAGE': 'en_US:en', 20:00:49 INFO - 'LOGNAME': 'cltbld', 20:00:49 INFO - 'MAIL': '/var/mail/cltbld', 20:00:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:49 INFO - 'MOZ_NO_REMOTE': '1', 20:00:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:49 INFO - 'NO_EM_RESTART': '1', 20:00:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:00:49 INFO - 'PWD': '/builds/slave/test-pgo', 20:00:49 INFO - 'SHELL': '/bin/bash', 20:00:49 INFO - 'SHLVL': '1', 20:00:49 INFO - 'TERM': 'linux', 20:00:49 INFO - 'TMOUT': '86400', 20:00:49 INFO - 'USER': 'cltbld', 20:00:49 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1455335345.413220-2075552826', 20:00:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:49 INFO - '_': '/tools/buildbot/bin/python'} 20:00:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:00:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:00:51 INFO - Installing collected packages: mozsystemmonitor 20:00:51 INFO - Running setup.py install for mozsystemmonitor 20:00:51 INFO - Successfully installed mozsystemmonitor 20:00:51 INFO - Cleaning up... 20:00:51 INFO - Return code: 0 20:00:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 20:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:51 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 0x7f172dbecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf3a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc98c0>, '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 0xfca7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcac50>, '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': '0333a256a5e4f052382dd180000001b1-1455335345.413220-2075552826', '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 20:00:51 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 20:00:51 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 20:00:51 INFO - Using env: {'DISPLAY': ':0', 20:00:51 INFO - 'HOME': '/home/cltbld', 20:00:51 INFO - 'LANG': 'en_US.UTF-8', 20:00:51 INFO - 'LANGUAGE': 'en_US:en', 20:00:51 INFO - 'LOGNAME': 'cltbld', 20:00:51 INFO - 'MAIL': '/var/mail/cltbld', 20:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:51 INFO - 'MOZ_NO_REMOTE': '1', 20:00:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:51 INFO - 'NO_EM_RESTART': '1', 20:00:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:00:51 INFO - 'PWD': '/builds/slave/test-pgo', 20:00:51 INFO - 'SHELL': '/bin/bash', 20:00:51 INFO - 'SHLVL': '1', 20:00:51 INFO - 'TERM': 'linux', 20:00:51 INFO - 'TMOUT': '86400', 20:00:51 INFO - 'USER': 'cltbld', 20:00:51 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1455335345.413220-2075552826', 20:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:51 INFO - '_': '/tools/buildbot/bin/python'} 20:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:51 INFO - Downloading/unpacking blobuploader==1.2.4 20:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:53 INFO - Downloading blobuploader-1.2.4.tar.gz 20:00:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:00:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:00: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 20:00: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 20:00: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 20:00: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 20:00: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 20:00: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 20:00:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 20:00:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:54 INFO - Downloading docopt-0.6.1.tar.gz 20:00:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 20:00:54 INFO - Installing collected packages: blobuploader, requests, docopt 20:00:54 INFO - Running setup.py install for blobuploader 20:00:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:00:54 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 20:00:54 INFO - Running setup.py install for requests 20:00:54 INFO - Running setup.py install for docopt 20:00:54 INFO - Successfully installed blobuploader requests docopt 20:00:54 INFO - Cleaning up... 20:00:54 INFO - Return code: 0 20:00:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:54 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 0x7f172dbecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf3a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc98c0>, '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 0xfca7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcac50>, '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': '0333a256a5e4f052382dd180000001b1-1455335345.413220-2075552826', '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 20:00:54 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 20:00:54 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 20:00:54 INFO - Using env: {'DISPLAY': ':0', 20:00:54 INFO - 'HOME': '/home/cltbld', 20:00:54 INFO - 'LANG': 'en_US.UTF-8', 20:00:54 INFO - 'LANGUAGE': 'en_US:en', 20:00:54 INFO - 'LOGNAME': 'cltbld', 20:00:54 INFO - 'MAIL': '/var/mail/cltbld', 20:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:54 INFO - 'MOZ_NO_REMOTE': '1', 20:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:54 INFO - 'NO_EM_RESTART': '1', 20:00:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:00:54 INFO - 'PWD': '/builds/slave/test-pgo', 20:00:54 INFO - 'SHELL': '/bin/bash', 20:00:54 INFO - 'SHLVL': '1', 20:00:54 INFO - 'TERM': 'linux', 20:00:54 INFO - 'TMOUT': '86400', 20:00:54 INFO - 'USER': 'cltbld', 20:00:54 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1455335345.413220-2075552826', 20:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:54 INFO - '_': '/tools/buildbot/bin/python'} 20:00:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:00:55 INFO - Running setup.py (path:/tmp/pip-8vhZkk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:00:55 INFO - Running setup.py (path:/tmp/pip-0Zen8f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:00:55 INFO - Running setup.py (path:/tmp/pip-2kkfhx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:00:55 INFO - Running setup.py (path:/tmp/pip-_C_xnq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:00:55 INFO - Running setup.py (path:/tmp/pip-qBEOo5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:00:55 INFO - Running setup.py (path:/tmp/pip-kT86me-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:00:55 INFO - Running setup.py (path:/tmp/pip-WBZK8w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:00:55 INFO - Running setup.py (path:/tmp/pip-QgQNaC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:00:55 INFO - Running setup.py (path:/tmp/pip-IiCcn5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:00:55 INFO - Running setup.py (path:/tmp/pip-BvKGeM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:00:55 INFO - Running setup.py (path:/tmp/pip-kyfUui-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:00:55 INFO - Running setup.py (path:/tmp/pip-nUL6Pw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:00:55 INFO - Running setup.py (path:/tmp/pip-l0_8Bo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:00:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:00:56 INFO - Running setup.py (path:/tmp/pip-b4vopA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:00:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:00:56 INFO - Running setup.py (path:/tmp/pip-g8fgo0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:00:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:00:56 INFO - Running setup.py (path:/tmp/pip-tGfZPP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:00:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:00:56 INFO - Running setup.py (path:/tmp/pip-RSFjd0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:00:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:00:56 INFO - Running setup.py install for manifestparser 20:00:56 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 20:00:56 INFO - Running setup.py install for mozcrash 20:00:56 INFO - Running setup.py install for mozdebug 20:00:56 INFO - Running setup.py install for mozdevice 20:00:56 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 20:00:56 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 20:00:56 INFO - Running setup.py install for mozfile 20:00:56 INFO - Running setup.py install for mozhttpd 20:00:56 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 20:00:56 INFO - Running setup.py install for mozinfo 20:00:56 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 20:00:57 INFO - Running setup.py install for mozInstall 20:00:57 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 20:00:57 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 20:00:57 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 20:00:57 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 20:00:57 INFO - Running setup.py install for mozleak 20:00:57 INFO - Running setup.py install for mozlog 20:00:57 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 20:00:57 INFO - Running setup.py install for moznetwork 20:00:57 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 20:00:57 INFO - Running setup.py install for mozprocess 20:00:57 INFO - Running setup.py install for mozprofile 20:00:57 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 20:00:57 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 20:00:57 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 20:00:57 INFO - Running setup.py install for mozrunner 20:00:57 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 20:00:57 INFO - Running setup.py install for mozscreenshot 20:00:57 INFO - Running setup.py install for moztest 20:00:57 INFO - Running setup.py install for mozversion 20:00:58 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 20:00:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:00:58 INFO - Cleaning up... 20:00:58 INFO - Return code: 0 20:00:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:00:58 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')]} 20:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:58 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')]} 20:00:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:58 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 0x7f172dbecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf3a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc98c0>, '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 0xfca7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcac50>, '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': '0333a256a5e4f052382dd180000001b1-1455335345.413220-2075552826', '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 20:00:58 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 20:00:58 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 20:00:58 INFO - Using env: {'DISPLAY': ':0', 20:00:58 INFO - 'HOME': '/home/cltbld', 20:00:58 INFO - 'LANG': 'en_US.UTF-8', 20:00:58 INFO - 'LANGUAGE': 'en_US:en', 20:00:58 INFO - 'LOGNAME': 'cltbld', 20:00:58 INFO - 'MAIL': '/var/mail/cltbld', 20:00:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:58 INFO - 'MOZ_NO_REMOTE': '1', 20:00:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:58 INFO - 'NO_EM_RESTART': '1', 20:00:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:00:58 INFO - 'PWD': '/builds/slave/test-pgo', 20:00:58 INFO - 'SHELL': '/bin/bash', 20:00:58 INFO - 'SHLVL': '1', 20:00:58 INFO - 'TERM': 'linux', 20:00:58 INFO - 'TMOUT': '86400', 20:00:58 INFO - 'USER': 'cltbld', 20:00:58 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1455335345.413220-2075552826', 20:00:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:58 INFO - '_': '/tools/buildbot/bin/python'} 20:00:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:00:58 INFO - Running setup.py (path:/tmp/pip-NbseRj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:00:58 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)) 20:00:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:00:58 INFO - Running setup.py (path:/tmp/pip-bDHQ_Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:00:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 20:00:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:00:58 INFO - Running setup.py (path:/tmp/pip-pgxJTi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:00:58 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)) 20:00:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:00:58 INFO - Running setup.py (path:/tmp/pip-1FzZfO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:00:58 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)) 20:00:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:00:58 INFO - Running setup.py (path:/tmp/pip-bxOfRR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:00:58 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)) 20:00:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:00:58 INFO - Running setup.py (path:/tmp/pip-bt_V4C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:00:58 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)) 20:00:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:00:58 INFO - Running setup.py (path:/tmp/pip-7F7GEl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:00:58 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)) 20:00:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:00:58 INFO - Running setup.py (path:/tmp/pip-4wVYLx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:00:58 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)) 20:00:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:00:58 INFO - Running setup.py (path:/tmp/pip-uUIzCz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:00:58 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)) 20:00:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:00:58 INFO - Running setup.py (path:/tmp/pip-A3K_Dt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:00:58 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)) 20:00:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:00:58 INFO - Running setup.py (path:/tmp/pip-2HMxe3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:00:59 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)) 20:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:00:59 INFO - Running setup.py (path:/tmp/pip-uj3tlD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:00:59 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)) 20:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:00:59 INFO - Running setup.py (path:/tmp/pip-oyPUNs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:00:59 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)) 20:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:00:59 INFO - Running setup.py (path:/tmp/pip-kqVTzb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:00:59 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)) 20:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:00:59 INFO - Running setup.py (path:/tmp/pip-rs5lyX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:00:59 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)) 20:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:00:59 INFO - Running setup.py (path:/tmp/pip-RfLLPM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:00:59 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)) 20:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:00:59 INFO - Running setup.py (path:/tmp/pip-Zxe2h2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:00:59 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)) 20:00:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 20:00:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 20:00:59 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)) 20:00:59 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)) 20:00:59 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)) 20:00:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 20:00:59 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 20:00:59 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 20:00:59 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 20:00:59 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 20:00:59 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 20:00:59 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 20:01:01 INFO - Downloading blessings-1.6.tar.gz 20:01:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 20:01:01 INFO - Installing collected packages: blessings 20:01:01 INFO - Running setup.py install for blessings 20:01:01 INFO - Successfully installed blessings 20:01:01 INFO - Cleaning up... 20:01:01 INFO - Return code: 0 20:01:01 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 20:01:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:01:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:01:01 INFO - Reading from file tmpfile_stdout 20:01:01 INFO - Current package versions: 20:01:01 INFO - argparse == 1.2.1 20:01:01 INFO - blessings == 1.6 20:01:01 INFO - blobuploader == 1.2.4 20:01:01 INFO - docopt == 0.6.1 20:01:01 INFO - manifestparser == 1.1 20:01:01 INFO - mozInstall == 1.12 20:01:01 INFO - mozcrash == 0.16 20:01:01 INFO - mozdebug == 0.1 20:01:01 INFO - mozdevice == 0.48 20:01:01 INFO - mozfile == 1.2 20:01:01 INFO - mozhttpd == 0.7 20:01:01 INFO - mozinfo == 0.9 20:01:01 INFO - mozleak == 0.1 20:01:01 INFO - mozlog == 3.1 20:01:01 INFO - moznetwork == 0.27 20:01:01 INFO - mozprocess == 0.22 20:01:01 INFO - mozprofile == 0.28 20:01:01 INFO - mozrunner == 6.11 20:01:01 INFO - mozscreenshot == 0.1 20:01:01 INFO - mozsystemmonitor == 0.0 20:01:01 INFO - moztest == 0.7 20:01:01 INFO - mozversion == 1.4 20:01:01 INFO - psutil == 3.1.1 20:01:01 INFO - requests == 1.2.3 20:01:01 INFO - wsgiref == 0.1.2 20:01:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:01:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:01 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 0x7f172dbecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf3a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc98c0>, '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 0xfca7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcac50>, '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': '0333a256a5e4f052382dd180000001b1-1455335345.413220-2075552826', '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 20:01:01 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 20:01:01 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 20:01:01 INFO - Using env: {'DISPLAY': ':0', 20:01:01 INFO - 'HOME': '/home/cltbld', 20:01:01 INFO - 'LANG': 'en_US.UTF-8', 20:01:01 INFO - 'LANGUAGE': 'en_US:en', 20:01:01 INFO - 'LOGNAME': 'cltbld', 20:01:01 INFO - 'MAIL': '/var/mail/cltbld', 20:01:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:01 INFO - 'MOZ_NO_REMOTE': '1', 20:01:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:01 INFO - 'NO_EM_RESTART': '1', 20:01:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:01:01 INFO - 'PWD': '/builds/slave/test-pgo', 20:01:01 INFO - 'SHELL': '/bin/bash', 20:01:01 INFO - 'SHLVL': '1', 20:01:01 INFO - 'TERM': 'linux', 20:01:01 INFO - 'TMOUT': '86400', 20:01:01 INFO - 'USER': 'cltbld', 20:01:01 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1455335345.413220-2075552826', 20:01:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:01 INFO - '_': '/tools/buildbot/bin/python'} 20:01:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:01 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)) 20:01:01 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)) 20:01:01 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)) 20:01:01 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)) 20:01:01 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)) 20:01:01 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)) 20:01:01 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)) 20:01:01 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)) 20:01:01 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)) 20:01:01 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)) 20:01:01 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)) 20:01:01 INFO - Cleaning up... 20:01:01 INFO - Return code: 0 20:01:01 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 20:01:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:01 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 0x7f172dbecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf3a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc98c0>, '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 0xfca7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcac50>, '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': '0333a256a5e4f052382dd180000001b1-1455335345.413220-2075552826', '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 20:01:01 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 20:01:01 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 20:01:01 INFO - Using env: {'DISPLAY': ':0', 20:01:01 INFO - 'HOME': '/home/cltbld', 20:01:01 INFO - 'LANG': 'en_US.UTF-8', 20:01:01 INFO - 'LANGUAGE': 'en_US:en', 20:01:01 INFO - 'LOGNAME': 'cltbld', 20:01:01 INFO - 'MAIL': '/var/mail/cltbld', 20:01:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:01 INFO - 'MOZ_NO_REMOTE': '1', 20:01:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:01 INFO - 'NO_EM_RESTART': '1', 20:01:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:01:01 INFO - 'PWD': '/builds/slave/test-pgo', 20:01:01 INFO - 'SHELL': '/bin/bash', 20:01:01 INFO - 'SHLVL': '1', 20:01:01 INFO - 'TERM': 'linux', 20:01:01 INFO - 'TMOUT': '86400', 20:01:01 INFO - 'USER': 'cltbld', 20:01:01 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1455335345.413220-2075552826', 20:01:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:01 INFO - '_': '/tools/buildbot/bin/python'} 20:01:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:02 INFO - Downloading/unpacking jsonschema 20:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:01:03 INFO - Downloading/unpacking functools32 (from jsonschema) 20:01:03 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 20:01:03 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 20:01:03 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 20:01:03 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 20:01:03 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 20:01:03 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 20:01:04 INFO - Downloading functools32-3.2.3-2.tar.gz 20:01:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 20:01:04 INFO - warning: no files found matching '*.txt' 20:01:04 INFO - no previously-included directories found matching 'build' 20:01:04 INFO - no previously-included directories found matching 'dist' 20:01:04 INFO - no previously-included directories found matching '.git*' 20:01:04 INFO - Installing collected packages: jsonschema, functools32 20:01:04 INFO - Running setup.py install for functools32 20:01:04 INFO - warning: no files found matching '*.txt' 20:01:04 INFO - no previously-included directories found matching 'build' 20:01:04 INFO - no previously-included directories found matching 'dist' 20:01:04 INFO - no previously-included directories found matching '.git*' 20:01:04 INFO - Successfully installed jsonschema functools32 20:01:04 INFO - Cleaning up... 20:01:04 INFO - Return code: 0 20:01:04 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 20:01:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f172dbecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf3a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc98c0>, '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 0xfca7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcac50>, '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': '0333a256a5e4f052382dd180000001b1-1455335345.413220-2075552826', '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 20:01:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 20:01:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 20:01:04 INFO - Using env: {'DISPLAY': ':0', 20:01:04 INFO - 'HOME': '/home/cltbld', 20:01:04 INFO - 'LANG': 'en_US.UTF-8', 20:01:04 INFO - 'LANGUAGE': 'en_US:en', 20:01:04 INFO - 'LOGNAME': 'cltbld', 20:01:04 INFO - 'MAIL': '/var/mail/cltbld', 20:01:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:04 INFO - 'MOZ_NO_REMOTE': '1', 20:01:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:04 INFO - 'NO_EM_RESTART': '1', 20:01:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:01:04 INFO - 'PWD': '/builds/slave/test-pgo', 20:01:04 INFO - 'SHELL': '/bin/bash', 20:01:04 INFO - 'SHLVL': '1', 20:01:04 INFO - 'TERM': 'linux', 20:01:04 INFO - 'TMOUT': '86400', 20:01:04 INFO - 'USER': 'cltbld', 20:01:04 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1455335345.413220-2075552826', 20:01:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:04 INFO - '_': '/tools/buildbot/bin/python'} 20:01:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:04 INFO - Downloading/unpacking flake8 20:01:04 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 20:01:04 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 20:01:04 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 20:01:04 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 20:01:04 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 20:01:04 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 20:01:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:01:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:01:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 20:01:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:01:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:01:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:01:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:01:07 INFO - no previously-included directories found matching 'docs/_build' 20:01:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:01:07 INFO - Running setup.py install for pep8 20:01:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:01:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:01:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:01:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:01:07 INFO - no previously-included directories found matching 'docs/_build' 20:01:07 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 20:01:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:01:07 INFO - Cleaning up... 20:01:07 INFO - Return code: 0 20:01:07 INFO - Running post-action listener: _resource_record_post_action 20:01:07 INFO - Running post-action listener: _start_resource_monitoring 20:01:07 INFO - Starting resource monitoring. 20:01:07 INFO - ##### 20:01:07 INFO - ##### Running install step. 20:01:07 INFO - ##### 20:01:07 INFO - Running pre-action listener: _resource_record_pre_action 20:01:07 INFO - Running main action method: install 20:01:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:01:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:01:07 INFO - Reading from file tmpfile_stdout 20:01:07 INFO - Detecting whether we're running mozinstall >=1.0... 20:01:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 20:01:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 20:01:07 INFO - Reading from file tmpfile_stdout 20:01:07 INFO - Output received: 20:01:07 INFO - Usage: mozinstall [options] installer 20:01:07 INFO - Options: 20:01:07 INFO - -h, --help show this help message and exit 20:01:07 INFO - -d DEST, --destination=DEST 20:01:07 INFO - Directory to install application into. [default: 20:01:07 INFO - "/builds/slave/test-pgo"] 20:01:07 INFO - --app=APP Application being installed. [default: firefox] 20:01:07 INFO - mkdir: /builds/slave/test-pgo/build/application 20:01:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 20:01:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 20:01:23 INFO - Reading from file tmpfile_stdout 20:01:23 INFO - Output received: 20:01:23 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 20:01:23 INFO - Running post-action listener: _resource_record_post_action 20:01:23 INFO - ##### 20:01:23 INFO - ##### Running run-tests step. 20:01:23 INFO - ##### 20:01:23 INFO - Running pre-action listener: _resource_record_pre_action 20:01:23 INFO - Running main action method: run_tests 20:01:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 20:01:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 20:01:23 INFO - Python 2.7.3 20:01:23 INFO - Return code: 0 20:01:23 INFO - grabbing minidump binary from tooltool 20:01:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:23 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 0xfc98c0>, '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 0xfca7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcac50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 20:01:23 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 20:01:23 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 20:01:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:01:23 INFO - Return code: 0 20:01:23 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 20:01:23 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 20:01:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 20:01:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 20:01:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 20:01:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 20:01:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 20:01:25 INFO - Return code: 0 20:01:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aj-cjXBTSpWlm0oRWAdjEQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 20:01:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aj-cjXBTSpWlm0oRWAdjEQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 20:01:25 INFO - Using env: {'DISPLAY': ':0', 20:01:25 INFO - 'HOME': '/home/cltbld', 20:01:25 INFO - 'LANG': 'en_US.UTF-8', 20:01:25 INFO - 'LANGUAGE': 'en_US:en', 20:01:25 INFO - 'LOGNAME': 'cltbld', 20:01:25 INFO - 'MAIL': '/var/mail/cltbld', 20:01:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:01:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 20:01:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:25 INFO - 'MOZ_NO_REMOTE': '1', 20:01:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:01:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:25 INFO - 'NO_EM_RESTART': '1', 20:01:25 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:01:25 INFO - 'PWD': '/builds/slave/test-pgo', 20:01:25 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 20:01:25 INFO - 'SHELL': '/bin/bash', 20:01:25 INFO - 'SHLVL': '1', 20:01:25 INFO - 'TERM': 'linux', 20:01:25 INFO - 'TMOUT': '86400', 20:01:25 INFO - 'USER': 'cltbld', 20:01:25 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1455335345.413220-2075552826', 20:01:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:25 INFO - '_': '/tools/buildbot/bin/python'} 20:01:25 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aj-cjXBTSpWlm0oRWAdjEQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:01:25 INFO - mozversion application_buildid: 20160212173004 20:01:25 INFO - mozversion application_changeset: 5de4c2e4ddd4f04e4694f7a3b20a2432e4e5fa6c 20:01:25 INFO - mozversion application_display_name: Nightly 20:01:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:01:25 INFO - mozversion application_name: Firefox 20:01:25 INFO - mozversion application_remotingname: firefox 20:01:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:01:25 INFO - mozversion application_vendor: Mozilla 20:01:25 INFO - mozversion application_version: 47.0a1 20:01:25 INFO - mozversion platform_buildid: 20160212173004 20:01:25 INFO - mozversion platform_changeset: 5de4c2e4ddd4f04e4694f7a3b20a2432e4e5fa6c 20:01:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:01:25 INFO - mozversion platform_version: 47.0a1 20:01:25 INFO - using testdate: 1455336085 20:01:25 INFO - actual date: 1455336085 20:01:25 INFO - starting webserver on 'localhost:52582' 20:01:25 INFO - SUITE-START | Running 2 tests 20:01:25 INFO - TEST-START | dromaeo_css 20:01:25 INFO - operating with platform_type : linux_ 20:01:25 INFO - Initialising browser for dromaeo_css test... 20:01:25 INFO - TEST-INFO | started process 6636 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKwaBqR/profile http://localhost:52582/getInfo.html) 20:01:28 INFO - PROCESS | 6636 | __metrics Screen width/height:1600/1200 20:01:28 INFO - PROCESS | 6636 | colorDepth:24 20:01:28 INFO - PROCESS | 6636 | Browser inner width/height: 1024/697 20:01:28 INFO - PROCESS | 6636 | __metrics 20:01:29 INFO - PROCESS | 6636 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:01:29 INFO - PROCESS | 6636 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 20:01:30 INFO - TEST-INFO | 6636: exit 0 20:01:30 INFO - Browser initialized. 20:01:30 INFO - Running cycle 1/1 for dromaeo_css test... 20:01:30 INFO - TEST-INFO | started process 6730 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKwaBqR/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:01:42 INFO - PROCESS | 6730 | RSS: Main: 149975040 20:01:42 INFO - PROCESS | 6730 | 20:02:33 INFO - PROCESS | 6730 | 1455336153326 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] 20:04:42 INFO - PROCESS | 6730 | Cycle 1(1): loaded http://localhost:52582/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52582/tests/dromaeo/cssquery-ext.html) 20:04:43 INFO - PROCESS | 6730 | RSS: Main: 274456576 20:04:43 INFO - PROCESS | 6730 | 20:07:45 INFO - PROCESS | 6730 | Cycle 1(1): loaded http://localhost:52582/tests/dromaeo/cssquery-ext.html (next: http://localhost:52582/tests/dromaeo/cssquery-jquery.html) 20:07:46 INFO - PROCESS | 6730 | RSS: Main: 238698496 20:07:46 INFO - PROCESS | 6730 | 20:10:48 INFO - PROCESS | 6730 | Cycle 1(1): loaded http://localhost:52582/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52582/tests/dromaeo/cssquery-mootools.html) 20:10:48 INFO - PROCESS | 6730 | RSS: Main: 244609024 20:10:48 INFO - PROCESS | 6730 | 20:13:50 INFO - PROCESS | 6730 | Cycle 1(1): loaded http://localhost:52582/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52582/tests/dromaeo/cssquery-prototype.html) 20:13:51 INFO - PROCESS | 6730 | RSS: Main: 222773248 20:13:51 INFO - PROCESS | 6730 | 20:16:54 INFO - PROCESS | 6730 | Cycle 1(1): loaded http://localhost:52582/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52582/tests/dromaeo/cssquery-yui.html) 20:16:54 INFO - PROCESS | 6730 | RSS: Main: 224268288 20:16:54 INFO - PROCESS | 6730 | 20:19:57 INFO - PROCESS | 6730 | Cycle 1(1): loaded http://localhost:52582/tests/dromaeo/cssquery-yui.html (next: http://localhost:52582/tests/dromaeo/cssquery-dojo.html) 20:19:57 INFO - PROCESS | 6730 | RSS: Main: 268144640 20:19:57 INFO - PROCESS | 6730 | 20:19:57 INFO - PROCESS | 6730 | __start_tp_report 20:19:57 INFO - PROCESS | 6730 | _x_x_mozilla_page_load 20:19:57 INFO - PROCESS | 6730 | _x_x_mozilla_page_load_details 20:19:57 INFO - PROCESS | 6730 | |i|pagename|runs| 20:19:57 INFO - PROCESS | 6730 | |0;dojo.html;3092.9381412371754;3120.7191352778245;3165.730912872406;3175.0157451190134;3196.5524826524284;5059.114654935385;5084.669496482726;5090.567301779349;5109.514596113368;5174.586033117351;4991.800327986876;5094.414142373628;5107.361579802525;5161.9483805162035;5214.322138122039;4696.131215725093;4704.38842950416;4708.7645617719145;4747.098051370246;4836.97581512092;4758.524147585231;4776.379070720802;4794.544518270776;4834.9033019339595;4866.026794641069;4676.602488788457;4714;4748.074125545537;4785.880352991168;4797.664163508556;4658.510856360067;4665.393498845162;4668.533146685339;4670.7664616769025;4709.788059537329;4631.374764406795;4634.9073018539775;4647.814087436498;4666.9766651166865;4677.158111539921;4860.635452341088;4931.506849315076;5001.8499445016705;5114.41184263807;5136.229565565158;5544.86137846553;5547.1679248112705;5550;5553.416891226403;5554.222408862763;5580.246666700024;5581.804636837691;5591.133374326986;5591.3569939456665;5594.0769772987815;5150.51070148339;5186.818461353834;5220.556252718561;5222.399424066281;5230.947690523084;5608.327000759935;5611.9438805612235;5613.101903695389;5617.831465055973;5656.2929633795775;5413.079776438015;5413.160960051198;5413.458654134633;5415.918761218585;5418.241446197536;5401.162819762943;5462.262594549765;5547.861303467364;5587.245721827501;5621.18492818539;5412.83761487156;5439.673619582838;5441.972790136024;5455.918161227585;5466.863328416822;5447.891042179134;5452;5455.699936503451;5455.727213639302;5462.945370546244;4282.079352939133;4314.115606300701;4320.157569274024;4354.346847972766;4366.694331396835;3803.448499967489;3807.9619203807606;3819.4079917612257;3848.749831260959;3850.172212974168;5061.7975280989085;5075.213341932006;5079.390473143247;5091.694498330112;5118.10433174193;5497.752601132958;5551.8889622208135;5563.610547261653;5601.271834661468;5639.943600563942;5066.36670416198;5099.566536844335;5100.668456550312;5109;5151.459096794858;4652.348671186037;4720.858374248778;4728.976355118271;4729.810807567727;4738.194506933761;5616.101423772258;5663.178839068394;5674.546036317085;5678.744456499468;5702.971485142631;5430.375506816767;5436.619436639556;5437.537809286255;5437.646552974044;5460.972695136499;5607.775688972395;5626.915596265977;5645.802396916252;5669.461401166883;5676.829695109153;5436.320459942507;5472.34331880161;5486.753096110605;5493.890122197614;5527.723613819373;5511.200875873056;5551.500364967173;5555.0834112371;5560.638558493685;5568.220449137205;5325.9201111982575;5412.648177868584;5414.214938833926;5433.728313584384;5463.781448742165;5449.3188351456065;5494.011078005998;5504.22940788282;5505.449455054462;5546.861328466659;5269.552088072403;5373;5376.542993845567;5383.9192412114635;5430.864228394322;5360.142377219626;5427.728613569385;5449.264349312792;5453.318335208099;5460.890782184413;5245.423003469692;5260.368755749335;5264.842054738364;5264.921026184534;5285.127953887565 20:19:57 INFO - PROCESS | 6730 | |1;ext.html;532.1804421191365;550.1692444408941;555.8638133657255;556.0186271231277;595.7438301530343;28684.85657571712;38406.42390364143;39409.40885886707;39428.60571394289;39429.211415771664;42209.36685949713;42932.35601465973;43005.784971075176;43007.78496107523;43049;8563.571821408936;8807.823843523125;8841.5579221039;8866.157715017063;8871.645134194625;8702.086280940504;8845.380823342337;8845.734627961172;8848.070952549986;8853.822923541558;8755.299576033934;8890.822183556325;8893.066228046058;8893.510856902867;8902.688405905794;8762.12378762125;8854.734357969206;8857.512836793941;8860.069692682304;8869.068747781455;8684.305255579538;8818.29453643707;8835.911640883638;8838.602262898185;8841.071687472851;40009.39985900214;40529.797351013054;40542.18915621671;40568.391474127915;40573.79713101416;3151.6533181350032;3236.8705251790134;3262.21706790371;3266.9643256236836;3697.999999999973;30191.245218869484;30638.234044148852;31066.53400198999;31353.37293254145;31717.524237136462;3597.262561174979;3710.9443358349645;3717.8698745544048;3731.458938453909;3874.5544262409903;210649;212207;212254;212421;212867;53506;55485;56611.15083273754;57115.14327285094;62954.68522657357;54945.45054549483;55058.72470637701;55111;55267.170992435145;55395.44604553984;14276.072055316372;14286.642833929027;14370.568882933529;14411.42354305837;14491.92754036223;9536.427814331024;11055.613053543248;11289.604863829727;11294.152938529644;11325.037371823322;19826.50433739139;19876.50308742293;20141.39575812728;20167.19331226764;20168;7803.960980195063;7953.880691789628;7999.720009799629;8017.8797318039105;8080.878786818203;905.7826121730737;991.7173605522391;1109.5118148014847;1122.172303916725;1128.5372997071327;28924.566131508043;29002.41995160085;29041.128766137048;29120.563191552144;29590.556141657893;1009.3187098708489;1037.9792404151874;1096.819024860905;1121.859767529059;1140.7604403075447;14863.18252496123;14875.107493550422;15118.622034449007;15238.31427585739;15321.616959575877;313590;317646;317664;318090;318196;51217.7439112802;52024;52045.47954520406;52063;52077.218841717404;1337.0840973932693;1339.852616212216;1353.1407556201882;1353.8510763815973;1365.215001374214;27600;28350.858245708638;28610.14169574916;28661.713382865906;28852.422951540433;46895;47468.762656186496;47485.28772068491;47547.28679069886;47595.524044760496;294992;297251;297374;297945;297947;32618.673813261565;33226.169345766546;33257.16857078592;33376.83311583426;33402.83298583492;43275;43632.12735745331;43828.780856095516;44297.55702442934;44765.328520071576;35736.463953041246;36146.27707445784;36495;36544.45183322199;37729.245415091;28034.439311214068;33496;33739.325213496086;34653.306933861684;34922.65077349194;32954.17614559655;33544.49683254704;33727.83136084304;33947.66052339445;34036.319273614885;29210.853945730134;30542.236444089074;31051.53422698616;31228;31258.374832503676;19298.517537061685;22943.88528057349;22990.195343162908;25946.35134121662;26219 20:19:57 INFO - PROCESS | 6730 | |2;jquery.html;358.77576514678327;361.83717327202766;366.2437067455702;367.2196582262691;368.9354362986477;13664.863351366483;13864.930675346634;16133.19334033298;16887.32450701972;17349.47951561452;15596.220188990561;16048.83951160488;16481.83518164821;17214.762080929493;17265.827341726577;4842.75786210689;4998.075356059141;4998.875028124307;5003.699778013312;5008.123578373788;3791.9431208531896;4957;5315.282436871012;5535.529479994206;5536.557075433976;5448.242197228552;5475.5072043516075;5496.80761173359;5536.640118392292;5538.224648549186;5590.91613625796;5591.10542313232;5591.552675785927;5592.720363981805;5600.5799565032785;5320.414754377015;5344.7862085516535;5353.732313384316;5389.676619402849;5394.703291318976;19594.21623135073;19600.411987640393;19905.203791848307;20083.698744518842;20134.69797953032;2135.071244008861;2197.9890100549555;2523.7223905370392;2715.0768738628963;2780.569011803174;8723;9413.435193888321;9442.811143777155;9481.810363792685;9700.563474643588;1713.5202143399868;1864.5991111910869;1866.7586055273227;1875.5311172206948;1883.0867029490687;60137;60691.39308606946;63197.36802631961;63242.05136922904;64249.35750642481;10107.494625268708;10205.520199571021;10251.641192558225;10355.119814815675;10414.635487757892;13528;13635.113717608323;13661.385237664328;13662.93168534151;13705.109167904253;7264.491485595958;7362.521436106743;7395.083932853696;7414.332710056121;7455.515391499535;7137.250588688217;7154;7187.856242875113;7205.279472052753;7209.351158395664;4160.875173744732;4488.192125417456;4549.977250113729;4554.271316589396;4587.266037434061;1746.1792957310045;1840.778637384577;1862.0875770872447;1862.8602854785945;1863.6086421851292;730.5361095704266;743.650484272391;745.1951891956674;806.8184658451802;879.5294517433142;13471.932640336736;15214.47687776281;15775.132367719885;16226.756598651029;16230.688158400731;883.4831623500324;886.055808588077;914.2411798207472;925.6806401791371;938.8450905600499;9431.245500359955;9605.663801766905;9637.903620963842;9709.70870873875;9732.41605503672;156747;156839;156859;156963;400164;66189;67631.32368676348;74903.25096749072;74926;77060.61469692616;1029.953652085658;1128.7065363005677;1130.327455164176;1152.1128730877178;1164.394514852289;14356.21040842722;14633.853661463248;14721.852781472047;14801.18593477326;14916.179610121113;32646;33568.83215583907;34288.14279642929;34858.65141348656;35252.118697032776;43540.78229608959;43710;43906.56093439153;44151;48120.7593962028;7184.497085203986;7337.3029562191505;7770.53376797394;7798.610069496616;7809.297163255107;10972.780544389227;11113.388763617755;11301.886981130412;11536;11598.94200528992;9404;9627.807443850943;9835.704928852147;9929.851052234078;10278.537465813906;9527.38072025316;9784.461854598065;9909.207263419054;10057.145142662956;10239.641612543823;3314.055494184146;6679;9079.7742304788;9856.359336643096;10476.16190704757;7643.082830060428;7653.272939070779;7765.378769698524;7779.883301750591;7884.250996155356;9680.951595241979;10318.277720559488;10581.682549523526;10620.628278010232;10709.946450267698 20:19:57 INFO - PROCESS | 6730 | |3;mootools.html;1336.5474354559383;1493.4548889655275;1506.5103841251596;1689.467817637444;1831.5787368905144;7056.470764692643;7572.469927105105;7677.654505547257;7680.423968202394;7696.576688282143;7672.1560628330835;7807.531548107103;7856.8035799105055;7862.0958589762195;7864.646090925908;2001.449601359623;2280.144945645383;2322.8606283622953;2332.5218330242346;2363.550925324183;2344.39045848079;2356.39911822485;2356.599378105726;2356.8114550835976;2358.9410264743346;2255.075419078178;2315.3979965209082;2317.860928344296;2319.7796209360085;2320.6519022146645;2327.6857624220766;2352.6588644646517;2352.6588644646517;2381.8451800633075;2385.880705964712;2316.93049208524;2326.336993956714;2341.2156927429332;2348.8590684558812;2362.5983582790795;7954.681812727484;7995.560244186568;8004.359651227946;8026.719064832703;8033.718819841336;4827.106985207748;4893;4913.238448040559;4925.581325587329;4939.160342741707;2919.8102123361914;2930.58971743956;2990.416868710602;3058.617672790901;3064.080775767261;952.2477242978039;958.6836344006462;979.740368802268;979.8481235408523;992.3450522655086;10750.73123171927;10763.300385474919;10918.727031824188;10923.836142457869;10929.125669946385;4342.956570434255;4400.867973960786;4439.933400998988;4470.731756094645;4491.865244042684;9319.347645664873;9328.486933218603;9329.393589416803;9336.57985390659;9374.203192728695;4859.271109333628;4897.3878265216845;4912.975435122801;4916.508349165055;4921.114199444063;4435.135148646047;4439.64482841372;4448.088141930896;4448.110377924428;4449.488308844459;3452.3958307296625;3730.850765969331;3759.229357981662;3765.359888818907;3800.3349413852466;1205.3310412720848;1218.214251807579;1220.951161953512;1225.4240506961714;1230.6738714240732;1291.1284882704138;1321.4978308242999;1325.9734805304033;1367.2480135925202;1367.863213678624;7429.271109164441;7673.040869891263;7689.884651730228;7700.422468314899;7705.42209334291;1109.7835921995134;1117.675873996532;1128.8476055732535;1131.2816361610437;1135.4969917803503;5839.649621022667;5888;5907.350191478934;5909.261342332208;5911.556633252523;9360.719178424659;9401.34190606651;9550;9582.233421326277;9590.568424420917;9341.532923353805;9442.669506567374;9483.478408687588;9489.715308540755;9497.240220782322;7250.4199664026755;7399.593022383713;7477.775666730006;7487.326140647259;7494.362979146725;7300.561966281828;7348.77953661391;7353.191148973716;7357.411407087313;7377.4098072155175;8064;8095.87856182146;8316.584170791315;8331.83336333282;8334.62494187751;8316.750497485085;8450.619722112397;8451.112633173429;8470.195331443503;8476.703315383931;6233.096201050913;7019.6841142147705;7189.3889019431845;7197.712091516491;7210.74762383335;6715.294894036056;6751.257361690308;7287.489875708649;7353.889691654736;7415.8887616684715;6547.574407663486;6551.574147680385;6817.965910170417;6821.897671534832;6974.337437943387;6991.965040174767;7038.190608080136;7056.6471676417;7073.363397294268;7118.679659415235;6992.056072430157;7033.613151276524;7069.081019467436;7071.681774320065;7073.3987611053635;6538.738450461929;6601.669916504059;6605.9009114864275;6611.471082313499;6635.933640663725;6709.4632429404555;6752.797416077526;6754.86490270182;6761.966190169018;6878.037074809631 20:19:57 INFO - PROCESS | 6730 | |4;prototype.html;335.85893924551686;338.4128536988325;341.6822355209655;346.6169882280082;355.05024060637805;5673.23411339469;5855.443732845378;5910.734016969242;5914.34942156363;5917.526597872171;5714;5770.682612456313;5831.5626328025355;5849.151872978416;5849.853753656161;4579.061292435051;4580.541945805426;4580.854786303425;4588.678792484528;4593.747343896084;4391.253486907218;4452.97773511132;4552.954470455303;4571.131485017836;4599.724016559017;4530.207213737599;4536.432945881765;4544.4092268005115;4560.794764235618;4562.361269422284;4562.064776720765;4567.0409214065085;4572.45130584332;4573.771311434415;4574.428196475457;4034.616711412411;4038.172174704179;4042.3734321180264;4047.797610119482;4054.6553542948886;5534.183309995808;5560.972195138998;5620;5626.381098079208;5629.915551266734;5313;5313.8937221255355;5313.920291195596;5314.5216930476445;5315.734213289359;5953.315368732608;6216.906746398808;6217.87564248717;6223.657698826562;6223.937760622381;4337.63130133939;4453.198424283628;4455.77721113943;4470.038941627533;4480.260756975095;6438.678066096723;6478.740850366027;6479.64361960092;6481.254655714606;6495.1556297681;4557.384753058294;4570.131674981742;4578.153041687232;4581.198290299251;4584.014436896084;4542.863714088583;4636.542632404831;4638.1883170445035;4639.350490931272;4671.672982891233;5279.9208011879855;5292.629515933924;5298.258243845865;5298.4634456007325;5301.840944771663;6282.057691346243;6286.622802631857;6289.182406287154;6289.245290565162;6290.370962903673;1615.7657139714674;1635.582926353772;1636.648120654065;1641.5896025993502;1642.3184378482795;1102.1733699725205;1103.3104309806372;1116.0123290887623;1118.5246270335076;1144.4506636814376;5860.560457965669;5873.236479257755;5874.9118763218585;5878.911816322673;5883.411658834168;6413.262474815456;6418.454431373386;6418.74325027003;6421.711023003976;6422.357764223634;5768.682722450221;5869.20765696634;5874.559408044413;5877.941220587825;5879.647221166658;3414.3854106260615;3469;3473.166440054419;3474.982625086858;3480.443129099332;6653.733850646016;6656.234533028667;6663.900041499382;6675.632840193836;6675.699593518303;6536.803895883131;6537.9673101635135;6545.280019197884;6547.083408322838;6550.803475895731;6477.222733272038;6648.135742353463;6650.933490665128;6716.597004179863;6722.798316050526;6152.969235153974;6271.310155882758;6402.903956440564;6403.9359606405205;6404.551681382259;6379.393957574023;6390.520710946605;6401.743930242738;6408.935910640834;6415.6471394071905;6697.430718388797;6702.966485167543;6707.8993815091835;6710.194776626836;6718.462522998246;4295.570442955679;4614.238650622609;4616.6075883550275;4622.191116554657;4622.491525932212;6415.903761443488;6455.838604034937;6506.186726659168;6515.413612774873;6516.478681705357;6191.473724733448;6236.968815155895;6246.593971391845;6247.250329960434;6248.343923888108;6150.261968563801;6207.410296021871;6250.499960003098;6250.531210159347;6252.499800015897;6135.07973803933;6135.14108024868;6139.355367686508;6141.355157708376;6143.385661433999;6265.373462653698;6267.2792628848265;6270.905936411049;6276.874462510633;6278.246610406781;6046.853431581867;6084.452399284086;6124.846878828065;6133.570650054453;6147.262328520606 20:19:57 INFO - PROCESS | 6730 | |5;yui.html;688.8518968421788;706.922238553759;733.8458923626039;801.8195905921168;812.1472453923379;13406.865931340684;13575.864241357596;13592;13641.113327633697;13652.726945461085;12675.429605667745;13466.627462511025;13739.58781236562;13769.380377882995;13789;682.3210905149383;829.6308142876422;839.9034111077212;841.7558907916697;841.8610929196675;685.2941470285614;820.5938060659952;844.4046946902419;844.6916875340518;845.2561745663838;870.1863757386864;878.8462019146656;879.3712495565669;880.5025160784169;880.6477409036405;707.4481904114773;858.1504310732392;872.8167084912176;873.6636394987944;874.7638137702785;642.6497558830449;642.9228492580874;644.7839973608847;644.9774257900998;645.4384685323798;13654.180749155083;13687.11033782801;13695.589132325946;13784;13797.24115173665;12456.252624842538;12813.551525696555;12916.160449570842;12952.611421657366;13204.735905281937;10449.373037617766;10478.947605261925;10517.84223236652;10548.156147508182;10635.415052172128;3541.4156664150382;3601.9099522511883;3602.3155600435834;3602.621724718893;3730.347189241872;46717.766411168064;47227.527724722655;47702;47786.76106619445;47799.76100119512;8997.910020899839;9268.675596354095;9964.302498825158;10027.598896044223;10114.696559103239;18049;18201.908990454962;18229.17968691412;18313.816861831212;18338.633227335646;7411.740589079356;7508.1741008489025;7592.544447333178;7625.389968802482;7782.221777822172;4154.605312495369;4207.831686732497;4252.383404406344;4265.253580623378;4280.72175308604;3121.641011283686;3129.5305704144107;3138.2154461384653;3153.4323821711855;3202.3115030268605;582.4117641182436;583;583.6089819820645;596.5198015597399;612.8406614280319;653.8790323790114;669.300580892968;673.7035704290097;694.7012784502713;697.2121502701914;8173.754787356389;8728.301735861116;8791.824163516821;8917.598708058153;9021.684241051531;640.0399400898652;651.4983462733669;664.8221501224157;680.323078536859;692.7298353642084;3838.808059597009;3982.38273067675;4162.188373267244;4164.229617520768;4195;57096.429035709945;57590;57726;57728.422715773144;57771.42228577661;50198.74900625474;50296;51677.741611291705;51844;51854;44776.3283550747;44848;44885.61296154656;45352.052116612314;45517.772411138394;8209.38429617793;8216.753497395088;8387.077421483755;8405.453645513022;8512.489250644981;34863.825680871436;35124.29751404907;35911;35953.64046359503;36008.459873102445;40457;41856.79071604623;44397;44960;45006.77496612496;10420.478976051016;10551.683449496528;10625.840612390975;10641.680749577525;10874.619388321371;11783.234089784137;12351.19717218378;12414.503419863466;12472.376381181086;12599.496020159091;11325.943370283096;11359.716007099558;11392.886071139514;11409.315441073562;11547.94226028898;11713.590024349107;11827.940860295988;11862.82205766897;12036.63890083299;12145.089118315986;8756.562171891508;10531;10956.178286628376;11032.834507482556;11462;8306.62620182081;8506.872396914176;9114.544272786467;9281;9289.535523223947;8936.597853096497;9216.815663686823;9278;9415.670451534163;9418.387804792666 20:19:57 INFO - PROCESS | 6730 | __end_tp_report 20:19:57 INFO - PROCESS | 6730 | __start_cc_report 20:19:57 INFO - PROCESS | 6730 | _x_x_mozilla_cycle_collect,988 20:19:57 INFO - PROCESS | 6730 | __end_cc_report 20:19:57 INFO - PROCESS | 6730 | __startTimestamp1455337197611__endTimestamp 20:19:57 INFO - PROCESS | 6730 | 20:19:57 INFO - PROCESS | 6730 | ------- Summary: start ------- 20:19:57 INFO - PROCESS | 6730 | Number of tests: 6 20:19:57 INFO - PROCESS | 6730 | 20:19:57 INFO - PROCESS | 6730 | [#0] dojo.html Cycles:165 Average:5126.57 Median:5360.14 stddev:550.68 (10.3%) stddev-sans-first:528.76 20:19:57 INFO - PROCESS | 6730 | Values: 3092.9 3120.7 3165.7 3175.0 3196.6 5059.1 5084.7 5090.6 5109.5 5174.6 4991.8 5094.4 5107.4 5161.9 5214.3 4696.1 4704.4 4708.8 4747.1 4837.0 4758.5 4776.4 4794.5 4834.9 4866.0 4676.6 4714.0 4748.1 4785.9 4797.7 4658.5 4665.4 4668.5 4670.8 4709.8 4631.4 4634.9 4647.8 4667.0 4677.2 4860.6 4931.5 5001.8 5114.4 5136.2 5544.9 5547.2 5550.0 5553.4 5554.2 5580.2 5581.8 5591.1 5591.4 5594.1 5150.5 5186.8 5220.6 5222.4 5230.9 5608.3 5611.9 5613.1 5617.8 5656.3 5413.1 5413.2 5413.5 5415.9 5418.2 5401.2 5462.3 5547.9 5587.2 5621.2 5412.8 5439.7 5442.0 5455.9 5466.9 5447.9 5452.0 5455.7 5455.7 5462.9 4282.1 4314.1 4320.2 4354.3 4366.7 3803.4 3808.0 3819.4 3848.7 3850.2 5061.8 5075.2 5079.4 5091.7 5118.1 5497.8 5551.9 5563.6 5601.3 5639.9 5066.4 5099.6 5100.7 5109.0 5151.5 4652.3 4720.9 4729.0 4729.8 4738.2 5616.1 5663.2 5674.5 5678.7 5703.0 5430.4 5436.6 5437.5 5437.6 5461.0 5607.8 5626.9 5645.8 5669.5 5676.8 5436.3 5472.3 5486.8 5493.9 5527.7 5511.2 5551.5 5555.1 5560.6 5568.2 5325.9 5412.6 5414.2 5433.7 5463.8 5449.3 5494.0 5504.2 5505.4 5546.9 5269.6 5373.0 5376.5 5383.9 5430.9 5360.1 5427.7 5449.3 5453.3 5460.9 5245.4 5260.4 5264.8 5264.9 5285.1 20:19:57 INFO - PROCESS | 6730 | 20:19:57 INFO - PROCESS | 6730 | [#1] ext.html Cycles:180 Average:44574.40 Median:34787.98 stddev:72947.14 (209.7%) stddev-sans-first:73076.82 20:19:57 INFO - PROCESS | 6730 | Values: 532.2 550.2 555.9 556.0 595.7 28684.9 38406.4 39409.4 39428.6 39429.2 42209.4 42932.4 43005.8 43007.8 43049.0 8563.6 8807.8 8841.6 8866.2 8871.6 8702.1 8845.4 8845.7 8848.1 8853.8 8755.3 8890.8 8893.1 8893.5 8902.7 8762.1 8854.7 8857.5 8860.1 8869.1 8684.3 8818.3 8835.9 8838.6 8841.1 40009.4 40529.8 40542.2 40568.4 40573.8 3151.7 3236.9 3262.2 3267.0 3698.0 30191.2 30638.2 31066.5 31353.4 31717.5 3597.3 3710.9 3717.9 3731.5 3874.6 210649.0 212207.0 212254.0 212421.0 212867.0 53506.0 55485.0 56611.2 57115.1 62954.7 54945.5 55058.7 55111.0 55267.2 55395.4 14276.1 14286.6 14370.6 14411.4 14491.9 9536.4 11055.6 11289.6 11294.2 11325.0 19826.5 19876.5 20141.4 20167.2 20168.0 7804.0 7953.9 7999.7 8017.9 8080.9 905.8 991.7 1109.5 1122.2 1128.5 28924.6 29002.4 29041.1 29120.6 29590.6 1009.3 1038.0 1096.8 1121.9 1140.8 14863.2 14875.1 15118.6 15238.3 15321.6 313590.0 317646.0 317664.0 318090.0 318196.0 51217.7 52024.0 52045.5 52063.0 52077.2 1337.1 1339.9 1353.1 1353.9 1365.2 27600.0 28350.9 28610.1 28661.7 28852.4 46895.0 47468.8 47485.3 47547.3 47595.5 294992.0 297251.0 297374.0 297945.0 297947.0 32618.7 33226.2 33257.2 33376.8 33402.8 43275.0 43632.1 43828.8 44297.6 44765.3 35736.5 36146.3 36495.0 36544.5 37729.2 28034.4 33496.0 33739.3 34653.3 34922.7 32954.2 33544.5 33727.8 33947.7 34036.3 29210.9 30542.2 31051.5 31228.0 31258.4 19298.5 22943.9 22990.2 25946.4 26219.0 20:19:57 INFO - PROCESS | 6730 | 20:19:57 INFO - PROCESS | 6730 | [#2] jquery.html Cycles:180 Average:18419.30 Median:4519.08 stddev:39018.98 (863.4%) stddev-sans-first:39104.87 20:19:57 INFO - PROCESS | 6730 | Values: 358.8 361.8 366.2 367.2 368.9 13664.9 13864.9 16133.2 16887.3 17349.5 15596.2 16048.8 16481.8 17214.8 17265.8 4842.8 4998.1 4998.9 5003.7 5008.1 3791.9 4957.0 5315.3 5535.5 5536.6 5448.2 5475.5 5496.8 5536.6 5538.2 5590.9 5591.1 5591.6 5592.7 5600.6 5320.4 5344.8 5353.7 5389.7 5394.7 19594.2 19600.4 19905.2 20083.7 20134.7 2135.1 2198.0 2523.7 2715.1 2780.6 8723.0 9413.4 9442.8 9481.8 9700.6 1713.5 1864.6 1866.8 1875.5 1883.1 60137.0 60691.4 63197.4 63242.1 64249.4 10107.5 10205.5 10251.6 10355.1 10414.6 13528.0 13635.1 13661.4 13662.9 13705.1 7264.5 7362.5 7395.1 7414.3 7455.5 7137.3 7154.0 7187.9 7205.3 7209.4 4160.9 4488.2 4550.0 4554.3 4587.3 1746.2 1840.8 1862.1 1862.9 1863.6 730.5 743.7 745.2 806.8 879.5 13471.9 15214.5 15775.1 16226.8 16230.7 883.5 886.1 914.2 925.7 938.8 9431.2 9605.7 9637.9 9709.7 9732.4 156747.0 156839.0 156859.0 156963.0 400164.0 66189.0 67631.3 74903.3 74926.0 77060.6 1030.0 1128.7 1130.3 1152.1 1164.4 14356.2 14633.9 14721.9 14801.2 14916.2 32646.0 33568.8 34288.1 34858.7 35252.1 43540.8 43710.0 43906.6 44151.0 48120.8 7184.5 7337.3 7770.5 7798.6 7809.3 10972.8 11113.4 11301.9 11536.0 11598.9 9404.0 9627.8 9835.7 9929.9 10278.5 9527.4 9784.5 9909.2 10057.1 10239.6 3314.1 6679.0 9079.8 9856.4 10476.2 7643.1 7653.3 7765.4 7779.9 7884.3 9681.0 10318.3 10581.7 10620.6 10709.9 20:19:57 INFO - PROCESS | 6730 | 20:19:57 INFO - PROCESS | 6730 | [#3] mootools.html Cycles:180 Average:5526.68 Median:6608.69 stddev:2829.95 (42.8%) stddev-sans-first:2820.36 20:19:57 INFO - PROCESS | 6730 | Values: 1336.5 1493.5 1506.5 1689.5 1831.6 7056.5 7572.5 7677.7 7680.4 7696.6 7672.2 7807.5 7856.8 7862.1 7864.6 2001.4 2280.1 2322.9 2332.5 2363.6 2344.4 2356.4 2356.6 2356.8 2358.9 2255.1 2315.4 2317.9 2319.8 2320.7 2327.7 2352.7 2352.7 2381.8 2385.9 2316.9 2326.3 2341.2 2348.9 2362.6 7954.7 7995.6 8004.4 8026.7 8033.7 4827.1 4893.0 4913.2 4925.6 4939.2 2919.8 2930.6 2990.4 3058.6 3064.1 952.2 958.7 979.7 979.8 992.3 10750.7 10763.3 10918.7 10923.8 10929.1 4343.0 4400.9 4439.9 4470.7 4491.9 9319.3 9328.5 9329.4 9336.6 9374.2 4859.3 4897.4 4913.0 4916.5 4921.1 4435.1 4439.6 4448.1 4448.1 4449.5 3452.4 3730.9 3759.2 3765.4 3800.3 1205.3 1218.2 1221.0 1225.4 1230.7 1291.1 1321.5 1326.0 1367.2 1367.9 7429.3 7673.0 7689.9 7700.4 7705.4 1109.8 1117.7 1128.8 1131.3 1135.5 5839.6 5888.0 5907.4 5909.3 5911.6 9360.7 9401.3 9550.0 9582.2 9590.6 9341.5 9442.7 9483.5 9489.7 9497.2 7250.4 7399.6 7477.8 7487.3 7494.4 7300.6 7348.8 7353.2 7357.4 7377.4 8064.0 8095.9 8316.6 8331.8 8334.6 8316.8 8450.6 8451.1 8470.2 8476.7 6233.1 7019.7 7189.4 7197.7 7210.7 6715.3 6751.3 7287.5 7353.9 7415.9 6547.6 6551.6 6818.0 6821.9 6974.3 6992.0 7038.2 7056.6 7073.4 7118.7 6992.1 7033.6 7069.1 7071.7 7073.4 6538.7 6601.7 6605.9 6611.5 6635.9 6709.5 6752.8 6754.9 6762.0 6878.0 20:19:57 INFO - PROCESS | 6730 | 20:19:57 INFO - PROCESS | 6730 | [#4] prototype.html Cycles:180 Average:5241.32 Median:5873.90 stddev:1544.88 (26.3%) stddev-sans-first:1504.70 20:19:57 INFO - PROCESS | 6730 | Values: 335.9 338.4 341.7 346.6 355.1 5673.2 5855.4 5910.7 5914.3 5917.5 5714.0 5770.7 5831.6 5849.2 5849.9 4579.1 4580.5 4580.9 4588.7 4593.7 4391.3 4453.0 4553.0 4571.1 4599.7 4530.2 4536.4 4544.4 4560.8 4562.4 4562.1 4567.0 4572.5 4573.8 4574.4 4034.6 4038.2 4042.4 4047.8 4054.7 5534.2 5561.0 5620.0 5626.4 5629.9 5313.0 5313.9 5313.9 5314.5 5315.7 5953.3 6216.9 6217.9 6223.7 6223.9 4337.6 4453.2 4455.8 4470.0 4480.3 6438.7 6478.7 6479.6 6481.3 6495.2 4557.4 4570.1 4578.2 4581.2 4584.0 4542.9 4636.5 4638.2 4639.4 4671.7 5279.9 5292.6 5298.3 5298.5 5301.8 6282.1 6286.6 6289.2 6289.2 6290.4 1615.8 1635.6 1636.6 1641.6 1642.3 1102.2 1103.3 1116.0 1118.5 1144.5 5860.6 5873.2 5874.9 5878.9 5883.4 6413.3 6418.5 6418.7 6421.7 6422.4 5768.7 5869.2 5874.6 5877.9 5879.6 3414.4 3469.0 3473.2 3475.0 3480.4 6653.7 6656.2 6663.9 6675.6 6675.7 6536.8 6538.0 6545.3 6547.1 6550.8 6477.2 6648.1 6650.9 6716.6 6722.8 6153.0 6271.3 6402.9 6403.9 6404.6 6379.4 6390.5 6401.7 6408.9 6415.6 6697.4 6703.0 6707.9 6710.2 6718.5 4295.6 4614.2 4616.6 4622.2 4622.5 6415.9 6455.8 6506.2 6515.4 6516.5 6191.5 6237.0 6246.6 6247.3 6248.3 6150.3 6207.4 6250.5 6250.5 6252.5 6135.1 6135.1 6139.4 6141.4 6143.4 6265.4 6267.3 6270.9 6276.9 6278.2 6046.9 6084.5 6124.8 6133.6 6147.3 20:19:57 INFO - PROCESS | 6730 | 20:19:57 INFO - PROCESS | 6730 | [#5] yui.html Cycles:180 Average:13711.69 Median:46117.77 stddev:15797.59 (34.3%) stddev-sans-first:15811.63 20:19:57 INFO - PROCESS | 6730 | Values: 688.9 706.9 733.8 801.8 812.1 13406.9 13575.9 13592.0 13641.1 13652.7 12675.4 13466.6 13739.6 13769.4 13789.0 682.3 829.6 839.9 841.8 841.9 685.3 820.6 844.4 844.7 845.3 870.2 878.8 879.4 880.5 880.6 707.4 858.2 872.8 873.7 874.8 642.6 642.9 644.8 645.0 645.4 13654.2 13687.1 13695.6 13784.0 13797.2 12456.3 12813.6 12916.2 12952.6 13204.7 10449.4 10478.9 10517.8 10548.2 10635.4 3541.4 3601.9 3602.3 3602.6 3730.3 46717.8 47227.5 47702.0 47786.8 47799.8 8997.9 9268.7 9964.3 10027.6 10114.7 18049.0 18201.9 18229.2 18313.8 18338.6 7411.7 7508.2 7592.5 7625.4 7782.2 4154.6 4207.8 4252.4 4265.3 4280.7 3121.6 3129.5 3138.2 3153.4 3202.3 582.4 583.0 583.6 596.5 612.8 653.9 669.3 673.7 694.7 697.2 8173.8 8728.3 8791.8 8917.6 9021.7 640.0 651.5 664.8 680.3 692.7 3838.8 3982.4 4162.2 4164.2 4195.0 57096.4 57590.0 57726.0 57728.4 57771.4 50198.7 50296.0 51677.7 51844.0 51854.0 44776.3 44848.0 44885.6 45352.1 45517.8 8209.4 8216.8 8387.1 8405.5 8512.5 34863.8 35124.3 35911.0 35953.6 36008.5 40457.0 41856.8 44397.0 44960.0 45006.8 10420.5 10551.7 10625.8 10641.7 10874.6 11783.2 12351.2 12414.5 12472.4 12599.5 11325.9 11359.7 11392.9 11409.3 11547.9 11713.6 11827.9 11862.8 12036.6 12145.1 8756.6 10531.0 10956.2 11032.8 11462.0 8306.6 8506.9 9114.5 9281.0 9289.5 8936.6 9216.8 9278.0 9415.7 9418.4 20:19:57 INFO - PROCESS | 6730 | -------- Summary: end -------- 20:19:57 INFO - PROCESS | 6730 | 20:19:58 INFO - TEST-INFO | 6730: exit 0 20:19:58 INFO - TEST-OK | dromaeo_css | took 1113142ms 20:19:58 INFO - TEST-START | kraken 20:19:58 INFO - operating with platform_type : linux_ 20:19:58 INFO - Initialising browser for kraken test... 20:19:58 INFO - TEST-INFO | started process 6921 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3F2vI_/profile http://localhost:52582/getInfo.html) 20:20:02 INFO - PROCESS | 6921 | __metrics Screen width/height:1600/1200 20:20:02 INFO - PROCESS | 6921 | colorDepth:24 20:20:02 INFO - PROCESS | 6921 | Browser inner width/height: 1024/697 20:20:02 INFO - PROCESS | 6921 | __metrics 20:20:02 INFO - PROCESS | 6921 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:20:03 INFO - TEST-INFO | 6921: exit 0 20:20:03 INFO - Browser initialized. 20:20:03 INFO - Running cycle 1/1 for kraken test... 20:20:03 INFO - TEST-INFO | started process 7007 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3F2vI_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:20:15 INFO - PROCESS | 7007 | RSS: Main: 150376448 20:20:15 INFO - PROCESS | 7007 | 20:20:17 INFO - PROCESS | 7007 | Cycle 1(1): loaded http://localhost:52582/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52582/tests/kraken/driver.html?testName=audio-beat-detection) 20:20:18 INFO - PROCESS | 7007 | RSS: Main: 194498560 20:20:18 INFO - PROCESS | 7007 | 20:20:21 INFO - PROCESS | 7007 | Cycle 1(1): loaded http://localhost:52582/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52582/tests/kraken/driver.html?testName=audio-dft) 20:20:21 INFO - PROCESS | 7007 | RSS: Main: 184590336 20:20:21 INFO - PROCESS | 7007 | 20:20:24 INFO - PROCESS | 7007 | Cycle 1(1): loaded http://localhost:52582/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52582/tests/kraken/driver.html?testName=audio-fft) 20:20:25 INFO - PROCESS | 7007 | RSS: Main: 167964672 20:20:25 INFO - PROCESS | 7007 | 20:20:27 INFO - PROCESS | 7007 | Cycle 1(1): loaded http://localhost:52582/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52582/tests/kraken/driver.html?testName=audio-oscillator) 20:20:27 INFO - PROCESS | 7007 | RSS: Main: 169795584 20:20:27 INFO - PROCESS | 7007 | 20:20:30 INFO - PROCESS | 7007 | Cycle 1(1): loaded http://localhost:52582/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52582/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:20:30 INFO - PROCESS | 7007 | RSS: Main: 171524096 20:20:30 INFO - PROCESS | 7007 | 20:20:33 INFO - PROCESS | 7007 | Cycle 1(1): loaded http://localhost:52582/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52582/tests/kraken/driver.html?testName=imaging-darkroom) 20:20:34 INFO - PROCESS | 7007 | RSS: Main: 172552192 20:20:34 INFO - PROCESS | 7007 | 20:20:37 INFO - PROCESS | 7007 | Cycle 1(1): loaded http://localhost:52582/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52582/tests/kraken/driver.html?testName=imaging-desaturate) 20:20:38 INFO - PROCESS | 7007 | RSS: Main: 172818432 20:20:38 INFO - PROCESS | 7007 | 20:20:41 INFO - PROCESS | 7007 | Cycle 1(1): loaded http://localhost:52582/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52582/tests/kraken/driver.html?testName=json-parse-financial) 20:20:41 INFO - PROCESS | 7007 | RSS: Main: 171278336 20:20:41 INFO - PROCESS | 7007 | 20:20:43 INFO - PROCESS | 7007 | Cycle 1(1): loaded http://localhost:52582/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52582/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:20:43 INFO - PROCESS | 7007 | RSS: Main: 182816768 20:20:43 INFO - PROCESS | 7007 | 20:20:45 INFO - PROCESS | 7007 | Cycle 1(1): loaded http://localhost:52582/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52582/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:20:46 INFO - PROCESS | 7007 | RSS: Main: 179572736 20:20:46 INFO - PROCESS | 7007 | 20:20:48 INFO - PROCESS | 7007 | Cycle 1(1): loaded http://localhost:52582/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52582/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:20:48 INFO - PROCESS | 7007 | RSS: Main: 198230016 20:20:48 INFO - PROCESS | 7007 | 20:20:51 INFO - PROCESS | 7007 | Cycle 1(1): loaded http://localhost:52582/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52582/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:20:51 INFO - PROCESS | 7007 | RSS: Main: 201555968 20:20:51 INFO - PROCESS | 7007 | 20:20:54 INFO - PROCESS | 7007 | Cycle 1(1): loaded http://localhost:52582/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52582/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:20:54 INFO - PROCESS | 7007 | RSS: Main: 199688192 20:20:54 INFO - PROCESS | 7007 | 20:20:56 INFO - PROCESS | 7007 | Cycle 1(1): loaded http://localhost:52582/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52582/tests/kraken/driver.html?testName=ai-astar) 20:20:56 INFO - PROCESS | 7007 | RSS: Main: 261341184 20:20:56 INFO - PROCESS | 7007 | 20:20:56 INFO - PROCESS | 7007 | __start_tp_report 20:20:56 INFO - PROCESS | 7007 | _x_x_mozilla_page_load 20:20:56 INFO - PROCESS | 7007 | _x_x_mozilla_page_load_details 20:20:56 INFO - PROCESS | 7007 | |i|pagename|runs| 20:20:56 INFO - PROCESS | 7007 | |0;ai-astar;111;111;105;110;112;112;101;111;111;110 20:20:56 INFO - PROCESS | 7007 | |1;audio-beat-detection;153;127;153;171;126;161;155;131;177;134 20:20:56 INFO - PROCESS | 7007 | |2;audio-dft;160;164;161;160;160;161;162;165;163;161 20:20:56 INFO - PROCESS | 7007 | |3;audio-fft;76;72;110;93;73;72;73;119;92;74 20:20:56 INFO - PROCESS | 7007 | |4;audio-oscillator;95;96;141;96;96;97;140;96;96;148 20:20:56 INFO - PROCESS | 7007 | |5;imaging-gaussian-blur;119;115;114;116;115;115;114;114;115;114 20:20:56 INFO - PROCESS | 7007 | |6;imaging-darkroom;146;145;145;145;145;146;145;145;145;147 20:20:56 INFO - PROCESS | 7007 | |7;imaging-desaturate;96;96;96;96;96;96;96;96;96;95 20:20:56 INFO - PROCESS | 7007 | |8;json-parse-financial;56;57;60;57;56;56;56;65;54;54 20:20:56 INFO - PROCESS | 7007 | |9;json-stringify-tinderbox;67;68;67;68;68;68;69;67;68;68 20:20:56 INFO - PROCESS | 7007 | |10;stanford-crypto-aes;89;82;82;83;82;83;82;82;83;89 20:20:56 INFO - PROCESS | 7007 | |11;stanford-crypto-ccm;114;120;125;124;125;137;121;115;116;116 20:20:56 INFO - PROCESS | 7007 | |12;stanford-crypto-pbkdf2;155;143;144;151;154;142;149;149;149;149 20:20:56 INFO - PROCESS | 7007 | |13;stanford-crypto-sha256-iterative;68;71;69;68;71;70;70;69;67;67 20:20:56 INFO - PROCESS | 7007 | __end_tp_report 20:20:56 INFO - PROCESS | 7007 | __start_cc_report 20:20:56 INFO - PROCESS | 7007 | _x_x_mozilla_cycle_collect,1005 20:20:56 INFO - PROCESS | 7007 | __end_cc_report 20:20:56 INFO - PROCESS | 7007 | __startTimestamp1455337256946__endTimestamp 20:20:56 INFO - PROCESS | 7007 | 20:20:56 INFO - PROCESS | 7007 | ------- Summary: start ------- 20:20:56 INFO - PROCESS | 7007 | Number of tests: 14 20:20:56 INFO - PROCESS | 7007 | 20:20:56 INFO - PROCESS | 7007 | [#0] ai-astar Cycles:10 Average:109.40 Median:111.00 stddev:3.57 (3.2%) stddev-sans-first:3.73 20:20:56 INFO - PROCESS | 7007 | Values: 111.0 111.0 105.0 110.0 112.0 112.0 101.0 111.0 111.0 110.0 20:20:56 INFO - PROCESS | 7007 | 20:20:56 INFO - PROCESS | 7007 | [#1] audio-beat-detection Cycles:10 Average:148.80 Median:154.00 stddev:18.38 (11.9%) stddev-sans-first:19.44 20:20:56 INFO - PROCESS | 7007 | Values: 153.0 127.0 153.0 171.0 126.0 161.0 155.0 131.0 177.0 134.0 20:20:56 INFO - PROCESS | 7007 | 20:20:56 INFO - PROCESS | 7007 | [#2] audio-dft Cycles:10 Average:161.70 Median:161.50 stddev:1.77 (1.1%) stddev-sans-first:1.76 20:20:56 INFO - PROCESS | 7007 | Values: 160.0 164.0 161.0 160.0 160.0 161.0 162.0 165.0 163.0 161.0 20:20:56 INFO - PROCESS | 7007 | 20:20:56 INFO - PROCESS | 7007 | [#3] audio-fft Cycles:10 Average:85.40 Median:73.50 stddev:17.39 (23.7%) stddev-sans-first:18.10 20:20:56 INFO - PROCESS | 7007 | Values: 76.0 72.0 110.0 93.0 73.0 72.0 73.0 119.0 92.0 74.0 20:20:56 INFO - PROCESS | 7007 | 20:20:56 INFO - PROCESS | 7007 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:96.00 stddev:22.80 (23.8%) stddev-sans-first:23.52 20:20:56 INFO - PROCESS | 7007 | Values: 95.0 96.0 141.0 96.0 96.0 97.0 140.0 96.0 96.0 148.0 20:20:56 INFO - PROCESS | 7007 | 20:20:56 INFO - PROCESS | 7007 | [#5] imaging-gaussian-blur Cycles:10 Average:115.10 Median:115.00 stddev:1.52 (1.3%) stddev-sans-first:0.71 20:20:56 INFO - PROCESS | 7007 | Values: 119.0 115.0 114.0 116.0 115.0 115.0 114.0 114.0 115.0 114.0 20:20:56 INFO - PROCESS | 7007 | 20:20:56 INFO - PROCESS | 7007 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 20:20:56 INFO - PROCESS | 7007 | Values: 146.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 147.0 20:20:56 INFO - PROCESS | 7007 | 20:20:56 INFO - PROCESS | 7007 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 20:20:56 INFO - PROCESS | 7007 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 20:20:56 INFO - PROCESS | 7007 | 20:20:56 INFO - PROCESS | 7007 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:56.50 stddev:3.25 (5.7%) stddev-sans-first:3.42 20:20:56 INFO - PROCESS | 7007 | Values: 56.0 57.0 60.0 57.0 56.0 56.0 56.0 65.0 54.0 54.0 20:20:56 INFO - PROCESS | 7007 | 20:20:56 INFO - PROCESS | 7007 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 20:20:56 INFO - PROCESS | 7007 | Values: 67.0 68.0 67.0 68.0 68.0 68.0 69.0 67.0 68.0 68.0 20:20:56 INFO - PROCESS | 7007 | 20:20:56 INFO - PROCESS | 7007 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:83.00 stddev:2.83 (3.4%) stddev-sans-first:2.26 20:20:56 INFO - PROCESS | 7007 | Values: 89.0 82.0 82.0 83.0 82.0 83.0 82.0 82.0 83.0 89.0 20:20:56 INFO - PROCESS | 7007 | 20:20:56 INFO - PROCESS | 7007 | [#11] stanford-crypto-ccm Cycles:10 Average:121.30 Median:122.50 stddev:6.93 (5.7%) stddev-sans-first:6.83 20:20:56 INFO - PROCESS | 7007 | Values: 114.0 120.0 125.0 124.0 125.0 137.0 121.0 115.0 116.0 116.0 20:20:56 INFO - PROCESS | 7007 | 20:20:56 INFO - PROCESS | 7007 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.50 Median:149.00 stddev:4.38 (2.9%) stddev-sans-first:3.96 20:20:56 INFO - PROCESS | 7007 | Values: 155.0 143.0 144.0 151.0 154.0 142.0 149.0 149.0 149.0 149.0 20:20:56 INFO - PROCESS | 7007 | 20:20:56 INFO - PROCESS | 7007 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.50 stddev:1.49 (2.1%) stddev-sans-first:1.54 20:20:56 INFO - PROCESS | 7007 | Values: 68.0 71.0 69.0 68.0 71.0 70.0 70.0 69.0 67.0 67.0 20:20:56 INFO - PROCESS | 7007 | -------- Summary: end -------- 20:20:56 INFO - PROCESS | 7007 | 20:20:57 INFO - TEST-INFO | 7007: exit 0 20:20:57 INFO - TEST-OK | kraken | took 59580ms 20:20:57 INFO - SUITE-END | took 1172s 20:20:58 INFO - Completed test suite (00:19:32) 20:20:58 INFO - Working with test: dromaeo_css 20:20:58 INFO - Generating results file: dromaeo_css 20:20:58 INFO - Working with test: kraken 20:20:58 INFO - Generating results file: kraken 20:20:58 INFO - javascript benchmark 20:20:58 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:20:58 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 20:20:58 INFO - process_Request line: dromaeo_css 6819.70 graph.html#tests=[[72,64,35]] 20:20:58 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:20:58 INFO - process_Request line: kraken 1519.20 graph.html#tests=[[232,64,35]] 20:20:58 INFO - RETURN: dromaeo_css: 6819.70 20:20:58 INFO - RETURN: kraken: 1519.20 20:20:58 INFO - javascript benchmark 20:20:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3092.9381412371754, 3120.7191352778245, 3165.730912872406, 3175.0157451190134, 3196.5524826524284, 5059.114654935385, 5084.669496482726, 5090.567301779349, 5109.514596113368, 5174.586033117351, 4991.800327986876, 5094.414142373628, 5107.361579802525, 5161.9483805162035, 5214.322138122039, 4696.131215725093, 4704.38842950416, 4708.7645617719145, 4747.098051370246, 4836.97581512092, 4758.524147585231, 4776.379070720802, 4794.544518270776, 4834.9033019339595, 4866.026794641069, 4676.602488788457, 4714.0, 4748.074125545537, 4785.880352991168, 4797.664163508556, 4658.510856360067, 4665.393498845162, 4668.533146685339, 4670.7664616769025, 4709.788059537329, 4631.374764406795, 4634.9073018539775, 4647.814087436498, 4666.9766651166865, 4677.158111539921, 4860.635452341088, 4931.506849315076, 5001.8499445016705, 5114.41184263807, 5136.229565565158, 5544.86137846553, 5547.1679248112705, 5550.0, 5553.416891226403, 5554.222408862763, 5580.246666700024, 5581.804636837691, 5591.133374326986, 5591.3569939456665, 5594.0769772987815, 5150.51070148339, 5186.818461353834, 5220.556252718561, 5222.399424066281, 5230.947690523084, 5608.327000759935, 5611.9438805612235, 5613.101903695389, 5617.831465055973, 5656.2929633795775, 5413.079776438015, 5413.160960051198, 5413.458654134633, 5415.918761218585, 5418.241446197536, 5401.162819762943, 5462.262594549765, 5547.861303467364, 5587.245721827501, 5621.18492818539, 5412.83761487156, 5439.673619582838, 5441.972790136024, 5455.918161227585, 5466.863328416822, 5447.891042179134, 5452.0, 5455.699936503451, 5455.727213639302, 5462.945370546244, 4282.079352939133, 4314.115606300701, 4320.157569274024, 4354.346847972766, 4366.694331396835, 3803.448499967489, 3807.9619203807606, 3819.4079917612257, 3848.749831260959, 3850.172212974168, 5061.7975280989085, 5075.213341932006, 5079.390473143247, 5091.694498330112, 5118.10433174193, 5497.752601132958, 5551.8889622208135, 5563.610547261653, 5601.271834661468, 5639.943600563942, 5066.36670416198, 5099.566536844335, 5100.668456550312, 5109.0, 5151.459096794858, 4652.348671186037, 4720.858374248778, 4728.976355118271, 4729.810807567727, 4738.194506933761, 5616.101423772258, 5663.178839068394, 5674.546036317085, 5678.744456499468, 5702.971485142631, 5430.375506816767, 5436.619436639556, 5437.537809286255, 5437.646552974044, 5460.972695136499, 5607.775688972395, 5626.915596265977, 5645.802396916252, 5669.461401166883, 5676.829695109153, 5436.320459942507, 5472.34331880161, 5486.753096110605, 5493.890122197614, 5527.723613819373, 5511.200875873056, 5551.500364967173, 5555.0834112371, 5560.638558493685, 5568.220449137205, 5325.9201111982575, 5412.648177868584, 5414.214938833926, 5433.728313584384, 5463.781448742165, 5449.3188351456065, 5494.011078005998, 5504.22940788282, 5505.449455054462, 5546.861328466659, 5269.552088072403, 5373.0, 5376.542993845567, 5383.9192412114635, 5430.864228394322, 5360.142377219626, 5427.728613569385, 5449.264349312792, 5453.318335208099, 5460.890782184413, 5245.423003469692, 5260.368755749335, 5264.842054738364, 5264.921026184534, 5285.127953887565], "unit": "score", "name": "dojo.html", "value": 5092.1839806180915}, {"lowerIsBetter": false, "replicates": [532.1804421191365, 550.1692444408941, 555.8638133657255, 556.0186271231277, 595.7438301530343, 28684.85657571712, 38406.42390364143, 39409.40885886707, 39428.60571394289, 39429.211415771664, 42209.36685949713, 42932.35601465973, 43005.784971075176, 43007.78496107523, 43049.0, 8563.571821408936, 8807.823843523125, 8841.5579221039, 8866.157715017063, 8871.645134194625, 8702.086280940504, 8845.380823342337, 8845.734627961172, 8848.070952549986, 8853.822923541558, 8755.299576033934, 8890.822183556325, 8893.066228046058, 8893.510856902867, 8902.688405905794, 8762.12378762125, 8854.734357969206, 8857.512836793941, 8860.069692682304, 8869.068747781455, 8684.305255579538, 8818.29453643707, 8835.911640883638, 8838.602262898185, 8841.071687472851, 40009.39985900214, 40529.797351013054, 40542.18915621671, 40568.391474127915, 40573.79713101416, 3151.6533181350032, 3236.8705251790134, 3262.21706790371, 3266.9643256236836, 3697.999999999973, 30191.245218869484, 30638.234044148852, 31066.53400198999, 31353.37293254145, 31717.524237136462, 3597.262561174979, 3710.9443358349645, 3717.8698745544048, 3731.458938453909, 3874.5544262409903, 210649.0, 212207.0, 212254.0, 212421.0, 212867.0, 53506.0, 55485.0, 56611.15083273754, 57115.14327285094, 62954.68522657357, 54945.45054549483, 55058.72470637701, 55111.0, 55267.170992435145, 55395.44604553984, 14276.072055316372, 14286.642833929027, 14370.568882933529, 14411.42354305837, 14491.92754036223, 9536.427814331024, 11055.613053543248, 11289.604863829727, 11294.152938529644, 11325.037371823322, 19826.50433739139, 19876.50308742293, 20141.39575812728, 20167.19331226764, 20168.0, 7803.960980195063, 7953.880691789628, 7999.720009799629, 8017.8797318039105, 8080.878786818203, 905.7826121730737, 991.7173605522391, 1109.5118148014847, 1122.172303916725, 1128.5372997071327, 28924.566131508043, 29002.41995160085, 29041.128766137048, 29120.563191552144, 29590.556141657893, 1009.3187098708489, 1037.9792404151874, 1096.819024860905, 1121.859767529059, 1140.7604403075447, 14863.18252496123, 14875.107493550422, 15118.622034449007, 15238.31427585739, 15321.616959575877, 313590.0, 317646.0, 317664.0, 318090.0, 318196.0, 51217.7439112802, 52024.0, 52045.47954520406, 52063.0, 52077.218841717404, 1337.0840973932693, 1339.852616212216, 1353.1407556201882, 1353.8510763815973, 1365.215001374214, 27600.0, 28350.858245708638, 28610.14169574916, 28661.713382865906, 28852.422951540433, 46895.0, 47468.762656186496, 47485.28772068491, 47547.28679069886, 47595.524044760496, 294992.0, 297251.0, 297374.0, 297945.0, 297947.0, 32618.673813261565, 33226.169345766546, 33257.16857078592, 33376.83311583426, 33402.83298583492, 43275.0, 43632.12735745331, 43828.780856095516, 44297.55702442934, 44765.328520071576, 35736.463953041246, 36146.27707445784, 36495.0, 36544.45183322199, 37729.245415091, 28034.439311214068, 33496.0, 33739.325213496086, 34653.306933861684, 34922.65077349194, 32954.17614559655, 33544.49683254704, 33727.83136084304, 33947.66052339445, 34036.319273614885, 29210.853945730134, 30542.236444089074, 31051.53422698616, 31228.0, 31258.374832503676, 19298.517537061685, 22943.88528057349, 22990.195343162908, 25946.35134121662, 26219.0], "unit": "score", "name": "ext.html", "value": 18206.375794212225}, {"lowerIsBetter": false, "replicates": [358.77576514678327, 361.83717327202766, 366.2437067455702, 367.2196582262691, 368.9354362986477, 13664.863351366483, 13864.930675346634, 16133.19334033298, 16887.32450701972, 17349.47951561452, 15596.220188990561, 16048.83951160488, 16481.83518164821, 17214.762080929493, 17265.827341726577, 4842.75786210689, 4998.075356059141, 4998.875028124307, 5003.699778013312, 5008.123578373788, 3791.9431208531896, 4957.0, 5315.282436871012, 5535.529479994206, 5536.557075433976, 5448.242197228552, 5475.5072043516075, 5496.80761173359, 5536.640118392292, 5538.224648549186, 5590.91613625796, 5591.10542313232, 5591.552675785927, 5592.720363981805, 5600.5799565032785, 5320.414754377015, 5344.7862085516535, 5353.732313384316, 5389.676619402849, 5394.703291318976, 19594.21623135073, 19600.411987640393, 19905.203791848307, 20083.698744518842, 20134.69797953032, 2135.071244008861, 2197.9890100549555, 2523.7223905370392, 2715.0768738628963, 2780.569011803174, 8723.0, 9413.435193888321, 9442.811143777155, 9481.810363792685, 9700.563474643588, 1713.5202143399868, 1864.5991111910869, 1866.7586055273227, 1875.5311172206948, 1883.0867029490687, 60137.0, 60691.39308606946, 63197.36802631961, 63242.05136922904, 64249.35750642481, 10107.494625268708, 10205.520199571021, 10251.641192558225, 10355.119814815675, 10414.635487757892, 13528.0, 13635.113717608323, 13661.385237664328, 13662.93168534151, 13705.109167904253, 7264.491485595958, 7362.521436106743, 7395.083932853696, 7414.332710056121, 7455.515391499535, 7137.250588688217, 7154.0, 7187.856242875113, 7205.279472052753, 7209.351158395664, 4160.875173744732, 4488.192125417456, 4549.977250113729, 4554.271316589396, 4587.266037434061, 1746.1792957310045, 1840.778637384577, 1862.0875770872447, 1862.8602854785945, 1863.6086421851292, 730.5361095704266, 743.650484272391, 745.1951891956674, 806.8184658451802, 879.5294517433142, 13471.932640336736, 15214.47687776281, 15775.132367719885, 16226.756598651029, 16230.688158400731, 883.4831623500324, 886.055808588077, 914.2411798207472, 925.6806401791371, 938.8450905600499, 9431.245500359955, 9605.663801766905, 9637.903620963842, 9709.70870873875, 9732.41605503672, 156747.0, 156839.0, 156859.0, 156963.0, 400164.0, 66189.0, 67631.32368676348, 74903.25096749072, 74926.0, 77060.61469692616, 1029.953652085658, 1128.7065363005677, 1130.327455164176, 1152.1128730877178, 1164.394514852289, 14356.21040842722, 14633.853661463248, 14721.852781472047, 14801.18593477326, 14916.179610121113, 32646.0, 33568.83215583907, 34288.14279642929, 34858.65141348656, 35252.118697032776, 43540.78229608959, 43710.0, 43906.56093439153, 44151.0, 48120.7593962028, 7184.497085203986, 7337.3029562191505, 7770.53376797394, 7798.610069496616, 7809.297163255107, 10972.780544389227, 11113.388763617755, 11301.886981130412, 11536.0, 11598.94200528992, 9404.0, 9627.807443850943, 9835.704928852147, 9929.851052234078, 10278.537465813906, 9527.38072025316, 9784.461854598065, 9909.207263419054, 10057.145142662956, 10239.641612543823, 3314.055494184146, 6679.0, 9079.7742304788, 9856.359336643096, 10476.16190704757, 7643.082830060428, 7653.272939070779, 7765.378769698524, 7779.883301750591, 7884.250996155356, 9680.951595241979, 10318.277720559488, 10581.682549523526, 10620.628278010232, 10709.946450267698], "unit": "score", "name": "jquery.html", "value": 7948.61847484177}, {"lowerIsBetter": false, "replicates": [1336.5474354559383, 1493.4548889655275, 1506.5103841251596, 1689.467817637444, 1831.5787368905144, 7056.470764692643, 7572.469927105105, 7677.654505547257, 7680.423968202394, 7696.576688282143, 7672.1560628330835, 7807.531548107103, 7856.8035799105055, 7862.0958589762195, 7864.646090925908, 2001.449601359623, 2280.144945645383, 2322.8606283622953, 2332.5218330242346, 2363.550925324183, 2344.39045848079, 2356.39911822485, 2356.599378105726, 2356.8114550835976, 2358.9410264743346, 2255.075419078178, 2315.3979965209082, 2317.860928344296, 2319.7796209360085, 2320.6519022146645, 2327.6857624220766, 2352.6588644646517, 2352.6588644646517, 2381.8451800633075, 2385.880705964712, 2316.93049208524, 2326.336993956714, 2341.2156927429332, 2348.8590684558812, 2362.5983582790795, 7954.681812727484, 7995.560244186568, 8004.359651227946, 8026.719064832703, 8033.718819841336, 4827.106985207748, 4893.0, 4913.238448040559, 4925.581325587329, 4939.160342741707, 2919.8102123361914, 2930.58971743956, 2990.416868710602, 3058.617672790901, 3064.080775767261, 952.2477242978039, 958.6836344006462, 979.740368802268, 979.8481235408523, 992.3450522655086, 10750.73123171927, 10763.300385474919, 10918.727031824188, 10923.836142457869, 10929.125669946385, 4342.956570434255, 4400.867973960786, 4439.933400998988, 4470.731756094645, 4491.865244042684, 9319.347645664873, 9328.486933218603, 9329.393589416803, 9336.57985390659, 9374.203192728695, 4859.271109333628, 4897.3878265216845, 4912.975435122801, 4916.508349165055, 4921.114199444063, 4435.135148646047, 4439.64482841372, 4448.088141930896, 4448.110377924428, 4449.488308844459, 3452.3958307296625, 3730.850765969331, 3759.229357981662, 3765.359888818907, 3800.3349413852466, 1205.3310412720848, 1218.214251807579, 1220.951161953512, 1225.4240506961714, 1230.6738714240732, 1291.1284882704138, 1321.4978308242999, 1325.9734805304033, 1367.2480135925202, 1367.863213678624, 7429.271109164441, 7673.040869891263, 7689.884651730228, 7700.422468314899, 7705.42209334291, 1109.7835921995134, 1117.675873996532, 1128.8476055732535, 1131.2816361610437, 1135.4969917803503, 5839.649621022667, 5888.0, 5907.350191478934, 5909.261342332208, 5911.556633252523, 9360.719178424659, 9401.34190606651, 9550.0, 9582.233421326277, 9590.568424420917, 9341.532923353805, 9442.669506567374, 9483.478408687588, 9489.715308540755, 9497.240220782322, 7250.4199664026755, 7399.593022383713, 7477.775666730006, 7487.326140647259, 7494.362979146725, 7300.561966281828, 7348.77953661391, 7353.191148973716, 7357.411407087313, 7377.4098072155175, 8064.0, 8095.87856182146, 8316.584170791315, 8331.83336333282, 8334.62494187751, 8316.750497485085, 8450.619722112397, 8451.112633173429, 8470.195331443503, 8476.703315383931, 6233.096201050913, 7019.6841142147705, 7189.3889019431845, 7197.712091516491, 7210.74762383335, 6715.294894036056, 6751.257361690308, 7287.489875708649, 7353.889691654736, 7415.8887616684715, 6547.574407663486, 6551.574147680385, 6817.965910170417, 6821.897671534832, 6974.337437943387, 6991.965040174767, 7038.190608080136, 7056.6471676417, 7073.363397294268, 7118.679659415235, 6992.056072430157, 7033.613151276524, 7069.081019467436, 7071.681774320065, 7073.3987611053635, 6538.738450461929, 6601.669916504059, 6605.9009114864275, 6611.471082313499, 6635.933640663725, 6709.4632429404555, 6752.797416077526, 6754.86490270182, 6761.966190169018, 6878.037074809631], "unit": "score", "name": "mootools.html", "value": 4562.672781914521}, {"lowerIsBetter": false, "replicates": [335.85893924551686, 338.4128536988325, 341.6822355209655, 346.6169882280082, 355.05024060637805, 5673.23411339469, 5855.443732845378, 5910.734016969242, 5914.34942156363, 5917.526597872171, 5714.0, 5770.682612456313, 5831.5626328025355, 5849.151872978416, 5849.853753656161, 4579.061292435051, 4580.541945805426, 4580.854786303425, 4588.678792484528, 4593.747343896084, 4391.253486907218, 4452.97773511132, 4552.954470455303, 4571.131485017836, 4599.724016559017, 4530.207213737599, 4536.432945881765, 4544.4092268005115, 4560.794764235618, 4562.361269422284, 4562.064776720765, 4567.0409214065085, 4572.45130584332, 4573.771311434415, 4574.428196475457, 4034.616711412411, 4038.172174704179, 4042.3734321180264, 4047.797610119482, 4054.6553542948886, 5534.183309995808, 5560.972195138998, 5620.0, 5626.381098079208, 5629.915551266734, 5313.0, 5313.8937221255355, 5313.920291195596, 5314.5216930476445, 5315.734213289359, 5953.315368732608, 6216.906746398808, 6217.87564248717, 6223.657698826562, 6223.937760622381, 4337.63130133939, 4453.198424283628, 4455.77721113943, 4470.038941627533, 4480.260756975095, 6438.678066096723, 6478.740850366027, 6479.64361960092, 6481.254655714606, 6495.1556297681, 4557.384753058294, 4570.131674981742, 4578.153041687232, 4581.198290299251, 4584.014436896084, 4542.863714088583, 4636.542632404831, 4638.1883170445035, 4639.350490931272, 4671.672982891233, 5279.9208011879855, 5292.629515933924, 5298.258243845865, 5298.4634456007325, 5301.840944771663, 6282.057691346243, 6286.622802631857, 6289.182406287154, 6289.245290565162, 6290.370962903673, 1615.7657139714674, 1635.582926353772, 1636.648120654065, 1641.5896025993502, 1642.3184378482795, 1102.1733699725205, 1103.3104309806372, 1116.0123290887623, 1118.5246270335076, 1144.4506636814376, 5860.560457965669, 5873.236479257755, 5874.9118763218585, 5878.911816322673, 5883.411658834168, 6413.262474815456, 6418.454431373386, 6418.74325027003, 6421.711023003976, 6422.357764223634, 5768.682722450221, 5869.20765696634, 5874.559408044413, 5877.941220587825, 5879.647221166658, 3414.3854106260615, 3469.0, 3473.166440054419, 3474.982625086858, 3480.443129099332, 6653.733850646016, 6656.234533028667, 6663.900041499382, 6675.632840193836, 6675.699593518303, 6536.803895883131, 6537.9673101635135, 6545.280019197884, 6547.083408322838, 6550.803475895731, 6477.222733272038, 6648.135742353463, 6650.933490665128, 6716.597004179863, 6722.798316050526, 6152.969235153974, 6271.310155882758, 6402.903956440564, 6403.9359606405205, 6404.551681382259, 6379.393957574023, 6390.520710946605, 6401.743930242738, 6408.935910640834, 6415.6471394071905, 6697.430718388797, 6702.966485167543, 6707.8993815091835, 6710.194776626836, 6718.462522998246, 4295.570442955679, 4614.238650622609, 4616.6075883550275, 4622.191116554657, 4622.491525932212, 6415.903761443488, 6455.838604034937, 6506.186726659168, 6515.413612774873, 6516.478681705357, 6191.473724733448, 6236.968815155895, 6246.593971391845, 6247.250329960434, 6248.343923888108, 6150.261968563801, 6207.410296021871, 6250.499960003098, 6250.531210159347, 6252.499800015897, 6135.07973803933, 6135.14108024868, 6139.355367686508, 6141.355157708376, 6143.385661433999, 6265.373462653698, 6267.2792628848265, 6270.905936411049, 6276.874462510633, 6278.246610406781, 6046.853431581867, 6084.452399284086, 6124.846878828065, 6133.570650054453, 6147.262328520606], "unit": "score", "name": "prototype.html", "value": 4746.298434732551}, {"lowerIsBetter": false, "replicates": [688.8518968421788, 706.922238553759, 733.8458923626039, 801.8195905921168, 812.1472453923379, 13406.865931340684, 13575.864241357596, 13592.0, 13641.113327633697, 13652.726945461085, 12675.429605667745, 13466.627462511025, 13739.58781236562, 13769.380377882995, 13789.0, 682.3210905149383, 829.6308142876422, 839.9034111077212, 841.7558907916697, 841.8610929196675, 685.2941470285614, 820.5938060659952, 844.4046946902419, 844.6916875340518, 845.2561745663838, 870.1863757386864, 878.8462019146656, 879.3712495565669, 880.5025160784169, 880.6477409036405, 707.4481904114773, 858.1504310732392, 872.8167084912176, 873.6636394987944, 874.7638137702785, 642.6497558830449, 642.9228492580874, 644.7839973608847, 644.9774257900998, 645.4384685323798, 13654.180749155083, 13687.11033782801, 13695.589132325946, 13784.0, 13797.24115173665, 12456.252624842538, 12813.551525696555, 12916.160449570842, 12952.611421657366, 13204.735905281937, 10449.373037617766, 10478.947605261925, 10517.84223236652, 10548.156147508182, 10635.415052172128, 3541.4156664150382, 3601.9099522511883, 3602.3155600435834, 3602.621724718893, 3730.347189241872, 46717.766411168064, 47227.527724722655, 47702.0, 47786.76106619445, 47799.76100119512, 8997.910020899839, 9268.675596354095, 9964.302498825158, 10027.598896044223, 10114.696559103239, 18049.0, 18201.908990454962, 18229.17968691412, 18313.816861831212, 18338.633227335646, 7411.740589079356, 7508.1741008489025, 7592.544447333178, 7625.389968802482, 7782.221777822172, 4154.605312495369, 4207.831686732497, 4252.383404406344, 4265.253580623378, 4280.72175308604, 3121.641011283686, 3129.5305704144107, 3138.2154461384653, 3153.4323821711855, 3202.3115030268605, 582.4117641182436, 583.0, 583.6089819820645, 596.5198015597399, 612.8406614280319, 653.8790323790114, 669.300580892968, 673.7035704290097, 694.7012784502713, 697.2121502701914, 8173.754787356389, 8728.301735861116, 8791.824163516821, 8917.598708058153, 9021.684241051531, 640.0399400898652, 651.4983462733669, 664.8221501224157, 680.323078536859, 692.7298353642084, 3838.808059597009, 3982.38273067675, 4162.188373267244, 4164.229617520768, 4195.0, 57096.429035709945, 57590.0, 57726.0, 57728.422715773144, 57771.42228577661, 50198.74900625474, 50296.0, 51677.741611291705, 51844.0, 51854.0, 44776.3283550747, 44848.0, 44885.61296154656, 45352.052116612314, 45517.772411138394, 8209.38429617793, 8216.753497395088, 8387.077421483755, 8405.453645513022, 8512.489250644981, 34863.825680871436, 35124.29751404907, 35911.0, 35953.64046359503, 36008.459873102445, 40457.0, 41856.79071604623, 44397.0, 44960.0, 45006.77496612496, 10420.478976051016, 10551.683449496528, 10625.840612390975, 10641.680749577525, 10874.619388321371, 11783.234089784137, 12351.19717218378, 12414.503419863466, 12472.376381181086, 12599.496020159091, 11325.943370283096, 11359.716007099558, 11392.886071139514, 11409.315441073562, 11547.94226028898, 11713.590024349107, 11827.940860295988, 11862.82205766897, 12036.63890083299, 12145.089118315986, 8756.562171891508, 10531.0, 10956.178286628376, 11032.834507482556, 11462.0, 8306.62620182081, 8506.872396914176, 9114.544272786467, 9281.0, 9289.535523223947, 8936.597853096497, 9216.815663686823, 9278.0, 9415.670451534163, 9418.387804792666], "unit": "score", "name": "yui.html", "value": 6303.186073514631}], "name": "dromaeo_css", "value": 6819.69835959777}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 111.0, 105.0, 110.0, 112.0, 112.0, 101.0, 111.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.4}, {"lowerIsBetter": true, "replicates": [153.0, 127.0, 153.0, 171.0, 126.0, 161.0, 155.0, 131.0, 177.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 148.8}, {"lowerIsBetter": true, "replicates": [160.0, 164.0, 161.0, 160.0, 160.0, 161.0, 162.0, 165.0, 163.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [76.0, 72.0, 110.0, 93.0, 73.0, 72.0, 73.0, 119.0, 92.0, 74.0], "unit": "score", "name": "audio-fft", "value": 85.4}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 141.0, 96.0, 96.0, 97.0, 140.0, 96.0, 96.0, 148.0], "unit": "score", "name": "audio-oscillator", "value": 110.1}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 114.0, 116.0, 115.0, 115.0, 114.0, 114.0, 115.0, 114.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.1}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 60.0, 57.0, 56.0, 56.0, 56.0, 65.0, 54.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.1}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 68.0, 68.0, 68.0, 69.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [89.0, 82.0, 82.0, 83.0, 82.0, 83.0, 82.0, 82.0, 83.0, 89.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.7}, {"lowerIsBetter": true, "replicates": [114.0, 120.0, 125.0, 124.0, 125.0, 137.0, 121.0, 115.0, 116.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.3}, {"lowerIsBetter": true, "replicates": [155.0, 143.0, 144.0, 151.0, 154.0, 142.0, 149.0, 149.0, 149.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.5}, {"lowerIsBetter": true, "replicates": [68.0, 71.0, 69.0, 68.0, 71.0, 70.0, 70.0, 69.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.0}], "name": "kraken", "value": 1519.2}]} 20:20:58 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1519.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6819.70"}}} 20:20:58 INFO - Return code: 0 20:20:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:20:58 INFO - # TBPL SUCCESS # 20:20:58 INFO - Running post-action listener: _resource_record_post_action 20:20:58 INFO - Running post-run listener: _resource_record_post_run 20:20:59 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534212608; Read time: 12; Write time: 508080 20:20:59 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 240164864; Read time: 0; Write time: 282144 20:20:59 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293986304; Read time: 12; Write time: 225936 20:20:59 INFO - Running post-run listener: _upload_blobber_files 20:20:59 INFO - Blob upload gear active. 20:20:59 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:20:59 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 20:20:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 20:20:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 20:20:59 INFO - (blobuploader) - INFO - Open directory for files ... 20:20:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:20:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:20:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:21:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:21:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:21:00 INFO - (blobuploader) - INFO - Done attempting. 20:21:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 20:21:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:21:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:21:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:21:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:21:01 INFO - (blobuploader) - INFO - Done attempting. 20:21:01 INFO - (blobuploader) - INFO - Iteration through files over. 20:21:01 INFO - Return code: 0 20:21:01 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:21:01 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:21:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a21af272006cb21ff45c96b8af506147d173acae18ea15adac06ccc76df8f3a06e6b0cb3000b5faf241098eaf2430d9cd7dcd014e44d3f823ff7804b1e90a76d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5062f107ead7cba491351fffcf2b23e4540fc20fe27114466ab646de2452deda2afefa819e62e9913c164aa700940dcbe8a9cfbad5929c18028c1859b94ee5c7"} 20:21:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:21:01 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:21:01 INFO - Contents: 20:21:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a21af272006cb21ff45c96b8af506147d173acae18ea15adac06ccc76df8f3a06e6b0cb3000b5faf241098eaf2430d9cd7dcd014e44d3f823ff7804b1e90a76d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5062f107ead7cba491351fffcf2b23e4540fc20fe27114466ab646de2452deda2afefa819e62e9913c164aa700940dcbe8a9cfbad5929c18028c1859b94ee5c7"} 20:21:01 INFO - Running post-run listener: copy_logs_to_upload_dir 20:21:01 INFO - Copying logs to upload dir... 20:21:01 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 20:21:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.957707 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-02-12 20:21:01.455488) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-12 20:21:01.458643) ========= 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=0333a256a5e4f052382dd180000001b1-1455335345.413220-2075552826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a21af272006cb21ff45c96b8af506147d173acae18ea15adac06ccc76df8f3a06e6b0cb3000b5faf241098eaf2430d9cd7dcd014e44d3f823ff7804b1e90a76d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5062f107ead7cba491351fffcf2b23e4540fc20fe27114466ab646de2452deda2afefa819e62e9913c164aa700940dcbe8a9cfbad5929c18028c1859b94ee5c7"} build_url:https://queue.taskcluster.net/v1/task/aj-cjXBTSpWlm0oRWAdjEQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011444 build_url: 'https://queue.taskcluster.net/v1/task/aj-cjXBTSpWlm0oRWAdjEQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a21af272006cb21ff45c96b8af506147d173acae18ea15adac06ccc76df8f3a06e6b0cb3000b5faf241098eaf2430d9cd7dcd014e44d3f823ff7804b1e90a76d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5062f107ead7cba491351fffcf2b23e4540fc20fe27114466ab646de2452deda2afefa819e62e9913c164aa700940dcbe8a9cfbad5929c18028c1859b94ee5c7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-12 20:21:01.483123) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 20:21:01.483453) ========= 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=0333a256a5e4f052382dd180000001b1-1455335345.413220-2075552826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004618 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 20:21:01.569846) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-12 20:21:01.570482) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-12 20:21:01.571076) ========= ========= Total master_lag: 0.31 =========