builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-065 starttime: 1457052438.55 results: success (0) buildid: 20160303143009 builduid: d7f1e57e3deb4dbd95167b598bdfce68 revision: ad2c21a89e6e0f298d7c421426114d7849e594a8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 16:47:18.548208) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 16:47:18.548597) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 16:47:18.548905) ========= 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=523ca41ca1e0623de333ad52000001bf-1457050260.958677-1444022643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006308 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 16:47:18.571839) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 16:47:18.572114) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 16:47:18.584926) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 16:47:18.585189) ========= 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=523ca41ca1e0623de333ad52000001bf-1457050260.958677-1444022643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 16:47:18.634120) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 16:47:18.634382) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 16:47:18.634724) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 16:47:18.635001) ========= 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=523ca41ca1e0623de333ad52000001bf-1457050260.958677-1444022643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-03 16:47:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 31.7M=0s 2016-03-03 16:47:18 (31.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.083398 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 16:47:18.730264) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 16:47:18.730550) ========= 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=523ca41ca1e0623de333ad52000001bf-1457050260.958677-1444022643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020560 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 16:47:18.832245) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 16:47:18.832615) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ad2c21a89e6e0f298d7c421426114d7849e594a8 --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 ad2c21a89e6e0f298d7c421426114d7849e594a8 --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=523ca41ca1e0623de333ad52000001bf-1457050260.958677-1444022643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-03 16:47:19,105 truncating revision to first 12 chars 2016-03-03 16:47:19,105 Setting DEBUG logging. 2016-03-03 16:47:19,105 attempt 1/10 2016-03-03 16:47:19,105 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ad2c21a89e6e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-03 16:47:19,356 unpacking tar archive at: fx-team-ad2c21a89e6e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.544429 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 16:47:19.392919) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-03 16:47:19.393333) ========= echo ad2c21a89e6e0f298d7c421426114d7849e594a8 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ad2c21a89e6e0f298d7c421426114d7849e594a8'] 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=523ca41ca1e0623de333ad52000001bf-1457050260.958677-1444022643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False ad2c21a89e6e0f298d7c421426114d7849e594a8 program finished with exit code 0 elapsedTime=0.003804 script_repo_revision: 'ad2c21a89e6e0f298d7c421426114d7849e594a8' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-03 16:47:19.443112) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 16:47:19.443397) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 16:47:19.453873) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-03-03 16:47:19.454161) ========= /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=523ca41ca1e0623de333ad52000001bf-1457050260.958677-1444022643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:47:19 INFO - MultiFileLogger online at 20160303 16:47:19 in /builds/slave/test-pgo 16:47:19 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 16:47:19 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:47:19 INFO - {'append_to_log': False, 16:47:19 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:47:19 INFO - 'blob_upload_branch': 'Fx-Team', 16:47:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:47:19 INFO - 'branch': 'Fx-Team', 16:47:19 INFO - 'buildbot_json_path': 'buildprops.json', 16:47:19 INFO - 'config_files': ('talos/linux_config.py',), 16:47:19 INFO - 'default_actions': ('clobber', 16:47:19 INFO - 'read-buildbot-config', 16:47:19 INFO - 'download-and-extract', 16:47:19 INFO - 'populate-webroot', 16:47:19 INFO - 'create-virtualenv', 16:47:19 INFO - 'install', 16:47:19 INFO - 'run-tests'), 16:47:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:47:19 INFO - 'download_minidump_stackwalk': True, 16:47:19 INFO - 'download_symbols': 'ondemand', 16:47:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:47:19 INFO - 'tooltool.py': '/tools/tooltool.py', 16:47:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:47:19 INFO - '/tools/misc-python/virtualenv.py')}, 16:47:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:47:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:47:19 INFO - 'installer_path': 'installer.exe', 16:47:19 INFO - 'log_level': 'info', 16:47:19 INFO - 'log_name': 'talos', 16:47:19 INFO - 'log_to_console': True, 16:47:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:47:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:47:19 INFO - 'opt_config_files': (), 16:47:19 INFO - 'pip_index': False, 16:47:19 INFO - 'sps_profile': False, 16:47:19 INFO - 'sps_profile_interval': 0, 16:47:19 INFO - 'suite': 'dromaeojs', 16:47:19 INFO - 'system_bits': '32', 16:47:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:47:19 INFO - 'title': 'talos-linux64-ix-065', 16:47:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:47:19 INFO - 'use_talos_json': True, 16:47:19 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:47:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:47:19 INFO - 'work_dir': 'build'} 16:47:19 INFO - ##### 16:47:19 INFO - ##### Running clobber step. 16:47:19 INFO - ##### 16:47:19 INFO - Running pre-action listener: _resource_record_pre_action 16:47:19 INFO - Running main action method: clobber 16:47:19 INFO - rmtree: /builds/slave/test-pgo/build 16:47:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:47:20 INFO - Running post-action listener: _resource_record_post_action 16:47:20 INFO - ##### 16:47:20 INFO - ##### Running read-buildbot-config step. 16:47:20 INFO - ##### 16:47:20 INFO - Running pre-action listener: _resource_record_pre_action 16:47:20 INFO - Running main action method: read_buildbot_config 16:47:20 INFO - Using buildbot properties: 16:47:20 INFO - { 16:47:20 INFO - "project": "", 16:47:20 INFO - "product": "firefox", 16:47:20 INFO - "script_repo_revision": "production", 16:47:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:47:20 INFO - "repository": "", 16:47:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 16:47:20 INFO - "buildid": "20160303143009", 16:47:20 INFO - "pgo_build": "True", 16:47:20 INFO - "basedir": "/builds/slave/test-pgo", 16:47:20 INFO - "buildnumber": 971, 16:47:20 INFO - "slavename": "talos-linux64-ix-065", 16:47:20 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:47:20 INFO - "platform": "ubuntu64_hw", 16:47:20 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 16:47:20 INFO - "branch": "fx-team", 16:47:20 INFO - "repo_path": "integration/fx-team", 16:47:20 INFO - "revision": "ad2c21a89e6e0f298d7c421426114d7849e594a8", 16:47:20 INFO - "stage_platform": "linux64-pgo", 16:47:20 INFO - "builduid": "d7f1e57e3deb4dbd95167b598bdfce68", 16:47:20 INFO - "slavebuilddir": "test" 16:47:20 INFO - } 16:47:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/YrtD-JHvS0mko2YfDmCp_Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 16:47:20 INFO - Running post-action listener: _resource_record_post_action 16:47:20 INFO - ##### 16:47:20 INFO - ##### Running download-and-extract step. 16:47:20 INFO - ##### 16:47:20 INFO - Running pre-action listener: _resource_record_pre_action 16:47:20 INFO - Running main action method: download_and_extract 16:47:20 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:47:20 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')]} 16:47:20 INFO - https://queue.taskcluster.net/v1/task/YrtD-JHvS0mko2YfDmCp_Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:47:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrtD-JHvS0mko2YfDmCp_Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 16:47:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrtD-JHvS0mko2YfDmCp_Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 16:47:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrtD-JHvS0mko2YfDmCp_Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 16:47:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrtD-JHvS0mko2YfDmCp_Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:47:21 INFO - Downloaded 1448 bytes. 16:47:21 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 16:47:21 INFO - Using the following test package requirements: 16:47:21 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 16:47:21 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:47:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:47:21 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:47:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:47:21 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:47:21 INFO - u'jsshell-linux-x86_64.zip'], 16:47:21 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:47:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:47:21 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 16:47:21 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:47:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:47:21 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:47:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:47:21 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:47:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:47:21 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 16:47:21 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:47:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:47:21 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:47:21 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')]} 16:47:21 INFO - https://queue.taskcluster.net/v1/task/YrtD-JHvS0mko2YfDmCp_Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:47:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrtD-JHvS0mko2YfDmCp_Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:47:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrtD-JHvS0mko2YfDmCp_Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:47:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrtD-JHvS0mko2YfDmCp_Q/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 16:47:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrtD-JHvS0mko2YfDmCp_Q/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 16:47:25 INFO - Downloaded 23394763 bytes. 16:47:25 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'] 16:47:25 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 16:47:26 INFO - Return code: 0 16:47:26 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 16:47:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:26 INFO - https://queue.taskcluster.net/v1/task/YrtD-JHvS0mko2YfDmCp_Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:47:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrtD-JHvS0mko2YfDmCp_Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:47:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrtD-JHvS0mko2YfDmCp_Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:47:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrtD-JHvS0mko2YfDmCp_Q/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 16:47:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrtD-JHvS0mko2YfDmCp_Q/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 16:47:35 INFO - Downloaded 23394763 bytes. 16:47:35 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'] 16:47:35 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 16:47:36 INFO - Return code: 0 16:47:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:36 INFO - https://queue.taskcluster.net/v1/task/YrtD-JHvS0mko2YfDmCp_Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:47:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrtD-JHvS0mko2YfDmCp_Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 16:47:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrtD-JHvS0mko2YfDmCp_Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 16:47:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrtD-JHvS0mko2YfDmCp_Q/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 16:47:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrtD-JHvS0mko2YfDmCp_Q/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 16:47:37 INFO - Downloaded 10808282 bytes. 16:47:37 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'] 16:47:37 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 16:47:37 INFO - Return code: 0 16:47:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:37 INFO - https://queue.taskcluster.net/v1/task/YrtD-JHvS0mko2YfDmCp_Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:47:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrtD-JHvS0mko2YfDmCp_Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:47:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrtD-JHvS0mko2YfDmCp_Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:47:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrtD-JHvS0mko2YfDmCp_Q/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 16:47:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YrtD-JHvS0mko2YfDmCp_Q/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 16:47:39 INFO - Downloaded 56113851 bytes. 16:47:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YrtD-JHvS0mko2YfDmCp_Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:47:39 INFO - mkdir: /builds/slave/test-pgo/properties 16:47:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:47:39 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:47:39 INFO - Contents: 16:47:39 INFO - build_url:https://queue.taskcluster.net/v1/task/YrtD-JHvS0mko2YfDmCp_Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:47:39 INFO - Running post-action listener: _resource_record_post_action 16:47:39 INFO - Running post-action listener: set_extra_try_arguments 16:47:39 INFO - ##### 16:47:39 INFO - ##### Running populate-webroot step. 16:47:39 INFO - ##### 16:47:39 INFO - Running pre-action listener: _resource_record_pre_action 16:47:39 INFO - Running main action method: populate_webroot 16:47:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:47:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:47:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:47:39 INFO - '--tppagecycles', 16:47:39 INFO - '7'], 16:47:39 INFO - 'tests': ['tsvgm']}}, 16:47:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:47:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:47:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:47:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:47:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:47:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:47:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:47:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:39 INFO - 'talos_options': ['--e10s'], 16:47:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:47:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:39 INFO - 'tests': ['damp', 'tps']}, 16:47:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:39 INFO - 'talos_options': ['--e10s'], 16:47:39 INFO - 'tests': ['damp', 'tps']}, 16:47:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:47:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:47:39 INFO - 'other': {'tests': ['a11yr', 16:47:39 INFO - 'ts_paint', 16:47:39 INFO - 'tpaint', 16:47:39 INFO - 'sessionrestore', 16:47:39 INFO - 'sessionrestore_no_auto_restore']}, 16:47:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:47:39 INFO - 'tests': ['a11yr', 16:47:39 INFO - 'ts_paint', 16:47:39 INFO - 'tpaint', 16:47:39 INFO - 'sessionrestore', 16:47:39 INFO - 'sessionrestore_no_auto_restore']}, 16:47:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:47:39 INFO - 'tests': ['a11yr', 16:47:39 INFO - 'ts_paint', 16:47:39 INFO - 'tpaint', 16:47:39 INFO - 'sessionrestore', 16:47:39 INFO - 'sessionrestore_no_auto_restore']}, 16:47:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:47:39 INFO - 'tests': ['a11yr', 16:47:39 INFO - 'ts_paint', 16:47:39 INFO - 'tpaint', 16:47:39 INFO - 'sessionrestore', 16:47:39 INFO - 'sessionrestore_no_auto_restore']}, 16:47:39 INFO - 'other_l64': {'tests': ['a11yr', 16:47:39 INFO - 'ts_paint', 16:47:39 INFO - 'tpaint', 16:47:39 INFO - 'sessionrestore', 16:47:39 INFO - 'sessionrestore_no_auto_restore']}, 16:47:39 INFO - 'other_nol64': {'tests': ['a11yr', 16:47:39 INFO - 'ts_paint', 16:47:39 INFO - 'tpaint', 16:47:39 INFO - 'sessionrestore', 16:47:39 INFO - 'sessionrestore_no_auto_restore']}, 16:47:39 INFO - 'svgr': {'tests': ['tsvgx', 16:47:39 INFO - 'tsvgr_opacity', 16:47:39 INFO - 'tart', 16:47:39 INFO - 'tscrollx', 16:47:39 INFO - 'cart']}, 16:47:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:47:39 INFO - 'tests': ['tsvgx', 16:47:39 INFO - 'tsvgr_opacity', 16:47:39 INFO - 'tart', 16:47:39 INFO - 'tscrollx', 16:47:39 INFO - 'cart']}, 16:47:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:39 INFO - 'tests': ['tp5o']}, 16:47:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:39 INFO - 'talos_options': ['--e10s'], 16:47:39 INFO - 'tests': ['tp5o']}, 16:47:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:39 INFO - 'talos_options': ['--xperf_path', 16:47:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:47:39 INFO - 'tests': ['tp5n']}, 16:47:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:39 INFO - 'talos_options': ['--e10s', 16:47:39 INFO - '--xperf_path', 16:47:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:47:39 INFO - 'tests': ['tp5n']}}, 16:47:39 INFO - 'talos.zip': {'path': '', 16:47:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:47:39 INFO - Running post-action listener: _resource_record_post_action 16:47:39 INFO - ##### 16:47:39 INFO - ##### Running create-virtualenv step. 16:47:39 INFO - ##### 16:47:39 INFO - Running pre-action listener: _resource_record_pre_action 16:47:39 INFO - Running main action method: create_virtualenv 16:47:39 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:47:39 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 16:47:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:47:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:47:39 INFO - Using real prefix '/usr' 16:47:39 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:47:40 INFO - Installing distribute.............................................................................................................................................................................................done. 16:47:42 INFO - Installing pip.................done. 16:47:42 INFO - Return code: 0 16:47:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:47:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f48777f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12456d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d4920>, '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 0x12d5820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d5cb0>, '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': '523ca41ca1e0623de333ad52000001bf-1457050260.958677-1444022643', '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 16:47:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 16:47:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:47:42 INFO - Using env: {'DISPLAY': ':0', 16:47:42 INFO - 'HOME': '/home/cltbld', 16:47:42 INFO - 'LANG': 'en_US.UTF-8', 16:47:42 INFO - 'LANGUAGE': 'en_US:en', 16:47:42 INFO - 'LOGNAME': 'cltbld', 16:47:42 INFO - 'MAIL': '/var/mail/cltbld', 16:47:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:42 INFO - 'MOZ_NO_REMOTE': '1', 16:47:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:42 INFO - 'NO_EM_RESTART': '1', 16:47:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:47:42 INFO - 'PWD': '/builds/slave/test-pgo', 16:47:42 INFO - 'SHELL': '/bin/bash', 16:47:42 INFO - 'SHLVL': '1', 16:47:42 INFO - 'TERM': 'linux', 16:47:42 INFO - 'TMOUT': '86400', 16:47:42 INFO - 'USER': 'cltbld', 16:47:42 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1457050260.958677-1444022643', 16:47:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:42 INFO - '_': '/tools/buildbot/bin/python'} 16:47:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:42 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 16:47:42 INFO - Cleaning up... 16:47:42 INFO - Return code: 0 16:47:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:47:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f48777f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12456d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d4920>, '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 0x12d5820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d5cb0>, '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': '523ca41ca1e0623de333ad52000001bf-1457050260.958677-1444022643', '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 16:47:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 16:47:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:47:42 INFO - Using env: {'DISPLAY': ':0', 16:47:42 INFO - 'HOME': '/home/cltbld', 16:47:42 INFO - 'LANG': 'en_US.UTF-8', 16:47:42 INFO - 'LANGUAGE': 'en_US:en', 16:47:42 INFO - 'LOGNAME': 'cltbld', 16:47:42 INFO - 'MAIL': '/var/mail/cltbld', 16:47:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:42 INFO - 'MOZ_NO_REMOTE': '1', 16:47:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:42 INFO - 'NO_EM_RESTART': '1', 16:47:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:47:42 INFO - 'PWD': '/builds/slave/test-pgo', 16:47:42 INFO - 'SHELL': '/bin/bash', 16:47:42 INFO - 'SHLVL': '1', 16:47:42 INFO - 'TERM': 'linux', 16:47:42 INFO - 'TMOUT': '86400', 16:47:42 INFO - 'USER': 'cltbld', 16:47:42 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1457050260.958677-1444022643', 16:47:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:42 INFO - '_': '/tools/buildbot/bin/python'} 16:47:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:42 INFO - Downloading/unpacking psutil>=0.7.1 16:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:47:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:47:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:47:44 INFO - Installing collected packages: psutil 16:47:44 INFO - Running setup.py install for psutil 16:47:44 INFO - building 'psutil._psutil_linux' extension 16:47:44 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 16:47:44 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 16:47:45 INFO - building 'psutil._psutil_posix' extension 16:47:45 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 16:47:45 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 16:47:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:47:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:47:45 INFO - Successfully installed psutil 16:47:45 INFO - Cleaning up... 16:47:45 INFO - Return code: 0 16:47:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:45 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 0x7f48777f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12456d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d4920>, '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 0x12d5820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d5cb0>, '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': '523ca41ca1e0623de333ad52000001bf-1457050260.958677-1444022643', '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 16:47:45 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 16:47:45 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 16:47:45 INFO - Using env: {'DISPLAY': ':0', 16:47:45 INFO - 'HOME': '/home/cltbld', 16:47:45 INFO - 'LANG': 'en_US.UTF-8', 16:47:45 INFO - 'LANGUAGE': 'en_US:en', 16:47:45 INFO - 'LOGNAME': 'cltbld', 16:47:45 INFO - 'MAIL': '/var/mail/cltbld', 16:47:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:45 INFO - 'MOZ_NO_REMOTE': '1', 16:47:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:45 INFO - 'NO_EM_RESTART': '1', 16:47:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:47:45 INFO - 'PWD': '/builds/slave/test-pgo', 16:47:45 INFO - 'SHELL': '/bin/bash', 16:47:45 INFO - 'SHLVL': '1', 16:47:45 INFO - 'TERM': 'linux', 16:47:45 INFO - 'TMOUT': '86400', 16:47:45 INFO - 'USER': 'cltbld', 16:47:45 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1457050260.958677-1444022643', 16:47:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:45 INFO - '_': '/tools/buildbot/bin/python'} 16:47:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:47:45 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 16:47:45 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 16:47:45 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 16:47:45 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 16:47:45 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 16:47:45 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 16:47:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:47:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:47:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:47:47 INFO - Installing collected packages: mozsystemmonitor 16:47:47 INFO - Running setup.py install for mozsystemmonitor 16:47:47 INFO - Successfully installed mozsystemmonitor 16:47:47 INFO - Cleaning up... 16:47:47 INFO - Return code: 0 16:47:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:47:47 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')]} 16:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:47 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')]} 16:47:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:47 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 0x7f48777f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12456d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d4920>, '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 0x12d5820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d5cb0>, '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': '523ca41ca1e0623de333ad52000001bf-1457050260.958677-1444022643', '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 16:47:47 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 16:47:47 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 16:47:47 INFO - Using env: {'DISPLAY': ':0', 16:47:47 INFO - 'HOME': '/home/cltbld', 16:47:47 INFO - 'LANG': 'en_US.UTF-8', 16:47:47 INFO - 'LANGUAGE': 'en_US:en', 16:47:47 INFO - 'LOGNAME': 'cltbld', 16:47:47 INFO - 'MAIL': '/var/mail/cltbld', 16:47:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:47 INFO - 'MOZ_NO_REMOTE': '1', 16:47:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:47 INFO - 'NO_EM_RESTART': '1', 16:47:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:47:47 INFO - 'PWD': '/builds/slave/test-pgo', 16:47:47 INFO - 'SHELL': '/bin/bash', 16:47:47 INFO - 'SHLVL': '1', 16:47:47 INFO - 'TERM': 'linux', 16:47:47 INFO - 'TMOUT': '86400', 16:47:47 INFO - 'USER': 'cltbld', 16:47:47 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1457050260.958677-1444022643', 16:47:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:47 INFO - '_': '/tools/buildbot/bin/python'} 16:47:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:47 INFO - Downloading/unpacking blobuploader==1.2.4 16:47:47 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 16:47:47 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 16:47:47 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 16:47:47 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 16:47:47 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 16:47:47 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 16:47:49 INFO - Downloading blobuploader-1.2.4.tar.gz 16:47:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:47:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:47:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:50 INFO - Downloading docopt-0.6.1.tar.gz 16:47:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:47:50 INFO - Installing collected packages: blobuploader, requests, docopt 16:47:50 INFO - Running setup.py install for blobuploader 16:47:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:47:50 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:47:50 INFO - Running setup.py install for requests 16:47:50 INFO - Running setup.py install for docopt 16:47:50 INFO - Successfully installed blobuploader requests docopt 16:47:50 INFO - Cleaning up... 16:47:50 INFO - Return code: 0 16:47:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:47:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:47:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:50 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 0x7f48777f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12456d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d4920>, '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 0x12d5820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d5cb0>, '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': '523ca41ca1e0623de333ad52000001bf-1457050260.958677-1444022643', '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 16:47:50 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 16:47:50 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 16:47:50 INFO - Using env: {'DISPLAY': ':0', 16:47:50 INFO - 'HOME': '/home/cltbld', 16:47:50 INFO - 'LANG': 'en_US.UTF-8', 16:47:50 INFO - 'LANGUAGE': 'en_US:en', 16:47:50 INFO - 'LOGNAME': 'cltbld', 16:47:50 INFO - 'MAIL': '/var/mail/cltbld', 16:47:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:50 INFO - 'MOZ_NO_REMOTE': '1', 16:47:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:50 INFO - 'NO_EM_RESTART': '1', 16:47:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:47:50 INFO - 'PWD': '/builds/slave/test-pgo', 16:47:50 INFO - 'SHELL': '/bin/bash', 16:47:50 INFO - 'SHLVL': '1', 16:47:50 INFO - 'TERM': 'linux', 16:47:50 INFO - 'TMOUT': '86400', 16:47:50 INFO - 'USER': 'cltbld', 16:47:50 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1457050260.958677-1444022643', 16:47:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:50 INFO - '_': '/tools/buildbot/bin/python'} 16:47:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:47:51 INFO - Running setup.py (path:/tmp/pip-pA4Pua-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:47:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:47:51 INFO - Running setup.py (path:/tmp/pip-eSRt3V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:47:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:47:51 INFO - Running setup.py (path:/tmp/pip-s4NnaA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:47:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:47:51 INFO - Running setup.py (path:/tmp/pip-yDnkyh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:47:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:47:51 INFO - Running setup.py (path:/tmp/pip-tX9smJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:47:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:47:51 INFO - Running setup.py (path:/tmp/pip-1zy5OW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:47:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:47:51 INFO - Running setup.py (path:/tmp/pip-ZdRyW5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:47:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:47:51 INFO - Running setup.py (path:/tmp/pip-81cKye-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:47:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:47:51 INFO - Running setup.py (path:/tmp/pip-qJF8dd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:47:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:47:51 INFO - Running setup.py (path:/tmp/pip-fQL1JH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:47:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:47:51 INFO - Running setup.py (path:/tmp/pip-n_JEar-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:47:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:47:51 INFO - Running setup.py (path:/tmp/pip-QMja8V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:47:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:47:51 INFO - Running setup.py (path:/tmp/pip-ZcZkGC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:47:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:47:52 INFO - Running setup.py (path:/tmp/pip-mlXpbK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:47:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:47:52 INFO - Running setup.py (path:/tmp/pip-pH3HKh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:47:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:47:52 INFO - Running setup.py (path:/tmp/pip-CAtBMQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:47:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:47:52 INFO - Running setup.py (path:/tmp/pip-NljlPC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:47:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:47:52 INFO - Running setup.py install for manifestparser 16:47:52 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:47:52 INFO - Running setup.py install for mozcrash 16:47:52 INFO - Running setup.py install for mozdebug 16:47:52 INFO - Running setup.py install for mozdevice 16:47:52 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:47:52 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:47:52 INFO - Running setup.py install for mozfile 16:47:52 INFO - Running setup.py install for mozhttpd 16:47:52 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:47:52 INFO - Running setup.py install for mozinfo 16:47:53 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:47:53 INFO - Running setup.py install for mozInstall 16:47:53 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:47:53 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:47:53 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:47:53 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:47:53 INFO - Running setup.py install for mozleak 16:47:53 INFO - Running setup.py install for mozlog 16:47:53 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:47:53 INFO - Running setup.py install for moznetwork 16:47:53 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:47:53 INFO - Running setup.py install for mozprocess 16:47:53 INFO - Running setup.py install for mozprofile 16:47:53 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:47:53 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:47:53 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:47:53 INFO - Running setup.py install for mozrunner 16:47:53 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:47:53 INFO - Running setup.py install for mozscreenshot 16:47:53 INFO - Running setup.py install for moztest 16:47:54 INFO - Running setup.py install for mozversion 16:47:54 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:47:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:47:54 INFO - Cleaning up... 16:47:54 INFO - Return code: 0 16:47:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:47: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')]} 16:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47: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')]} 16:47:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:54 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 0x7f48777f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12456d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d4920>, '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 0x12d5820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d5cb0>, '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': '523ca41ca1e0623de333ad52000001bf-1457050260.958677-1444022643', '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 16:47:54 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 16:47:54 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 16:47:54 INFO - Using env: {'DISPLAY': ':0', 16:47:54 INFO - 'HOME': '/home/cltbld', 16:47:54 INFO - 'LANG': 'en_US.UTF-8', 16:47:54 INFO - 'LANGUAGE': 'en_US:en', 16:47:54 INFO - 'LOGNAME': 'cltbld', 16:47:54 INFO - 'MAIL': '/var/mail/cltbld', 16:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:54 INFO - 'MOZ_NO_REMOTE': '1', 16:47:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:54 INFO - 'NO_EM_RESTART': '1', 16:47:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:47:54 INFO - 'PWD': '/builds/slave/test-pgo', 16:47:54 INFO - 'SHELL': '/bin/bash', 16:47:54 INFO - 'SHLVL': '1', 16:47:54 INFO - 'TERM': 'linux', 16:47:54 INFO - 'TMOUT': '86400', 16:47:54 INFO - 'USER': 'cltbld', 16:47:54 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1457050260.958677-1444022643', 16:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:54 INFO - '_': '/tools/buildbot/bin/python'} 16:47:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:47:54 INFO - Running setup.py (path:/tmp/pip-IqfYIq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:47:54 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)) 16:47:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:47:54 INFO - Running setup.py (path:/tmp/pip-5fsgiH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:47:54 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)) 16:47:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:47:54 INFO - Running setup.py (path:/tmp/pip-4rM0Ek-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:47:54 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)) 16:47:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:47:54 INFO - Running setup.py (path:/tmp/pip-edBYXV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:47:54 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)) 16:47:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:47:54 INFO - Running setup.py (path:/tmp/pip-qJdVs5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:47:54 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)) 16:47:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:47:54 INFO - Running setup.py (path:/tmp/pip-kqh8y1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:47:54 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)) 16:47:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:47:54 INFO - Running setup.py (path:/tmp/pip-gvOW6H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:47:54 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)) 16:47:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:47:54 INFO - Running setup.py (path:/tmp/pip-ZF4ZEs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:47:54 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)) 16:47:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:47:54 INFO - Running setup.py (path:/tmp/pip-e7DOdm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:47:54 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)) 16:47:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:47:54 INFO - Running setup.py (path:/tmp/pip-0scSqA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:47:55 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)) 16:47:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:47:55 INFO - Running setup.py (path:/tmp/pip-P1T6ut-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:47:55 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)) 16:47:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:47:55 INFO - Running setup.py (path:/tmp/pip-P_MazI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:47:55 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)) 16:47:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:47:55 INFO - Running setup.py (path:/tmp/pip-qxcnq5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:47:55 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)) 16:47:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:47:55 INFO - Running setup.py (path:/tmp/pip-193ZM3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:47:55 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)) 16:47:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:47:55 INFO - Running setup.py (path:/tmp/pip-ZkX7qx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:47:55 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)) 16:47:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:47:55 INFO - Running setup.py (path:/tmp/pip-dFDJlm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:47:55 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)) 16:47:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:47:55 INFO - Running setup.py (path:/tmp/pip-TFyTJ2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:47:55 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)) 16:47:55 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)) 16:47:55 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)) 16:47:55 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)) 16:47:55 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)) 16:47:55 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)) 16:47:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:57 INFO - Downloading blessings-1.6.tar.gz 16:47:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:47:57 INFO - Installing collected packages: blessings 16:47:57 INFO - Running setup.py install for blessings 16:47:57 INFO - Successfully installed blessings 16:47:57 INFO - Cleaning up... 16:47:57 INFO - Return code: 0 16:47:57 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:47:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:47:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:47:57 INFO - Reading from file tmpfile_stdout 16:47:57 INFO - Current package versions: 16:47:57 INFO - argparse == 1.2.1 16:47:57 INFO - blessings == 1.6 16:47:57 INFO - blobuploader == 1.2.4 16:47:57 INFO - docopt == 0.6.1 16:47:57 INFO - manifestparser == 1.1 16:47:57 INFO - mozInstall == 1.12 16:47:57 INFO - mozcrash == 0.16 16:47:57 INFO - mozdebug == 0.1 16:47:57 INFO - mozdevice == 0.48 16:47:57 INFO - mozfile == 1.2 16:47:57 INFO - mozhttpd == 0.7 16:47:57 INFO - mozinfo == 0.9 16:47:57 INFO - mozleak == 0.1 16:47:57 INFO - mozlog == 3.1 16:47:57 INFO - moznetwork == 0.27 16:47:57 INFO - mozprocess == 0.22 16:47:57 INFO - mozprofile == 0.28 16:47:57 INFO - mozrunner == 6.11 16:47:57 INFO - mozscreenshot == 0.1 16:47:57 INFO - mozsystemmonitor == 0.0 16:47:57 INFO - moztest == 0.7 16:47:57 INFO - mozversion == 1.4 16:47:57 INFO - psutil == 3.1.1 16:47:57 INFO - requests == 1.2.3 16:47:57 INFO - wsgiref == 0.1.2 16:47:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:47:57 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')]} 16:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:57 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')]} 16:47:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:57 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 0x7f48777f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12456d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d4920>, '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 0x12d5820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d5cb0>, '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': '523ca41ca1e0623de333ad52000001bf-1457050260.958677-1444022643', '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 16:47:57 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 16:47:57 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 16:47:57 INFO - Using env: {'DISPLAY': ':0', 16:47:57 INFO - 'HOME': '/home/cltbld', 16:47:57 INFO - 'LANG': 'en_US.UTF-8', 16:47:57 INFO - 'LANGUAGE': 'en_US:en', 16:47:57 INFO - 'LOGNAME': 'cltbld', 16:47:57 INFO - 'MAIL': '/var/mail/cltbld', 16:47:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:57 INFO - 'MOZ_NO_REMOTE': '1', 16:47:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:57 INFO - 'NO_EM_RESTART': '1', 16:47:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:47:57 INFO - 'PWD': '/builds/slave/test-pgo', 16:47:57 INFO - 'SHELL': '/bin/bash', 16:47:57 INFO - 'SHLVL': '1', 16:47:57 INFO - 'TERM': 'linux', 16:47:57 INFO - 'TMOUT': '86400', 16:47:57 INFO - 'USER': 'cltbld', 16:47:57 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1457050260.958677-1444022643', 16:47:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:57 INFO - '_': '/tools/buildbot/bin/python'} 16:47:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:58 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)) 16:47:58 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)) 16:47:58 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)) 16:47:58 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)) 16:47:58 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)) 16:47:58 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)) 16:47:58 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)) 16:47:58 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)) 16:47:58 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)) 16:47:58 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)) 16:47:58 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)) 16:47:58 INFO - Cleaning up... 16:47:58 INFO - Return code: 0 16:47:58 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:47: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')]} 16:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47: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')]} 16:47:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:58 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 0x7f48777f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12456d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d4920>, '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 0x12d5820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d5cb0>, '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': '523ca41ca1e0623de333ad52000001bf-1457050260.958677-1444022643', '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 16:47:58 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 16:47:58 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 16:47:58 INFO - Using env: {'DISPLAY': ':0', 16:47:58 INFO - 'HOME': '/home/cltbld', 16:47:58 INFO - 'LANG': 'en_US.UTF-8', 16:47:58 INFO - 'LANGUAGE': 'en_US:en', 16:47:58 INFO - 'LOGNAME': 'cltbld', 16:47:58 INFO - 'MAIL': '/var/mail/cltbld', 16:47:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:58 INFO - 'MOZ_NO_REMOTE': '1', 16:47:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:58 INFO - 'NO_EM_RESTART': '1', 16:47:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:47:58 INFO - 'PWD': '/builds/slave/test-pgo', 16:47:58 INFO - 'SHELL': '/bin/bash', 16:47:58 INFO - 'SHLVL': '1', 16:47:58 INFO - 'TERM': 'linux', 16:47:58 INFO - 'TMOUT': '86400', 16:47:58 INFO - 'USER': 'cltbld', 16:47:58 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1457050260.958677-1444022643', 16:47:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:58 INFO - '_': '/tools/buildbot/bin/python'} 16:47:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:58 INFO - Downloading/unpacking jsonschema 16:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:48:00 INFO - Downloading/unpacking functools32 (from jsonschema) 16:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:00 INFO - Downloading functools32-3.2.3-2.tar.gz 16:48:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:48:00 INFO - warning: no files found matching '*.txt' 16:48:00 INFO - no previously-included directories found matching 'build' 16:48:00 INFO - no previously-included directories found matching 'dist' 16:48:00 INFO - no previously-included directories found matching '.git*' 16:48:00 INFO - Installing collected packages: jsonschema, functools32 16:48:00 INFO - Running setup.py install for functools32 16:48:00 INFO - warning: no files found matching '*.txt' 16:48:00 INFO - no previously-included directories found matching 'build' 16:48:00 INFO - no previously-included directories found matching 'dist' 16:48:00 INFO - no previously-included directories found matching '.git*' 16:48:00 INFO - Successfully installed jsonschema functools32 16:48:00 INFO - Cleaning up... 16:48:00 INFO - Return code: 0 16:48:00 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:48:00 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')]} 16:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:48:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:00 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')]} 16:48:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:48:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:48:00 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 0x7f48777f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12456d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d4920>, '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 0x12d5820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d5cb0>, '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': '523ca41ca1e0623de333ad52000001bf-1457050260.958677-1444022643', '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 16:48:00 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 16:48:00 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 16:48:00 INFO - Using env: {'DISPLAY': ':0', 16:48:00 INFO - 'HOME': '/home/cltbld', 16:48:00 INFO - 'LANG': 'en_US.UTF-8', 16:48:00 INFO - 'LANGUAGE': 'en_US:en', 16:48:00 INFO - 'LOGNAME': 'cltbld', 16:48:00 INFO - 'MAIL': '/var/mail/cltbld', 16:48:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:00 INFO - 'MOZ_NO_REMOTE': '1', 16:48:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:00 INFO - 'NO_EM_RESTART': '1', 16:48:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:48:00 INFO - 'PWD': '/builds/slave/test-pgo', 16:48:00 INFO - 'SHELL': '/bin/bash', 16:48:00 INFO - 'SHLVL': '1', 16:48:00 INFO - 'TERM': 'linux', 16:48:00 INFO - 'TMOUT': '86400', 16:48:00 INFO - 'USER': 'cltbld', 16:48:00 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1457050260.958677-1444022643', 16:48:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:00 INFO - '_': '/tools/buildbot/bin/python'} 16:48:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:48:00 INFO - Downloading/unpacking flake8 16:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:48:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:48:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:48: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 16:48: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 16:48: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 16:48: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 16:48: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 16:48: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 16:48:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:48:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:48: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 16:48: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 16:48: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 16:48: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 16:48: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 16:48: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 16:48:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:48: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 16:48: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 16:48: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 16:48: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 16:48: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 16:48: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 16:48:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:48:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:48:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:48:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:48:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:48:03 INFO - no previously-included directories found matching 'docs/_build' 16:48:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:48:03 INFO - Running setup.py install for pep8 16:48:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:48:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:48:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:48:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:48:03 INFO - no previously-included directories found matching 'docs/_build' 16:48:03 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:48:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:48:03 INFO - Cleaning up... 16:48:03 INFO - Return code: 0 16:48:03 INFO - Running post-action listener: _resource_record_post_action 16:48:03 INFO - Running post-action listener: _start_resource_monitoring 16:48:03 INFO - Starting resource monitoring. 16:48:03 INFO - ##### 16:48:03 INFO - ##### Running install step. 16:48:03 INFO - ##### 16:48:03 INFO - Running pre-action listener: _resource_record_pre_action 16:48:03 INFO - Running main action method: install 16:48:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:48:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:48:03 INFO - Reading from file tmpfile_stdout 16:48:03 INFO - Detecting whether we're running mozinstall >=1.0... 16:48:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:48:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:48:03 INFO - Reading from file tmpfile_stdout 16:48:03 INFO - Output received: 16:48:03 INFO - Usage: mozinstall [options] installer 16:48:03 INFO - Options: 16:48:03 INFO - -h, --help show this help message and exit 16:48:03 INFO - -d DEST, --destination=DEST 16:48:03 INFO - Directory to install application into. [default: 16:48:03 INFO - "/builds/slave/test-pgo"] 16:48:03 INFO - --app=APP Application being installed. [default: firefox] 16:48:03 INFO - mkdir: /builds/slave/test-pgo/build/application 16:48:03 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'] 16:48:03 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 16:48:19 INFO - Reading from file tmpfile_stdout 16:48:19 INFO - Output received: 16:48:19 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:48:19 INFO - Running post-action listener: _resource_record_post_action 16:48:19 INFO - ##### 16:48:19 INFO - ##### Running run-tests step. 16:48:19 INFO - ##### 16:48:19 INFO - Running pre-action listener: _resource_record_pre_action 16:48:19 INFO - Running main action method: run_tests 16:48:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:48:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:48:19 INFO - Python 2.7.3 16:48:19 INFO - Return code: 0 16:48:19 INFO - grabbing minidump binary from tooltool 16:48:19 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')]} 16:48:19 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 0x12d4920>, '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 0x12d5820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d5cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:48:19 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 16:48:19 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 16:48:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:48:20 INFO - Return code: 0 16:48:20 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:48:20 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:48:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:48:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:48:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:48:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:48:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:48:21 INFO - Return code: 0 16:48:21 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/YrtD-JHvS0mko2YfDmCp_Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 16:48:21 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/YrtD-JHvS0mko2YfDmCp_Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 16:48:21 INFO - Using env: {'DISPLAY': ':0', 16:48:21 INFO - 'HOME': '/home/cltbld', 16:48:21 INFO - 'LANG': 'en_US.UTF-8', 16:48:21 INFO - 'LANGUAGE': 'en_US:en', 16:48:21 INFO - 'LOGNAME': 'cltbld', 16:48:21 INFO - 'MAIL': '/var/mail/cltbld', 16:48:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:48:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:48:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:48:21 INFO - 'MOZ_NO_REMOTE': '1', 16:48:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:48:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:48:21 INFO - 'NO_EM_RESTART': '1', 16:48:21 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:48:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:48:21 INFO - 'PWD': '/builds/slave/test-pgo', 16:48:21 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:48:21 INFO - 'SHELL': '/bin/bash', 16:48:21 INFO - 'SHLVL': '1', 16:48:21 INFO - 'TERM': 'linux', 16:48:21 INFO - 'TMOUT': '86400', 16:48:21 INFO - 'USER': 'cltbld', 16:48:21 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1457050260.958677-1444022643', 16:48:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:48:21 INFO - '_': '/tools/buildbot/bin/python'} 16:48:21 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/YrtD-JHvS0mko2YfDmCp_Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 16:48:21 INFO - mozversion application_buildid: 20160303143009 16:48:21 INFO - mozversion application_changeset: ad2c21a89e6e0f298d7c421426114d7849e594a8 16:48:21 INFO - mozversion application_display_name: Nightly 16:48:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:48:21 INFO - mozversion application_name: Firefox 16:48:21 INFO - mozversion application_remotingname: firefox 16:48:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:48:21 INFO - mozversion application_vendor: Mozilla 16:48:21 INFO - mozversion application_version: 47.0a1 16:48:21 INFO - mozversion platform_buildid: 20160303143009 16:48:21 INFO - mozversion platform_changeset: ad2c21a89e6e0f298d7c421426114d7849e594a8 16:48:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:48:21 INFO - mozversion platform_version: 47.0a1 16:48:21 INFO - using testdate: 1457052501 16:48:21 INFO - actual date: 1457052501 16:48:21 INFO - starting webserver on 'localhost:49302' 16:48:21 INFO - SUITE-START | Running 2 tests 16:48:21 INFO - TEST-START | dromaeo_css 16:48:21 INFO - operating with platform_type : linux_ 16:48:21 INFO - Initialising browser for dromaeo_css test... 16:48:21 INFO - TEST-INFO | started process 2291 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpi_Vb06/profile http://localhost:49302/getInfo.html) 16:48:25 INFO - PROCESS | 2291 | __metrics Screen width/height:1600/1200 16:48:25 INFO - PROCESS | 2291 | colorDepth:24 16:48:25 INFO - PROCESS | 2291 | Browser inner width/height: 1024/697 16:48:25 INFO - PROCESS | 2291 | __metrics 16:48:26 INFO - PROCESS | 2291 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:48:26 INFO - PROCESS | 2291 | 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. 16:48:27 INFO - TEST-INFO | 2291: exit 0 16:48:27 INFO - Browser initialized. 16:48:27 INFO - Running cycle 1/1 for dromaeo_css test... 16:48:27 INFO - TEST-INFO | started process 2468 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpi_Vb06/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:48:39 INFO - PROCESS | 2468 | RSS: Main: 153309184 16:48:39 INFO - PROCESS | 2468 | 16:49:30 INFO - PROCESS | 2468 | 1457052570598 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] 16:51:38 INFO - PROCESS | 2468 | Cycle 1(1): loaded http://localhost:49302/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49302/tests/dromaeo/cssquery-ext.html) 16:51:39 INFO - PROCESS | 2468 | RSS: Main: 243867648 16:51:39 INFO - PROCESS | 2468 | 16:54:41 INFO - PROCESS | 2468 | Cycle 1(1): loaded http://localhost:49302/tests/dromaeo/cssquery-ext.html (next: http://localhost:49302/tests/dromaeo/cssquery-jquery.html) 16:54:42 INFO - PROCESS | 2468 | RSS: Main: 243625984 16:54:42 INFO - PROCESS | 2468 | 16:57:44 INFO - PROCESS | 2468 | Cycle 1(1): loaded http://localhost:49302/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49302/tests/dromaeo/cssquery-mootools.html) 16:57:44 INFO - PROCESS | 2468 | RSS: Main: 232976384 16:57:44 INFO - PROCESS | 2468 | 17:00:46 INFO - PROCESS | 2468 | Cycle 1(1): loaded http://localhost:49302/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49302/tests/dromaeo/cssquery-prototype.html) 17:00:47 INFO - PROCESS | 2468 | RSS: Main: 215244800 17:00:47 INFO - PROCESS | 2468 | 17:03:49 INFO - PROCESS | 2468 | Cycle 1(1): loaded http://localhost:49302/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49302/tests/dromaeo/cssquery-yui.html) 17:03:50 INFO - PROCESS | 2468 | RSS: Main: 220020736 17:03:50 INFO - PROCESS | 2468 | 17:06:53 INFO - PROCESS | 2468 | Cycle 1(1): loaded http://localhost:49302/tests/dromaeo/cssquery-yui.html (next: http://localhost:49302/tests/dromaeo/cssquery-dojo.html) 17:06:53 INFO - PROCESS | 2468 | RSS: Main: 271695872 17:06:53 INFO - PROCESS | 2468 | 17:06:53 INFO - PROCESS | 2468 | __start_tp_report 17:06:53 INFO - PROCESS | 2468 | _x_x_mozilla_page_load 17:06:53 INFO - PROCESS | 2468 | _x_x_mozilla_page_load_details 17:06:53 INFO - PROCESS | 2468 | |i|pagename|runs| 17:06:53 INFO - PROCESS | 2468 | |0;dojo.html;3082.630084389873;3119.7348225400838;3157.7947433416825;3163;3183.586133802606;4963.230699241623;4995.650304478688;5042.974785126074;5056.721880296583;5060.190369540875;4970;4994.2258949862735;5002;5068.771905264262;5093.465186155456;4581.427321584802;4592.563706447882;4605.861824145281;4691.15559199344;4760.666753327268;4699.7415142167165;4708.529147085281;4733.408323959505;4736.3369128322065;4752.556359803578;4497.9775101124615;4553.908921821579;4635.2583586626315;4646.186917289478;4681;4528.320751887243;4536.251518499444;4542.545745425464;4548.11311794197;4574.977125114387;4443.533428989942;4477.9104417911785;4494.235979883428;4544.409226800495;4553.043860789238;4740.691855029412;4878.658493905428;4980.526849949249;5010.198368261061;5027.27104569839;5420.891582168335;5422;5434.184872269152;5435.0488664483955;5441.1838224266285;5334.706591137486;5450.945490545123;5459.972700136514;5508.91736623951;5518.558515318765;4947.975260123749;4964.404271487445;4983.8504844854715;5002.099622068026;5015.921576860992;5454.10007348791;5541.889162216733;5541.889162216814;5544.611877168641;5589.35722391922;5299.814506492255;5318.361796584357;5336.91994620081;5341;5342.171963345688;5395.190721391744;5396.64921780083;5419.241306217133;5425.83722488326;5455.754491047913;5370.355557333145;5393.6224464287125;5394.91907621386;5395.190721391823;5450.427705090909;5268.315119034501;5283.867903302448;5375.00562395958;5386.676799392049;5395.136778115561;4104.302268614343;4111.075008123148;4119.073208528117;4146.5024197096545;4158.2307273154565;3725.3108174987715;3737.3459644562095;3737.7383583149463;3770.019794853358;3774.9056273592832;4999.575036121898;5037.82367617139;5064;5067.08792417361;5099.847004589868;5394.244805727201;5444.101723215705;5446.319210098738;5461.1808228766;5476.151196564539;5142.357205349332;5149.871253218699;5170.991656626921;5171.224316352577;5197.064528384927;4478.7760611969925;4575.313702944585;4601.631869450436;4642;4650.627949764011;5670.914936275959;5673.461021202979;5673.77304907799;5679.630823996427;5681.0626246668835;5397.325334333208;5400.513953744182;5410.107332290286;5417.377001644862;5465.07093794048;5593.580481463988;5649.858753531194;5657.717114144359;5714.714264286852;5732.455416735404;5204.427512973494;5241.633085683966;5247.763850626655;5248.895022099613;5254.290670759398;5279.709615971158;5297.099493086108;5300.178472336794;5318.095923692904;5366.248725178556;5306.28365170697;5316.6012549058205;5337.412884582771;5384.946150538444;5404.378496472956;5195.090859099718;5210.843674689765;5214.8957020860125;5236.947630523646;5273.841784746463;5170.1727723565555;5170.663906846043;5173.275741396283;5179.22311653255;5180.222966555047;5234.712090835041;5235.973820130875;5265.3944796348915;5280.049591073644;5309.044372013074;5108.872278193075;5110.259012443249;5112.412072611697;5114.5652619527755;5116.718580478109 17:06:53 INFO - PROCESS | 2468 | |1;ext.html;488.90955173292923;523.4373048972354;528.2657106621797;533.8398480455862;542.0135353656345;28496.28759281019;35913.64086359139;36058;36131.81934090326;36150.276994460095;38718.806405968004;39149.21701565967;39166.21667566647;39235;39285.41071883917;7394.149672787617;8455.619497122629;8620.396572239946;8674.089220631837;10074;10064.849027264598;10149.847752283722;10204.132648724868;10217.744556386075;10230.948845255763;10187.439690817002;10256.641017564387;10296.382217066963;10296.897031029668;10299.124574411184;10148.64479743209;10175.185985121247;10229.488525573728;10232.334898231591;10246.282760206788;10019.148372388283;10187.59249630014;10197.847032294521;10199.898001020043;10377.325473844176;38852.80573597142;39285.41071883895;39306.803465982775;39346;39346.606533934864;3478.2000139967695;3561.6972557332397;3658.067192865802;3882.5729169791302;4209.726367786084;28875.42249155026;30044.8497757512;30047;30091.849540752155;30142.38729543988;3865.439511270878;3920.3335432976464;3976.562578116405;4064.959350406488;4146.979265103655;259060;259148;260496;260519;261978;58239.417605824245;58602.413975860545;58676.41323586795;58711.70644146752;58725;63660.68169659122;63862.680686597196;63920.36079639144;63955.680221598595;64115;14503.347349369304;15703.293351799197;15965.920170399073;16103.436379726654;16115;12350.814737778941;12580.622581322576;12642.936785316198;12650.367481626066;12658.683532911751;17126.62871267608;19718;19749.901250493655;19818.504537386394;19978.400647980583;7368.668409921566;7498.4001279897475;7598.430117741192;7604.619769011638;7634.541927484369;925.842606756853;939.9624015039459;989.8267803134422;996.3175224970918;1022.892596277395;27373;28481.037805193264;28526;28788.568171477444;29008.709912900602;966.3718582921158;1021.4331046269243;1051.059301924773;1073.103958194916;1089.2810744908322;13386.598402047954;13510.662233444242;13717.657058573615;13801.861981380258;13932.651683707785;289026;291606;291809;292217;293054;51085.48914510808;51806;51875.48124518782;51925.48074519282;52004;1259.659891829201;1305.2690493323769;1371.095077249011;1391.6729568551382;1397.1198145168478;25555.105571304914;26270.343241419116;26807.731922681305;28818.85590572034;29834.254143645714;42839.645044369456;43201;43233.7838310819;43252.78373608112;43299.35050974175;192289;192425;193358;193647;193692;27270;30666.540001899542;32148.517772233903;32317.192070198435;32343.676563234065;37688.43467347937;38052;39139.21721565496;39338.213235734554;39383.40924886186;32527.67472325341;32774.836125819216;32999.50500742539;33208.66791332152;33268.334633307684;31612.367752644357;34989;35413.645863542064;35539.82230088833;35585;34359.141021474665;34662.480062798575;34706;34984.825075874454;35339;30668;30895.84552077225;31437.371252575278;31738;31874.681253187173;23560.29319120429;23836;24039.639405408583;24311.27066188017;24443 17:06:53 INFO - PROCESS | 2468 | |2;jquery.html;346.2210027438264;360.0692210635507;361.54445398797515;365.28586613171234;373.7551903503206;16972.4059657912;17069.48791536256;17173.313067477302;17463.301467941266;17475.912620436913;10795.29830561013;11096.55613775448;11116.166287528447;11151.888481115186;15966.680666386694;4815.085133824571;4855.975720121394;4920.581750551208;4936.728479933602;4946.925796113043;5207.140821764423;5234.398044224906;5313.681179129246;5326.840194794162;5332.546733527635;5282.867928301785;5285.445028272034;5286.180642000496;5286.233496143057;5346;4876.049170411771;4944.703317800943;4949.554540091391;4954.033963377143;5099.311592934943;4740.644451666139;4747.52524747526;4747.881302967419;4769.737664428455;4775.044991001813;12638.115331926769;17017.48947531576;20446;20472;20505;2134.3170185540635;2174.423777698911;2254.481469262079;2255.672927425514;2274.4996100857784;9547.474888881177;9694.563744631438;9824.361416507903;11333;13403.46386144553;1847.7967423583395;1887.1790771014653;1892.6025534637743;1893.280553389717;1910.7707075150931;46076.3088553672;56173.15740263899;57885.421145788845;63778.68110659463;67149.3285067148;9240;9358.532073396304;9534.713958581253;9570.33007689455;9607.711768646952;12024.939875300568;12270.263784172977;12349.382530873421;12397.75204495905;12412.62762117138;6708.966455167693;6838.418734407532;7355.742549010759;7396.482246242819;7737.264959828807;7528.134264559536;7601.6579253933705;7602.1257555380735;7708.38332933364;7735.651895664709;4337.783110844508;4342;4351.325544540601;4356.455443069616;4436.157130145262;1751.343246282644;1783.9821601784076;1787.6156626325403;1788.418763901737;1815.282963229517;851.1020872978943;916.3219217778795;919.8804155459748;932.1843387036344;940.6989763275823;16303.347866085462;16933.407330743365;17157.914210429117;17258.568535786453;17570;894.9418287811271;915.5376534849859;927.248928368024;943.551812888886;948.6489998700387;9393.90606093944;9790.608375665037;9821.656242031637;9870.506474676382;10027.849582256273;393955;400863;401000;409061;411120;72037.27962720305;72703.27296726964;74024.62987685027;75933.62033189909;76028.39851721072;990.0396615283307;994.472929347447;1001.3441196016621;1008;1011.367895065584;14878;14943.476978305707;15151.318190681666;15282.388704451698;15597.376104955674;26073.348166295993;33505.16237093994;33515;35139.29721405506;35556.82221588876;38295.2340953185;38995.6100438992;39225.2154956905;39962.80018599889;40030.799846000584;7895.881561776463;8038.557879316693;8080.838383232185;8084.434089613671;8138.755837324889;9633.855492167764;12466.937665311616;12687.175333603287;12737.426815793126;12811.423485943342;9047.773805654911;9901.851472227778;10590.788184236426;10657.360558366523;10777.838332425177;9384.81230375375;10648.8935110651;10732.624358147428;10933.18001149933;11209.607663731731;10273.589056437659;10360.792784144123;10506.264561480928;10675.14598832076;10930.125589952944;7523.699052037857;7577.886331705139;7656.119546252252;7819.530828150329;7905.723299684483;9973.451460169761;10616.787664246825;10714.571417143226;10800;10821.56713731442 17:06:53 INFO - PROCESS | 2468 | |3;mootools.html;1377.5454100146953;1485.4875068101505;1497.4160077569745;1663.1601041474055;1818.4726429335485;6848.178218613761;7628.771136865896;7782;7783.883241751364;7790.493617914845;7356.558606483602;7542.396608271339;7550.924490755091;7554.584497852616;7561.3365059686785;1899.4966333921523;2186.759456459788;2239.4737236749393;2240.2383189715492;2270.3642979965634;2195.220696652689;2228.732552093743;2233.6649502574583;2235.619944609412;2236.7651396603364;2127.5213077057692;2221.0449506712107;2224.088123869214;2225.877576733279;2226.1318085946496;1966.852486063544;2167.2847960173185;2214.7563767985507;2217.8891055447243;2218.7892150245702;2163.707899433572;2200.0869639099915;2200.8899555022344;2202.7907348801837;2207.006846918877;7828.373730101578;7847.332976696931;7886.645100970412;7895.328897043758;7927.08838483576;4629.65277604181;4717.033008233304;4753.3107699383745;4760;4760.547747963972;2851.985740071307;2913.5629655551625;2974.419988102321;2974.5092059810104;3031.8029328093826;901.8737376767258;939.2579861909084;949.8147861167075;969.185883857556;1002.6039714312806;10808.729781755519;10848.511816968177;10853.945730271376;10874.238803283773;10894.945525272324;4119.691023173274;4314.029343397773;4362.280223763107;4366.454193225847;4376.190404775127;9333;9355.06449355059;9373.43759374426;9385;9390.34267601275;4161.417401563784;4741.146593613183;4802.495737947535;4807.423109226916;4814.374131362901;4227.7463352198965;4295;4313.1158112586845;4320.891977700583;4330.285502891988;3570;3634.309481198564;3665.596784353719;3670.2292518570866;3699.0937220380642;1197.9940100299616;1228.956986505468;1229.7540491901655;1238.7832129377502;1251.4493622805937;1092.6121226964472;1102.8897110288906;1112.038087054692;1270.2251626507823;1360.129517109051;7422.48042637021;7615.5430674159725;7622.161562228151;7648.541087534766;7669.118051424046;483.1183090859196;488.4431747807431;496.68708713510256;497.32860638138226;498.5687380415914;5823.970880145572;5826.708664566755;5831.679257640785;5832.88334233313;5873.941260587425;9077.319201059814;9608.183304419063;9609.855852162224;9615.663451779294;9618.51907404627;9405.529723513797;9442.10300021497;9452.338336316392;9471.763205919908;9474.857877131848;7174.139103307636;7472.065991751031;7519.398448124137;7579.5073320234005;7579.5073320235115;6969.616671083139;6997.790066298019;7001.404880585003;7005.0893383859775;7009.684564194726;7962.681492740226;8029.759107226792;8084.948956635835;8133.430659853753;8244.340452763645;8366.790830229049;8601.526916019679;8729.869051964099;8738.650453981769;8745.256653184297;6048.6975651218145;6117.632942023492;6119.653676191231;6903.447724181953;7038.507304488637;7241.746538871114;7272.818179545554;7340.339369456775;7368.37368823656;7379.667914943948;6522.21733391996;6651;6697.497687673346;6702.698378572878;6768.56004359715;6519.6088234704175;6580.5064620154635;6588.308227636221;6626.27111017778;6755.628440435823;6945.027696122648;6974.267701891228;6984.6158461283085;6991.6853741580735;7001.719931202899;6490.545661803629;6556.246031706415;6566.704498297492;6612.669366531558;6656.667166641551;6495.415412612888;6531.150950376421;6561.245456772533;6562.5406221564035;6585.868282634417 17:06:53 INFO - PROCESS | 2468 | |4;prototype.html;308.28170363054085;314.32263472217363;322.7514813593533;327.52508862149887;329.1885502236987;5801.129830525418;5889.941100588992;5890.587658863881;5892.234009578749;5914.64512129272;5794.942050579493;5804.651720896749;5808.273965754281;5812.534997200224;5821.155932389801;4306.332518459643;4379.562043795627;4458.375827384169;4473.2171869922795;4478.283474644058;4483.30508771141;4486.775661216926;4497.9325310120375;4502.797374118156;4512.97743511282;4481.305397663367;4491.910161796762;4493.3484644726495;4495.865124046284;4507.549245075483;4301.397804307399;4374.803133858984;4479.574440428154;4485.282354823213;4513.638908887281;3939.1333906540517;3941.5664276929515;3944.4083387492105;3948.05246740783;3952.150287688161;5572.3870374258795;5573.916391254134;5583.441655834425;5587.357453892773;5592.713675854536;5218.582513398919;5232.424433312332;5233.947660523422;5236.895262094775;5241.79032838686;6179.845503862394;6181.474574661159;6182.474489668383;6190.288116866573;6193.194884665009;4110.630043296118;4194.8112334945;4394.121175764828;4395.670324725626;4399.142167277382;6308.116863639094;6362.300146983828;6418.839529011765;6489.253735820346;6522.054302126166;4292.763897985578;4294.463192100988;4296.720713153635;4296.957030429656;4300.268954277781;4340.52254252032;4346.065595896897;4347.456567929009;4348.391225228471;4351.586599273127;5063.518965698253;5086.262491938722;5087.592992560586;5088.567471764942;5091.007253585515;6208.1308616793685;6212.689365531795;6214.316425193316;6215.875682486416;6221.191245138193;1508.1177511156097;1549.2331296008547;1549.7055559443895;1550.8061492313461;1557.7819105325264;956.9090936361034;1009.0414106598761;1027.897210278981;1041.068243921686;1046.3094357723867;5850.385709500441;5934.703264836741;5984.222051133324;5997.400259974055;6002.6698531580305;6406.359364063556;6411.807645770635;6456.289808121103;6478.02829575558;6481.967590162113;5978.910316345258;5979.312379076375;5981.192539007178;5985.072313791369;5985.461308482258;3422.7775194612273;3456.8098754568236;3458.7060099891287;3460.1003739028033;3461.3769521486374;6546.541742078104;6603.20761508622;6641.070250164981;6654.933450665431;6811.046453496514;6482.060101285381;6499.707513161919;6505.674716264168;6518.250401203923;6594.73621055162;6805.489588280899;6820;6820.317968203339;6823.215330237086;6828;6407.775727849503;6434.163558737334;6436;6443.6455994920725;6447.9355206447335;6279.156376180863;6354.618722876642;6386.744530218739;6407.487401007815;6410.391012853772;6781.38967492928;6793.252742198453;6795.218549866829;6808.795736127726;6823.965880170567;4416.138852923649;4416.933745993749;4422.49141348749;4425.535318791609;4434.37918691377;6426.518011149089;6434.227892652912;6445;6445.677716114082;6445.838854028687;5974.64152150855;6035.059879497196;6244.781432649836;6246.531510136849;6248.343923887926;5868.882622347614;6064.757409703739;6192;6212.161358216764;6221.160143380585;6124.693765311806;6130.785422510191;6138.447539721446;6141.109539116714;6156.507479401726;6242.500599951902;6246;6248.062790581449;6252.468540173954;6282.937170628235;5930.377310382348;6064.878702426015;6065.514758819372;6069.848253793691;6079.939200607937 17:06:53 INFO - PROCESS | 2468 | |5;yui.html;742.6064185981428;764.3808515102763;772.1544908325382;815.6207363575936;823.6787652815399;13743.175409475438;13856.930715346434;13899.096558723675;13923.930380348109;13935.442582296697;14446.349914253857;14827.481038163667;14864.033837800562;14902.776458353133;14977;682.6040896280145;828.7389472316231;832.1054866019053;841.88634534338;842.3850589069951;830.796454868558;836.5022811427222;838.3209600223807;839.2991851803752;841.3101256969287;872.6989188729877;876.2332958661171;877.249951291646;877.473515890467;877.9736607901773;708.8405108850493;862.905080441151;869.1959937058227;874.9475031498131;880.0539420123393;626.6835248199676;631.0534198701947;631.4064779107624;631.5074242091176;632.936706329368;13637.363516377998;13637.863621363858;13657.180569165881;13661.043726939119;13667.316634168252;12970.935145324307;13020.934895325558;13166.144200626928;13245.735085298336;13352.799708004388;10910.61812836547;10974.670759877217;11020.393878336688;11080.445977701083;11209.887901120966;3642.1076836175043;3715.30327324314;3729.1050147964565;3736.8878933632036;3748.6626203641804;50154.24768628473;50385.74807125941;50550.24174637383;50714.492855071716;50781.23828142544;10146.594136234467;10149.238807089498;10267.024632659886;10471.68584942453;10503.05472507478;18649;18827.15277812502;18861.90569047146;18878.622427551647;18889.433317000512;7307.3058059484265;7385.889211661829;7390.150132734697;7405.740799072007;7482.363999060032;4387.100644367897;4558.794854231567;4581.358609794632;4621.95378046222;4634.304854271886;2998.070598114548;3001.1746769638526;3013.261750871007;3039.2098054505545;3053.0535533984535;492.47551357803826;564.8559617297645;570.4067769519653;571.5484767034079;607.6809674920702;495.58618553507506;545.4599946053457;582.825152454262;652.354169372318;666.7233098264263;7728;7967.880481792778;8004.879926801103;8040.919590804017;8135.186481351936;589.8702285497184;645.519088279235;681.0669382945397;681.0873429604354;687.7214728035153;3556.3065202285306;3705.2589482103685;3972.916905045025;4071.206114807584;4185.811638476276;55397.72301138468;59074.40925590775;59585.40414595798;59624.70187649034;59784;51599;52416;52791.20813187728;53373.7331313341;53578.46421535813;44463;47574.28638570424;48120.759396203495;48551.27173092406;48690.5130948686;7956.84086318282;8026.638801254075;8167.3466122711225;8206.343492520704;8271.33829293643;33737.83131084329;34169.31661366709;39204;39423;40416.79791601023;45172.54827451815;47246.291305629755;49958.50041499538;50312.496875032244;51893.740531298616;12109.636710898687;12304.75390492203;12404.875951240372;12422.813657795321;12544.874551254736;12277;12572.1199516033;12764.672093806077;12795.61613151607;13396.129251598615;11496.137789665641;11550.59572914944;11576.47905844256;11921.940390297994;12016.33910134951;11024.118070554498;11990.760184796429;11994.220375675553;12002.39988000579;12003;10684.626038088629;11163.609273675382;11283.323000619988;11553.191276610556;11582.536698531965;8988.235999940078;9030.45817250967;9050.637974481211;9426.340156189;9521.523923803921;8807.031226565201;8866.911330886867;9093.181613654802;9446.433214007182;9731.61073557078 17:06:53 INFO - PROCESS | 2468 | __end_tp_report 17:06:53 INFO - PROCESS | 2468 | __start_cc_report 17:06:53 INFO - PROCESS | 2468 | _x_x_mozilla_cycle_collect,759 17:06:53 INFO - PROCESS | 2468 | __end_cc_report 17:06:53 INFO - PROCESS | 2468 | __startTimestamp1457053613430__endTimestamp 17:06:53 INFO - PROCESS | 2468 | 17:06:53 INFO - PROCESS | 2468 | ------- Summary: start ------- 17:06:53 INFO - PROCESS | 2468 | Number of tests: 6 17:06:53 INFO - PROCESS | 2468 | 17:06:53 INFO - PROCESS | 2468 | [#0] dojo.html Cycles:165 Average:5018.43 Median:5179.22 stddev:546.51 (10.6%) stddev-sans-first:526.66 17:06:53 INFO - PROCESS | 2468 | Values: 3082.6 3119.7 3157.8 3163.0 3183.6 4963.2 4995.7 5043.0 5056.7 5060.2 4970.0 4994.2 5002.0 5068.8 5093.5 4581.4 4592.6 4605.9 4691.2 4760.7 4699.7 4708.5 4733.4 4736.3 4752.6 4498.0 4553.9 4635.3 4646.2 4681.0 4528.3 4536.3 4542.5 4548.1 4575.0 4443.5 4477.9 4494.2 4544.4 4553.0 4740.7 4878.7 4980.5 5010.2 5027.3 5420.9 5422.0 5434.2 5435.0 5441.2 5334.7 5450.9 5460.0 5508.9 5518.6 4948.0 4964.4 4983.9 5002.1 5015.9 5454.1 5541.9 5541.9 5544.6 5589.4 5299.8 5318.4 5336.9 5341.0 5342.2 5395.2 5396.6 5419.2 5425.8 5455.8 5370.4 5393.6 5394.9 5395.2 5450.4 5268.3 5283.9 5375.0 5386.7 5395.1 4104.3 4111.1 4119.1 4146.5 4158.2 3725.3 3737.3 3737.7 3770.0 3774.9 4999.6 5037.8 5064.0 5067.1 5099.8 5394.2 5444.1 5446.3 5461.2 5476.2 5142.4 5149.9 5171.0 5171.2 5197.1 4478.8 4575.3 4601.6 4642.0 4650.6 5670.9 5673.5 5673.8 5679.6 5681.1 5397.3 5400.5 5410.1 5417.4 5465.1 5593.6 5649.9 5657.7 5714.7 5732.5 5204.4 5241.6 5247.8 5248.9 5254.3 5279.7 5297.1 5300.2 5318.1 5366.2 5306.3 5316.6 5337.4 5384.9 5404.4 5195.1 5210.8 5214.9 5236.9 5273.8 5170.2 5170.7 5173.3 5179.2 5180.2 5234.7 5236.0 5265.4 5280.0 5309.0 5108.9 5110.3 5112.4 5114.6 5116.7 17:06:53 INFO - PROCESS | 2468 | 17:06:53 INFO - PROCESS | 2468 | [#1] ext.html Cycles:180 Average:42171.57 Median:31166.61 stddev:65551.87 (210.3%) stddev-sans-first:65661.05 17:06:53 INFO - PROCESS | 2468 | Values: 488.9 523.4 528.3 533.8 542.0 28496.3 35913.6 36058.0 36131.8 36150.3 38718.8 39149.2 39166.2 39235.0 39285.4 7394.1 8455.6 8620.4 8674.1 10074.0 10064.8 10149.8 10204.1 10217.7 10230.9 10187.4 10256.6 10296.4 10296.9 10299.1 10148.6 10175.2 10229.5 10232.3 10246.3 10019.1 10187.6 10197.8 10199.9 10377.3 38852.8 39285.4 39306.8 39346.0 39346.6 3478.2 3561.7 3658.1 3882.6 4209.7 28875.4 30044.8 30047.0 30091.8 30142.4 3865.4 3920.3 3976.6 4065.0 4147.0 259060.0 259148.0 260496.0 260519.0 261978.0 58239.4 58602.4 58676.4 58711.7 58725.0 63660.7 63862.7 63920.4 63955.7 64115.0 14503.3 15703.3 15965.9 16103.4 16115.0 12350.8 12580.6 12642.9 12650.4 12658.7 17126.6 19718.0 19749.9 19818.5 19978.4 7368.7 7498.4 7598.4 7604.6 7634.5 925.8 940.0 989.8 996.3 1022.9 27373.0 28481.0 28526.0 28788.6 29008.7 966.4 1021.4 1051.1 1073.1 1089.3 13386.6 13510.7 13717.7 13801.9 13932.7 289026.0 291606.0 291809.0 292217.0 293054.0 51085.5 51806.0 51875.5 51925.5 52004.0 1259.7 1305.3 1371.1 1391.7 1397.1 25555.1 26270.3 26807.7 28818.9 29834.3 42839.6 43201.0 43233.8 43252.8 43299.4 192289.0 192425.0 193358.0 193647.0 193692.0 27270.0 30666.5 32148.5 32317.2 32343.7 37688.4 38052.0 39139.2 39338.2 39383.4 32527.7 32774.8 32999.5 33208.7 33268.3 31612.4 34989.0 35413.6 35539.8 35585.0 34359.1 34662.5 34706.0 34984.8 35339.0 30668.0 30895.8 31437.4 31738.0 31874.7 23560.3 23836.0 24039.6 24311.3 24443.0 17:06:53 INFO - PROCESS | 2468 | 17:06:53 INFO - PROCESS | 2468 | [#2] jquery.html Cycles:180 Average:23689.36 Median:207728.89 stddev:66164.25 (31.9%) stddev-sans-first:66326.64 17:06:53 INFO - PROCESS | 2468 | Values: 346.2 360.1 361.5 365.3 373.8 16972.4 17069.5 17173.3 17463.3 17475.9 10795.3 11096.6 11116.2 11151.9 15966.7 4815.1 4856.0 4920.6 4936.7 4946.9 5207.1 5234.4 5313.7 5326.8 5332.5 5282.9 5285.4 5286.2 5286.2 5346.0 4876.0 4944.7 4949.6 4954.0 5099.3 4740.6 4747.5 4747.9 4769.7 4775.0 12638.1 17017.5 20446.0 20472.0 20505.0 2134.3 2174.4 2254.5 2255.7 2274.5 9547.5 9694.6 9824.4 11333.0 13403.5 1847.8 1887.2 1892.6 1893.3 1910.8 46076.3 56173.2 57885.4 63778.7 67149.3 9240.0 9358.5 9534.7 9570.3 9607.7 12024.9 12270.3 12349.4 12397.8 12412.6 6709.0 6838.4 7355.7 7396.5 7737.3 7528.1 7601.7 7602.1 7708.4 7735.7 4337.8 4342.0 4351.3 4356.5 4436.2 1751.3 1784.0 1787.6 1788.4 1815.3 851.1 916.3 919.9 932.2 940.7 16303.3 16933.4 17157.9 17258.6 17570.0 894.9 915.5 927.2 943.6 948.6 9393.9 9790.6 9821.7 9870.5 10027.8 393955.0 400863.0 401000.0 409061.0 411120.0 72037.3 72703.3 74024.6 75933.6 76028.4 990.0 994.5 1001.3 1008.0 1011.4 14878.0 14943.5 15151.3 15282.4 15597.4 26073.3 33505.2 33515.0 35139.3 35556.8 38295.2 38995.6 39225.2 39962.8 40030.8 7895.9 8038.6 8080.8 8084.4 8138.8 9633.9 12466.9 12687.2 12737.4 12811.4 9047.8 9901.9 10590.8 10657.4 10777.8 9384.8 10648.9 10732.6 10933.2 11209.6 10273.6 10360.8 10506.3 10675.1 10930.1 7523.7 7577.9 7656.1 7819.5 7905.7 9973.5 10616.8 10714.6 10800.0 10821.6 17:06:53 INFO - PROCESS | 2468 | 17:06:53 INFO - PROCESS | 2468 | [#3] mootools.html Cycles:180 Average:5413.40 Median:6507.51 stddev:2870.31 (44.1%) stddev-sans-first:2862.33 17:06:53 INFO - PROCESS | 2468 | Values: 1377.5 1485.5 1497.4 1663.2 1818.5 6848.2 7628.8 7782.0 7783.9 7790.5 7356.6 7542.4 7550.9 7554.6 7561.3 1899.5 2186.8 2239.5 2240.2 2270.4 2195.2 2228.7 2233.7 2235.6 2236.8 2127.5 2221.0 2224.1 2225.9 2226.1 1966.9 2167.3 2214.8 2217.9 2218.8 2163.7 2200.1 2200.9 2202.8 2207.0 7828.4 7847.3 7886.6 7895.3 7927.1 4629.7 4717.0 4753.3 4760.0 4760.5 2852.0 2913.6 2974.4 2974.5 3031.8 901.9 939.3 949.8 969.2 1002.6 10808.7 10848.5 10853.9 10874.2 10894.9 4119.7 4314.0 4362.3 4366.5 4376.2 9333.0 9355.1 9373.4 9385.0 9390.3 4161.4 4741.1 4802.5 4807.4 4814.4 4227.7 4295.0 4313.1 4320.9 4330.3 3570.0 3634.3 3665.6 3670.2 3699.1 1198.0 1229.0 1229.8 1238.8 1251.4 1092.6 1102.9 1112.0 1270.2 1360.1 7422.5 7615.5 7622.2 7648.5 7669.1 483.1 488.4 496.7 497.3 498.6 5824.0 5826.7 5831.7 5832.9 5873.9 9077.3 9608.2 9609.9 9615.7 9618.5 9405.5 9442.1 9452.3 9471.8 9474.9 7174.1 7472.1 7519.4 7579.5 7579.5 6969.6 6997.8 7001.4 7005.1 7009.7 7962.7 8029.8 8084.9 8133.4 8244.3 8366.8 8601.5 8729.9 8738.7 8745.3 6048.7 6117.6 6119.7 6903.4 7038.5 7241.7 7272.8 7340.3 7368.4 7379.7 6522.2 6651.0 6697.5 6702.7 6768.6 6519.6 6580.5 6588.3 6626.3 6755.6 6945.0 6974.3 6984.6 6991.7 7001.7 6490.5 6556.2 6566.7 6612.7 6656.7 6495.4 6531.2 6561.2 6562.5 6585.9 17:06:53 INFO - PROCESS | 2468 | 17:06:53 INFO - PROCESS | 2468 | [#4] prototype.html Cycles:180 Average:5194.40 Median:5922.51 stddev:1582.58 (26.7%) stddev-sans-first:1543.94 17:06:53 INFO - PROCESS | 2468 | Values: 308.3 314.3 322.8 327.5 329.2 5801.1 5889.9 5890.6 5892.2 5914.6 5794.9 5804.7 5808.3 5812.5 5821.2 4306.3 4379.6 4458.4 4473.2 4478.3 4483.3 4486.8 4497.9 4502.8 4513.0 4481.3 4491.9 4493.3 4495.9 4507.5 4301.4 4374.8 4479.6 4485.3 4513.6 3939.1 3941.6 3944.4 3948.1 3952.2 5572.4 5573.9 5583.4 5587.4 5592.7 5218.6 5232.4 5233.9 5236.9 5241.8 6179.8 6181.5 6182.5 6190.3 6193.2 4110.6 4194.8 4394.1 4395.7 4399.1 6308.1 6362.3 6418.8 6489.3 6522.1 4292.8 4294.5 4296.7 4297.0 4300.3 4340.5 4346.1 4347.5 4348.4 4351.6 5063.5 5086.3 5087.6 5088.6 5091.0 6208.1 6212.7 6214.3 6215.9 6221.2 1508.1 1549.2 1549.7 1550.8 1557.8 956.9 1009.0 1027.9 1041.1 1046.3 5850.4 5934.7 5984.2 5997.4 6002.7 6406.4 6411.8 6456.3 6478.0 6482.0 5978.9 5979.3 5981.2 5985.1 5985.5 3422.8 3456.8 3458.7 3460.1 3461.4 6546.5 6603.2 6641.1 6654.9 6811.0 6482.1 6499.7 6505.7 6518.3 6594.7 6805.5 6820.0 6820.3 6823.2 6828.0 6407.8 6434.2 6436.0 6443.6 6447.9 6279.2 6354.6 6386.7 6407.5 6410.4 6781.4 6793.3 6795.2 6808.8 6824.0 4416.1 4416.9 4422.5 4425.5 4434.4 6426.5 6434.2 6445.0 6445.7 6445.8 5974.6 6035.1 6244.8 6246.5 6248.3 5868.9 6064.8 6192.0 6212.2 6221.2 6124.7 6130.8 6138.4 6141.1 6156.5 6242.5 6246.0 6248.1 6252.5 6282.9 5930.4 6064.9 6065.5 6069.8 6079.9 17:06:53 INFO - PROCESS | 2468 | 17:06:53 INFO - PROCESS | 2468 | [#5] yui.html Cycles:180 Average:14303.91 Median:48620.89 stddev:16687.04 (34.3%) stddev-sans-first:16702.78 17:06:53 INFO - PROCESS | 2468 | Values: 742.6 764.4 772.2 815.6 823.7 13743.2 13856.9 13899.1 13923.9 13935.4 14446.3 14827.5 14864.0 14902.8 14977.0 682.6 828.7 832.1 841.9 842.4 830.8 836.5 838.3 839.3 841.3 872.7 876.2 877.2 877.5 878.0 708.8 862.9 869.2 874.9 880.1 626.7 631.1 631.4 631.5 632.9 13637.4 13637.9 13657.2 13661.0 13667.3 12970.9 13020.9 13166.1 13245.7 13352.8 10910.6 10974.7 11020.4 11080.4 11209.9 3642.1 3715.3 3729.1 3736.9 3748.7 50154.2 50385.7 50550.2 50714.5 50781.2 10146.6 10149.2 10267.0 10471.7 10503.1 18649.0 18827.2 18861.9 18878.6 18889.4 7307.3 7385.9 7390.2 7405.7 7482.4 4387.1 4558.8 4581.4 4622.0 4634.3 2998.1 3001.2 3013.3 3039.2 3053.1 492.5 564.9 570.4 571.5 607.7 495.6 545.5 582.8 652.4 666.7 7728.0 7967.9 8004.9 8040.9 8135.2 589.9 645.5 681.1 681.1 687.7 3556.3 3705.3 3972.9 4071.2 4185.8 55397.7 59074.4 59585.4 59624.7 59784.0 51599.0 52416.0 52791.2 53373.7 53578.5 44463.0 47574.3 48120.8 48551.3 48690.5 7956.8 8026.6 8167.3 8206.3 8271.3 33737.8 34169.3 39204.0 39423.0 40416.8 45172.5 47246.3 49958.5 50312.5 51893.7 12109.6 12304.8 12404.9 12422.8 12544.9 12277.0 12572.1 12764.7 12795.6 13396.1 11496.1 11550.6 11576.5 11921.9 12016.3 11024.1 11990.8 11994.2 12002.4 12003.0 10684.6 11163.6 11283.3 11553.2 11582.5 8988.2 9030.5 9050.6 9426.3 9521.5 8807.0 8866.9 9093.2 9446.4 9731.6 17:06:53 INFO - PROCESS | 2468 | -------- Summary: end -------- 17:06:53 INFO - PROCESS | 2468 | 17:06:54 INFO - TEST-INFO | 2468: exit 0 17:06:54 INFO - TEST-OK | dromaeo_css | took 1112678ms 17:06:54 INFO - TEST-START | kraken 17:06:54 INFO - operating with platform_type : linux_ 17:06:54 INFO - Initialising browser for kraken test... 17:06:54 INFO - TEST-INFO | started process 2691 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpR6rZma/profile http://localhost:49302/getInfo.html) 17:06:58 INFO - PROCESS | 2691 | __metrics Screen width/height:1600/1200 17:06:58 INFO - PROCESS | 2691 | colorDepth:24 17:06:58 INFO - PROCESS | 2691 | Browser inner width/height: 1024/697 17:06:58 INFO - PROCESS | 2691 | __metrics 17:06:58 INFO - PROCESS | 2691 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:06:59 INFO - TEST-INFO | 2691: exit 0 17:06:59 INFO - Browser initialized. 17:06:59 INFO - Running cycle 1/1 for kraken test... 17:06:59 INFO - TEST-INFO | started process 2845 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpR6rZma/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:07:11 INFO - PROCESS | 2845 | RSS: Main: 153337856 17:07:11 INFO - PROCESS | 2845 | 17:07:14 INFO - PROCESS | 2845 | Cycle 1(1): loaded http://localhost:49302/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49302/tests/kraken/driver.html?testName=audio-beat-detection) 17:07:14 INFO - PROCESS | 2845 | RSS: Main: 197255168 17:07:14 INFO - PROCESS | 2845 | 17:07:17 INFO - PROCESS | 2845 | Cycle 1(1): loaded http://localhost:49302/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49302/tests/kraken/driver.html?testName=audio-dft) 17:07:17 INFO - PROCESS | 2845 | RSS: Main: 187240448 17:07:17 INFO - PROCESS | 2845 | 17:07:20 INFO - PROCESS | 2845 | Cycle 1(1): loaded http://localhost:49302/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49302/tests/kraken/driver.html?testName=audio-fft) 17:07:21 INFO - PROCESS | 2845 | RSS: Main: 170024960 17:07:21 INFO - PROCESS | 2845 | 17:07:23 INFO - PROCESS | 2845 | Cycle 1(1): loaded http://localhost:49302/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49302/tests/kraken/driver.html?testName=audio-oscillator) 17:07:24 INFO - PROCESS | 2845 | RSS: Main: 173051904 17:07:24 INFO - PROCESS | 2845 | 17:07:26 INFO - PROCESS | 2845 | Cycle 1(1): loaded http://localhost:49302/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49302/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:07:26 INFO - PROCESS | 2845 | RSS: Main: 174673920 17:07:26 INFO - PROCESS | 2845 | 17:07:29 INFO - PROCESS | 2845 | Cycle 1(1): loaded http://localhost:49302/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49302/tests/kraken/driver.html?testName=imaging-darkroom) 17:07:30 INFO - PROCESS | 2845 | RSS: Main: 176246784 17:07:30 INFO - PROCESS | 2845 | 17:07:33 INFO - PROCESS | 2845 | Cycle 1(1): loaded http://localhost:49302/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49302/tests/kraken/driver.html?testName=imaging-desaturate) 17:07:34 INFO - PROCESS | 2845 | RSS: Main: 176234496 17:07:34 INFO - PROCESS | 2845 | 17:07:37 INFO - PROCESS | 2845 | Cycle 1(1): loaded http://localhost:49302/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49302/tests/kraken/driver.html?testName=json-parse-financial) 17:07:37 INFO - PROCESS | 2845 | RSS: Main: 176803840 17:07:37 INFO - PROCESS | 2845 | 17:07:39 INFO - PROCESS | 2845 | Cycle 1(1): loaded http://localhost:49302/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49302/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:07:39 INFO - PROCESS | 2845 | RSS: Main: 187064320 17:07:39 INFO - PROCESS | 2845 | 17:07:41 INFO - PROCESS | 2845 | Cycle 1(1): loaded http://localhost:49302/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49302/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:07:42 INFO - PROCESS | 2845 | RSS: Main: 183607296 17:07:42 INFO - PROCESS | 2845 | 17:07:44 INFO - PROCESS | 2845 | Cycle 1(1): loaded http://localhost:49302/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49302/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:07:44 INFO - PROCESS | 2845 | RSS: Main: 195821568 17:07:44 INFO - PROCESS | 2845 | 17:07:47 INFO - PROCESS | 2845 | Cycle 1(1): loaded http://localhost:49302/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49302/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:07:47 INFO - PROCESS | 2845 | RSS: Main: 200564736 17:07:47 INFO - PROCESS | 2845 | 17:07:50 INFO - PROCESS | 2845 | Cycle 1(1): loaded http://localhost:49302/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49302/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:07:51 INFO - PROCESS | 2845 | RSS: Main: 199880704 17:07:51 INFO - PROCESS | 2845 | 17:07:52 INFO - PROCESS | 2845 | Cycle 1(1): loaded http://localhost:49302/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49302/tests/kraken/driver.html?testName=ai-astar) 17:07:53 INFO - PROCESS | 2845 | RSS: Main: 259891200 17:07:53 INFO - PROCESS | 2845 | 17:07:53 INFO - PROCESS | 2845 | __start_tp_report 17:07:53 INFO - PROCESS | 2845 | _x_x_mozilla_page_load 17:07:53 INFO - PROCESS | 2845 | _x_x_mozilla_page_load_details 17:07:53 INFO - PROCESS | 2845 | |i|pagename|runs| 17:07:53 INFO - PROCESS | 2845 | |0;ai-astar;110;111;107;111;110;111;100;112;110;111 17:07:53 INFO - PROCESS | 2845 | |1;audio-beat-detection;151;132;152;168;128;154;158;128;187;129 17:07:53 INFO - PROCESS | 2845 | |2;audio-dft;162;161;160;160;162;159;160;165;163;162 17:07:53 INFO - PROCESS | 2845 | |3;audio-fft;76;75;109;105;75;75;73;131;105;75 17:07:53 INFO - PROCESS | 2845 | |4;audio-oscillator;92;93;139;94;94;95;138;93;93;145 17:07:53 INFO - PROCESS | 2845 | |5;imaging-gaussian-blur;117;117;116;116;117;117;117;117;117;117 17:07:53 INFO - PROCESS | 2845 | |6;imaging-darkroom;145;145;145;146;146;146;147;146;145;146 17:07:53 INFO - PROCESS | 2845 | |7;imaging-desaturate;96;96;96;95;96;96;95;96;96;96 17:07:53 INFO - PROCESS | 2845 | |8;json-parse-financial;58;59;58;58;58;58;60;67;57;56 17:07:53 INFO - PROCESS | 2845 | |9;json-stringify-tinderbox;77;68;67;67;67;68;67;67;68;68 17:07:53 INFO - PROCESS | 2845 | |10;stanford-crypto-aes;81;84;82;82;82;81;83;83;82;82 17:07:53 INFO - PROCESS | 2845 | |11;stanford-crypto-ccm;116;115;116;115;119;121;121;116;115;115 17:07:53 INFO - PROCESS | 2845 | |12;stanford-crypto-pbkdf2;172;143;158;159;154;141;155;157;149;144 17:07:53 INFO - PROCESS | 2845 | |13;stanford-crypto-sha256-iterative;70;70;73;70;69;68;69;71;71;68 17:07:53 INFO - PROCESS | 2845 | __end_tp_report 17:07:53 INFO - PROCESS | 2845 | __start_cc_report 17:07:53 INFO - PROCESS | 2845 | _x_x_mozilla_cycle_collect,1104 17:07:53 INFO - PROCESS | 2845 | __end_cc_report 17:07:53 INFO - PROCESS | 2845 | __startTimestamp1457053673141__endTimestamp 17:07:53 INFO - PROCESS | 2845 | 17:07:53 INFO - PROCESS | 2845 | ------- Summary: start ------- 17:07:53 INFO - PROCESS | 2845 | Number of tests: 14 17:07:53 INFO - PROCESS | 2845 | 17:07:53 INFO - PROCESS | 2845 | [#0] ai-astar Cycles:10 Average:109.30 Median:111.00 stddev:3.53 (3.2%) stddev-sans-first:3.73 17:07:53 INFO - PROCESS | 2845 | Values: 110.0 111.0 107.0 111.0 110.0 111.0 100.0 112.0 110.0 111.0 17:07:53 INFO - PROCESS | 2845 | 17:07:53 INFO - PROCESS | 2845 | [#1] audio-beat-detection Cycles:10 Average:148.70 Median:153.00 stddev:19.70 (12.9%) stddev-sans-first:20.88 17:07:53 INFO - PROCESS | 2845 | Values: 151.0 132.0 152.0 168.0 128.0 154.0 158.0 128.0 187.0 129.0 17:07:53 INFO - PROCESS | 2845 | 17:07:53 INFO - PROCESS | 2845 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:1.78 (1.1%) stddev-sans-first:1.87 17:07:53 INFO - PROCESS | 2845 | Values: 162.0 161.0 160.0 160.0 162.0 159.0 160.0 165.0 163.0 162.0 17:07:53 INFO - PROCESS | 2845 | 17:07:53 INFO - PROCESS | 2845 | [#3] audio-fft Cycles:10 Average:89.90 Median:75.00 stddev:20.75 (27.7%) stddev-sans-first:21.40 17:07:53 INFO - PROCESS | 2845 | Values: 76.0 75.0 109.0 105.0 75.0 75.0 73.0 131.0 105.0 75.0 17:07:53 INFO - PROCESS | 2845 | 17:07:53 INFO - PROCESS | 2845 | [#4] audio-oscillator Cycles:10 Average:107.60 Median:93.00 stddev:22.90 (24.6%) stddev-sans-first:23.58 17:07:53 INFO - PROCESS | 2845 | Values: 92.0 93.0 139.0 94.0 94.0 95.0 138.0 93.0 93.0 145.0 17:07:53 INFO - PROCESS | 2845 | 17:07:53 INFO - PROCESS | 2845 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 17:07:53 INFO - PROCESS | 2845 | Values: 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 17:07:53 INFO - PROCESS | 2845 | 17:07:53 INFO - PROCESS | 2845 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 17:07:53 INFO - PROCESS | 2845 | Values: 145.0 145.0 145.0 146.0 146.0 146.0 147.0 146.0 145.0 146.0 17:07:53 INFO - PROCESS | 2845 | 17:07:53 INFO - PROCESS | 2845 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 17:07:53 INFO - PROCESS | 2845 | Values: 96.0 96.0 96.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 17:07:53 INFO - PROCESS | 2845 | 17:07:53 INFO - PROCESS | 2845 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:58.00 stddev:3.03 (5.2%) stddev-sans-first:3.20 17:07:53 INFO - PROCESS | 2845 | Values: 58.0 59.0 58.0 58.0 58.0 58.0 60.0 67.0 57.0 56.0 17:07:53 INFO - PROCESS | 2845 | 17:07:53 INFO - PROCESS | 2845 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.00 stddev:3.06 (4.5%) stddev-sans-first:0.53 17:07:53 INFO - PROCESS | 2845 | Values: 77.0 68.0 67.0 67.0 67.0 68.0 67.0 67.0 68.0 68.0 17:07:53 INFO - PROCESS | 2845 | 17:07:53 INFO - PROCESS | 2845 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.00 stddev:0.92 (1.1%) stddev-sans-first:0.87 17:07:53 INFO - PROCESS | 2845 | Values: 81.0 84.0 82.0 82.0 82.0 81.0 83.0 83.0 82.0 82.0 17:07:53 INFO - PROCESS | 2845 | 17:07:53 INFO - PROCESS | 2845 | [#11] stanford-crypto-ccm Cycles:10 Average:116.90 Median:116.00 stddev:2.47 (2.1%) stddev-sans-first:2.60 17:07:53 INFO - PROCESS | 2845 | Values: 116.0 115.0 116.0 115.0 119.0 121.0 121.0 116.0 115.0 115.0 17:07:53 INFO - PROCESS | 2845 | 17:07:53 INFO - PROCESS | 2845 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.20 Median:156.00 stddev:9.33 (6.0%) stddev-sans-first:6.99 17:07:53 INFO - PROCESS | 2845 | Values: 172.0 143.0 158.0 159.0 154.0 141.0 155.0 157.0 149.0 144.0 17:07:53 INFO - PROCESS | 2845 | 17:07:53 INFO - PROCESS | 2845 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.00 stddev:1.52 (2.2%) stddev-sans-first:1.62 17:07:53 INFO - PROCESS | 2845 | Values: 70.0 70.0 73.0 70.0 69.0 68.0 69.0 71.0 71.0 68.0 17:07:53 INFO - PROCESS | 2845 | -------- Summary: end -------- 17:07:53 INFO - PROCESS | 2845 | 17:07:54 INFO - TEST-INFO | 2845: exit 0 17:07:54 INFO - TEST-OK | kraken | took 59986ms 17:07:54 INFO - SUITE-END | took 1172s 17:07:54 INFO - Completed test suite (00:19:32) 17:07:54 INFO - Working with test: dromaeo_css 17:07:54 INFO - Generating results file: dromaeo_css 17:07:54 INFO - Working with test: kraken 17:07:54 INFO - Generating results file: kraken 17:07:54 INFO - javascript benchmark 17:07:54 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:07:54 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 17:07:54 INFO - process_Request line: dromaeo_css 6758.03 graph.html#tests=[[72,64,35]] 17:07:54 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:07:54 INFO - process_Request line: kraken 1524.70 graph.html#tests=[[232,64,35]] 17:07:54 INFO - RETURN: dromaeo_css: 6758.03 17:07:54 INFO - RETURN: kraken: 1524.70 17:07:54 INFO - javascript benchmark 17:07:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3082.630084389873, 3119.7348225400838, 3157.7947433416825, 3163.0, 3183.586133802606, 4963.230699241623, 4995.650304478688, 5042.974785126074, 5056.721880296583, 5060.190369540875, 4970.0, 4994.2258949862735, 5002.0, 5068.771905264262, 5093.465186155456, 4581.427321584802, 4592.563706447882, 4605.861824145281, 4691.15559199344, 4760.666753327268, 4699.7415142167165, 4708.529147085281, 4733.408323959505, 4736.3369128322065, 4752.556359803578, 4497.9775101124615, 4553.908921821579, 4635.2583586626315, 4646.186917289478, 4681.0, 4528.320751887243, 4536.251518499444, 4542.545745425464, 4548.11311794197, 4574.977125114387, 4443.533428989942, 4477.9104417911785, 4494.235979883428, 4544.409226800495, 4553.043860789238, 4740.691855029412, 4878.658493905428, 4980.526849949249, 5010.198368261061, 5027.27104569839, 5420.891582168335, 5422.0, 5434.184872269152, 5435.0488664483955, 5441.1838224266285, 5334.706591137486, 5450.945490545123, 5459.972700136514, 5508.91736623951, 5518.558515318765, 4947.975260123749, 4964.404271487445, 4983.8504844854715, 5002.099622068026, 5015.921576860992, 5454.10007348791, 5541.889162216733, 5541.889162216814, 5544.611877168641, 5589.35722391922, 5299.814506492255, 5318.361796584357, 5336.91994620081, 5341.0, 5342.171963345688, 5395.190721391744, 5396.64921780083, 5419.241306217133, 5425.83722488326, 5455.754491047913, 5370.355557333145, 5393.6224464287125, 5394.91907621386, 5395.190721391823, 5450.427705090909, 5268.315119034501, 5283.867903302448, 5375.00562395958, 5386.676799392049, 5395.136778115561, 4104.302268614343, 4111.075008123148, 4119.073208528117, 4146.5024197096545, 4158.2307273154565, 3725.3108174987715, 3737.3459644562095, 3737.7383583149463, 3770.019794853358, 3774.9056273592832, 4999.575036121898, 5037.82367617139, 5064.0, 5067.08792417361, 5099.847004589868, 5394.244805727201, 5444.101723215705, 5446.319210098738, 5461.1808228766, 5476.151196564539, 5142.357205349332, 5149.871253218699, 5170.991656626921, 5171.224316352577, 5197.064528384927, 4478.7760611969925, 4575.313702944585, 4601.631869450436, 4642.0, 4650.627949764011, 5670.914936275959, 5673.461021202979, 5673.77304907799, 5679.630823996427, 5681.0626246668835, 5397.325334333208, 5400.513953744182, 5410.107332290286, 5417.377001644862, 5465.07093794048, 5593.580481463988, 5649.858753531194, 5657.717114144359, 5714.714264286852, 5732.455416735404, 5204.427512973494, 5241.633085683966, 5247.763850626655, 5248.895022099613, 5254.290670759398, 5279.709615971158, 5297.099493086108, 5300.178472336794, 5318.095923692904, 5366.248725178556, 5306.28365170697, 5316.6012549058205, 5337.412884582771, 5384.946150538444, 5404.378496472956, 5195.090859099718, 5210.843674689765, 5214.8957020860125, 5236.947630523646, 5273.841784746463, 5170.1727723565555, 5170.663906846043, 5173.275741396283, 5179.22311653255, 5180.222966555047, 5234.712090835041, 5235.973820130875, 5265.3944796348915, 5280.049591073644, 5309.044372013074, 5108.872278193075, 5110.259012443249, 5112.412072611697, 5114.5652619527755, 5116.718580478109], "unit": "score", "name": "dojo.html", "value": 4984.35212716719}, {"lowerIsBetter": false, "replicates": [488.90955173292923, 523.4373048972354, 528.2657106621797, 533.8398480455862, 542.0135353656345, 28496.28759281019, 35913.64086359139, 36058.0, 36131.81934090326, 36150.276994460095, 38718.806405968004, 39149.21701565967, 39166.21667566647, 39235.0, 39285.41071883917, 7394.149672787617, 8455.619497122629, 8620.396572239946, 8674.089220631837, 10074.0, 10064.849027264598, 10149.847752283722, 10204.132648724868, 10217.744556386075, 10230.948845255763, 10187.439690817002, 10256.641017564387, 10296.382217066963, 10296.897031029668, 10299.124574411184, 10148.64479743209, 10175.185985121247, 10229.488525573728, 10232.334898231591, 10246.282760206788, 10019.148372388283, 10187.59249630014, 10197.847032294521, 10199.898001020043, 10377.325473844176, 38852.80573597142, 39285.41071883895, 39306.803465982775, 39346.0, 39346.606533934864, 3478.2000139967695, 3561.6972557332397, 3658.067192865802, 3882.5729169791302, 4209.726367786084, 28875.42249155026, 30044.8497757512, 30047.0, 30091.849540752155, 30142.38729543988, 3865.439511270878, 3920.3335432976464, 3976.562578116405, 4064.959350406488, 4146.979265103655, 259060.0, 259148.0, 260496.0, 260519.0, 261978.0, 58239.417605824245, 58602.413975860545, 58676.41323586795, 58711.70644146752, 58725.0, 63660.68169659122, 63862.680686597196, 63920.36079639144, 63955.680221598595, 64115.0, 14503.347349369304, 15703.293351799197, 15965.920170399073, 16103.436379726654, 16115.0, 12350.814737778941, 12580.622581322576, 12642.936785316198, 12650.367481626066, 12658.683532911751, 17126.62871267608, 19718.0, 19749.901250493655, 19818.504537386394, 19978.400647980583, 7368.668409921566, 7498.4001279897475, 7598.430117741192, 7604.619769011638, 7634.541927484369, 925.842606756853, 939.9624015039459, 989.8267803134422, 996.3175224970918, 1022.892596277395, 27373.0, 28481.037805193264, 28526.0, 28788.568171477444, 29008.709912900602, 966.3718582921158, 1021.4331046269243, 1051.059301924773, 1073.103958194916, 1089.2810744908322, 13386.598402047954, 13510.662233444242, 13717.657058573615, 13801.861981380258, 13932.651683707785, 289026.0, 291606.0, 291809.0, 292217.0, 293054.0, 51085.48914510808, 51806.0, 51875.48124518782, 51925.48074519282, 52004.0, 1259.659891829201, 1305.2690493323769, 1371.095077249011, 1391.6729568551382, 1397.1198145168478, 25555.105571304914, 26270.343241419116, 26807.731922681305, 28818.85590572034, 29834.254143645714, 42839.645044369456, 43201.0, 43233.7838310819, 43252.78373608112, 43299.35050974175, 192289.0, 192425.0, 193358.0, 193647.0, 193692.0, 27270.0, 30666.540001899542, 32148.517772233903, 32317.192070198435, 32343.676563234065, 37688.43467347937, 38052.0, 39139.21721565496, 39338.213235734554, 39383.40924886186, 32527.67472325341, 32774.836125819216, 32999.50500742539, 33208.66791332152, 33268.334633307684, 31612.367752644357, 34989.0, 35413.645863542064, 35539.82230088833, 35585.0, 34359.141021474665, 34662.480062798575, 34706.0, 34984.825075874454, 35339.0, 30668.0, 30895.84552077225, 31437.371252575278, 31738.0, 31874.681253187173, 23560.29319120429, 23836.0, 24039.639405408583, 24311.27066188017, 24443.0], "unit": "score", "name": "ext.html", "value": 18164.788038909697}, {"lowerIsBetter": false, "replicates": [346.2210027438264, 360.0692210635507, 361.54445398797515, 365.28586613171234, 373.7551903503206, 16972.4059657912, 17069.48791536256, 17173.313067477302, 17463.301467941266, 17475.912620436913, 10795.29830561013, 11096.55613775448, 11116.166287528447, 11151.888481115186, 15966.680666386694, 4815.085133824571, 4855.975720121394, 4920.581750551208, 4936.728479933602, 4946.925796113043, 5207.140821764423, 5234.398044224906, 5313.681179129246, 5326.840194794162, 5332.546733527635, 5282.867928301785, 5285.445028272034, 5286.180642000496, 5286.233496143057, 5346.0, 4876.049170411771, 4944.703317800943, 4949.554540091391, 4954.033963377143, 5099.311592934943, 4740.644451666139, 4747.52524747526, 4747.881302967419, 4769.737664428455, 4775.044991001813, 12638.115331926769, 17017.48947531576, 20446.0, 20472.0, 20505.0, 2134.3170185540635, 2174.423777698911, 2254.481469262079, 2255.672927425514, 2274.4996100857784, 9547.474888881177, 9694.563744631438, 9824.361416507903, 11333.0, 13403.46386144553, 1847.7967423583395, 1887.1790771014653, 1892.6025534637743, 1893.280553389717, 1910.7707075150931, 46076.3088553672, 56173.15740263899, 57885.421145788845, 63778.68110659463, 67149.3285067148, 9240.0, 9358.532073396304, 9534.713958581253, 9570.33007689455, 9607.711768646952, 12024.939875300568, 12270.263784172977, 12349.382530873421, 12397.75204495905, 12412.62762117138, 6708.966455167693, 6838.418734407532, 7355.742549010759, 7396.482246242819, 7737.264959828807, 7528.134264559536, 7601.6579253933705, 7602.1257555380735, 7708.38332933364, 7735.651895664709, 4337.783110844508, 4342.0, 4351.325544540601, 4356.455443069616, 4436.157130145262, 1751.343246282644, 1783.9821601784076, 1787.6156626325403, 1788.418763901737, 1815.282963229517, 851.1020872978943, 916.3219217778795, 919.8804155459748, 932.1843387036344, 940.6989763275823, 16303.347866085462, 16933.407330743365, 17157.914210429117, 17258.568535786453, 17570.0, 894.9418287811271, 915.5376534849859, 927.248928368024, 943.551812888886, 948.6489998700387, 9393.90606093944, 9790.608375665037, 9821.656242031637, 9870.506474676382, 10027.849582256273, 393955.0, 400863.0, 401000.0, 409061.0, 411120.0, 72037.27962720305, 72703.27296726964, 74024.62987685027, 75933.62033189909, 76028.39851721072, 990.0396615283307, 994.472929347447, 1001.3441196016621, 1008.0, 1011.367895065584, 14878.0, 14943.476978305707, 15151.318190681666, 15282.388704451698, 15597.376104955674, 26073.348166295993, 33505.16237093994, 33515.0, 35139.29721405506, 35556.82221588876, 38295.2340953185, 38995.6100438992, 39225.2154956905, 39962.80018599889, 40030.799846000584, 7895.881561776463, 8038.557879316693, 8080.838383232185, 8084.434089613671, 8138.755837324889, 9633.855492167764, 12466.937665311616, 12687.175333603287, 12737.426815793126, 12811.423485943342, 9047.773805654911, 9901.851472227778, 10590.788184236426, 10657.360558366523, 10777.838332425177, 9384.81230375375, 10648.8935110651, 10732.624358147428, 10933.18001149933, 11209.607663731731, 10273.589056437659, 10360.792784144123, 10506.264561480928, 10675.14598832076, 10930.125589952944, 7523.699052037857, 7577.886331705139, 7656.119546252252, 7819.530828150329, 7905.723299684483, 9973.451460169761, 10616.787664246825, 10714.571417143226, 10800.0, 10821.56713731442], "unit": "score", "name": "jquery.html", "value": 8062.811004655701}, {"lowerIsBetter": false, "replicates": [1377.5454100146953, 1485.4875068101505, 1497.4160077569745, 1663.1601041474055, 1818.4726429335485, 6848.178218613761, 7628.771136865896, 7782.0, 7783.883241751364, 7790.493617914845, 7356.558606483602, 7542.396608271339, 7550.924490755091, 7554.584497852616, 7561.3365059686785, 1899.4966333921523, 2186.759456459788, 2239.4737236749393, 2240.2383189715492, 2270.3642979965634, 2195.220696652689, 2228.732552093743, 2233.6649502574583, 2235.619944609412, 2236.7651396603364, 2127.5213077057692, 2221.0449506712107, 2224.088123869214, 2225.877576733279, 2226.1318085946496, 1966.852486063544, 2167.2847960173185, 2214.7563767985507, 2217.8891055447243, 2218.7892150245702, 2163.707899433572, 2200.0869639099915, 2200.8899555022344, 2202.7907348801837, 2207.006846918877, 7828.373730101578, 7847.332976696931, 7886.645100970412, 7895.328897043758, 7927.08838483576, 4629.65277604181, 4717.033008233304, 4753.3107699383745, 4760.0, 4760.547747963972, 2851.985740071307, 2913.5629655551625, 2974.419988102321, 2974.5092059810104, 3031.8029328093826, 901.8737376767258, 939.2579861909084, 949.8147861167075, 969.185883857556, 1002.6039714312806, 10808.729781755519, 10848.511816968177, 10853.945730271376, 10874.238803283773, 10894.945525272324, 4119.691023173274, 4314.029343397773, 4362.280223763107, 4366.454193225847, 4376.190404775127, 9333.0, 9355.06449355059, 9373.43759374426, 9385.0, 9390.34267601275, 4161.417401563784, 4741.146593613183, 4802.495737947535, 4807.423109226916, 4814.374131362901, 4227.7463352198965, 4295.0, 4313.1158112586845, 4320.891977700583, 4330.285502891988, 3570.0, 3634.309481198564, 3665.596784353719, 3670.2292518570866, 3699.0937220380642, 1197.9940100299616, 1228.956986505468, 1229.7540491901655, 1238.7832129377502, 1251.4493622805937, 1092.6121226964472, 1102.8897110288906, 1112.038087054692, 1270.2251626507823, 1360.129517109051, 7422.48042637021, 7615.5430674159725, 7622.161562228151, 7648.541087534766, 7669.118051424046, 483.1183090859196, 488.4431747807431, 496.68708713510256, 497.32860638138226, 498.5687380415914, 5823.970880145572, 5826.708664566755, 5831.679257640785, 5832.88334233313, 5873.941260587425, 9077.319201059814, 9608.183304419063, 9609.855852162224, 9615.663451779294, 9618.51907404627, 9405.529723513797, 9442.10300021497, 9452.338336316392, 9471.763205919908, 9474.857877131848, 7174.139103307636, 7472.065991751031, 7519.398448124137, 7579.5073320234005, 7579.5073320235115, 6969.616671083139, 6997.790066298019, 7001.404880585003, 7005.0893383859775, 7009.684564194726, 7962.681492740226, 8029.759107226792, 8084.948956635835, 8133.430659853753, 8244.340452763645, 8366.790830229049, 8601.526916019679, 8729.869051964099, 8738.650453981769, 8745.256653184297, 6048.6975651218145, 6117.632942023492, 6119.653676191231, 6903.447724181953, 7038.507304488637, 7241.746538871114, 7272.818179545554, 7340.339369456775, 7368.37368823656, 7379.667914943948, 6522.21733391996, 6651.0, 6697.497687673346, 6702.698378572878, 6768.56004359715, 6519.6088234704175, 6580.5064620154635, 6588.308227636221, 6626.27111017778, 6755.628440435823, 6945.027696122648, 6974.267701891228, 6984.6158461283085, 6991.6853741580735, 7001.719931202899, 6490.545661803629, 6556.246031706415, 6566.704498297492, 6612.669366531558, 6656.667166641551, 6495.415412612888, 6531.150950376421, 6561.245456772533, 6562.5406221564035, 6585.868282634417], "unit": "score", "name": "mootools.html", "value": 4352.4687772305115}, {"lowerIsBetter": false, "replicates": [308.28170363054085, 314.32263472217363, 322.7514813593533, 327.52508862149887, 329.1885502236987, 5801.129830525418, 5889.941100588992, 5890.587658863881, 5892.234009578749, 5914.64512129272, 5794.942050579493, 5804.651720896749, 5808.273965754281, 5812.534997200224, 5821.155932389801, 4306.332518459643, 4379.562043795627, 4458.375827384169, 4473.2171869922795, 4478.283474644058, 4483.30508771141, 4486.775661216926, 4497.9325310120375, 4502.797374118156, 4512.97743511282, 4481.305397663367, 4491.910161796762, 4493.3484644726495, 4495.865124046284, 4507.549245075483, 4301.397804307399, 4374.803133858984, 4479.574440428154, 4485.282354823213, 4513.638908887281, 3939.1333906540517, 3941.5664276929515, 3944.4083387492105, 3948.05246740783, 3952.150287688161, 5572.3870374258795, 5573.916391254134, 5583.441655834425, 5587.357453892773, 5592.713675854536, 5218.582513398919, 5232.424433312332, 5233.947660523422, 5236.895262094775, 5241.79032838686, 6179.845503862394, 6181.474574661159, 6182.474489668383, 6190.288116866573, 6193.194884665009, 4110.630043296118, 4194.8112334945, 4394.121175764828, 4395.670324725626, 4399.142167277382, 6308.116863639094, 6362.300146983828, 6418.839529011765, 6489.253735820346, 6522.054302126166, 4292.763897985578, 4294.463192100988, 4296.720713153635, 4296.957030429656, 4300.268954277781, 4340.52254252032, 4346.065595896897, 4347.456567929009, 4348.391225228471, 4351.586599273127, 5063.518965698253, 5086.262491938722, 5087.592992560586, 5088.567471764942, 5091.007253585515, 6208.1308616793685, 6212.689365531795, 6214.316425193316, 6215.875682486416, 6221.191245138193, 1508.1177511156097, 1549.2331296008547, 1549.7055559443895, 1550.8061492313461, 1557.7819105325264, 956.9090936361034, 1009.0414106598761, 1027.897210278981, 1041.068243921686, 1046.3094357723867, 5850.385709500441, 5934.703264836741, 5984.222051133324, 5997.400259974055, 6002.6698531580305, 6406.359364063556, 6411.807645770635, 6456.289808121103, 6478.02829575558, 6481.967590162113, 5978.910316345258, 5979.312379076375, 5981.192539007178, 5985.072313791369, 5985.461308482258, 3422.7775194612273, 3456.8098754568236, 3458.7060099891287, 3460.1003739028033, 3461.3769521486374, 6546.541742078104, 6603.20761508622, 6641.070250164981, 6654.933450665431, 6811.046453496514, 6482.060101285381, 6499.707513161919, 6505.674716264168, 6518.250401203923, 6594.73621055162, 6805.489588280899, 6820.0, 6820.317968203339, 6823.215330237086, 6828.0, 6407.775727849503, 6434.163558737334, 6436.0, 6443.6455994920725, 6447.9355206447335, 6279.156376180863, 6354.618722876642, 6386.744530218739, 6407.487401007815, 6410.391012853772, 6781.38967492928, 6793.252742198453, 6795.218549866829, 6808.795736127726, 6823.965880170567, 4416.138852923649, 4416.933745993749, 4422.49141348749, 4425.535318791609, 4434.37918691377, 6426.518011149089, 6434.227892652912, 6445.0, 6445.677716114082, 6445.838854028687, 5974.64152150855, 6035.059879497196, 6244.781432649836, 6246.531510136849, 6248.343923887926, 5868.882622347614, 6064.757409703739, 6192.0, 6212.161358216764, 6221.160143380585, 6124.693765311806, 6130.785422510191, 6138.447539721446, 6141.109539116714, 6156.507479401726, 6242.500599951902, 6246.0, 6248.062790581449, 6252.468540173954, 6282.937170628235, 5930.377310382348, 6064.878702426015, 6065.514758819372, 6069.848253793691, 6079.939200607937], "unit": "score", "name": "prototype.html", "value": 4673.692447981092}, {"lowerIsBetter": false, "replicates": [742.6064185981428, 764.3808515102763, 772.1544908325382, 815.6207363575936, 823.6787652815399, 13743.175409475438, 13856.930715346434, 13899.096558723675, 13923.930380348109, 13935.442582296697, 14446.349914253857, 14827.481038163667, 14864.033837800562, 14902.776458353133, 14977.0, 682.6040896280145, 828.7389472316231, 832.1054866019053, 841.88634534338, 842.3850589069951, 830.796454868558, 836.5022811427222, 838.3209600223807, 839.2991851803752, 841.3101256969287, 872.6989188729877, 876.2332958661171, 877.249951291646, 877.473515890467, 877.9736607901773, 708.8405108850493, 862.905080441151, 869.1959937058227, 874.9475031498131, 880.0539420123393, 626.6835248199676, 631.0534198701947, 631.4064779107624, 631.5074242091176, 632.936706329368, 13637.363516377998, 13637.863621363858, 13657.180569165881, 13661.043726939119, 13667.316634168252, 12970.935145324307, 13020.934895325558, 13166.144200626928, 13245.735085298336, 13352.799708004388, 10910.61812836547, 10974.670759877217, 11020.393878336688, 11080.445977701083, 11209.887901120966, 3642.1076836175043, 3715.30327324314, 3729.1050147964565, 3736.8878933632036, 3748.6626203641804, 50154.24768628473, 50385.74807125941, 50550.24174637383, 50714.492855071716, 50781.23828142544, 10146.594136234467, 10149.238807089498, 10267.024632659886, 10471.68584942453, 10503.05472507478, 18649.0, 18827.15277812502, 18861.90569047146, 18878.622427551647, 18889.433317000512, 7307.3058059484265, 7385.889211661829, 7390.150132734697, 7405.740799072007, 7482.363999060032, 4387.100644367897, 4558.794854231567, 4581.358609794632, 4621.95378046222, 4634.304854271886, 2998.070598114548, 3001.1746769638526, 3013.261750871007, 3039.2098054505545, 3053.0535533984535, 492.47551357803826, 564.8559617297645, 570.4067769519653, 571.5484767034079, 607.6809674920702, 495.58618553507506, 545.4599946053457, 582.825152454262, 652.354169372318, 666.7233098264263, 7728.0, 7967.880481792778, 8004.879926801103, 8040.919590804017, 8135.186481351936, 589.8702285497184, 645.519088279235, 681.0669382945397, 681.0873429604354, 687.7214728035153, 3556.3065202285306, 3705.2589482103685, 3972.916905045025, 4071.206114807584, 4185.811638476276, 55397.72301138468, 59074.40925590775, 59585.40414595798, 59624.70187649034, 59784.0, 51599.0, 52416.0, 52791.20813187728, 53373.7331313341, 53578.46421535813, 44463.0, 47574.28638570424, 48120.759396203495, 48551.27173092406, 48690.5130948686, 7956.84086318282, 8026.638801254075, 8167.3466122711225, 8206.343492520704, 8271.33829293643, 33737.83131084329, 34169.31661366709, 39204.0, 39423.0, 40416.79791601023, 45172.54827451815, 47246.291305629755, 49958.50041499538, 50312.496875032244, 51893.740531298616, 12109.636710898687, 12304.75390492203, 12404.875951240372, 12422.813657795321, 12544.874551254736, 12277.0, 12572.1199516033, 12764.672093806077, 12795.61613151607, 13396.129251598615, 11496.137789665641, 11550.59572914944, 11576.47905844256, 11921.940390297994, 12016.33910134951, 11024.118070554498, 11990.760184796429, 11994.220375675553, 12002.39988000579, 12003.0, 10684.626038088629, 11163.609273675382, 11283.323000619988, 11553.191276610556, 11582.536698531965, 8988.235999940078, 9030.45817250967, 9050.637974481211, 9426.340156189, 9521.523923803921, 8807.031226565201, 8866.911330886867, 9093.181613654802, 9446.433214007182, 9731.61073557078], "unit": "score", "name": "yui.html", "value": 6414.466724282971}], "name": "dromaeo_css", "value": 6758.0323651996}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 107.0, 111.0, 110.0, 111.0, 100.0, 112.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.3}, {"lowerIsBetter": true, "replicates": [151.0, 132.0, 152.0, 168.0, 128.0, 154.0, 158.0, 128.0, 187.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 148.7}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 160.0, 160.0, 162.0, 159.0, 160.0, 165.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [76.0, 75.0, 109.0, 105.0, 75.0, 75.0, 73.0, 131.0, 105.0, 75.0], "unit": "score", "name": "audio-fft", "value": 89.9}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 139.0, 94.0, 94.0, 95.0, 138.0, 93.0, 93.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 107.6}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 147.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [58.0, 59.0, 58.0, 58.0, 58.0, 58.0, 60.0, 67.0, 57.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.9}, {"lowerIsBetter": true, "replicates": [77.0, 68.0, 67.0, 67.0, 67.0, 68.0, 67.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [81.0, 84.0, 82.0, 82.0, 82.0, 81.0, 83.0, 83.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.2}, {"lowerIsBetter": true, "replicates": [116.0, 115.0, 116.0, 115.0, 119.0, 121.0, 121.0, 116.0, 115.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.9}, {"lowerIsBetter": true, "replicates": [172.0, 143.0, 158.0, 159.0, 154.0, 141.0, 155.0, 157.0, 149.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.2}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 73.0, 70.0, 69.0, 68.0, 69.0, 71.0, 71.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.9}], "name": "kraken", "value": 1524.7000000000003}]} 17:07:54 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1524.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6758.03"}}} 17:07:54 INFO - Return code: 0 17:07:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:07:54 INFO - # TBPL SUCCESS # 17:07:54 INFO - Running post-action listener: _resource_record_post_action 17:07:54 INFO - Running post-run listener: _resource_record_post_run 17:07:55 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 535236608; Read time: 0; Write time: 540588 17:07:55 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 240594944; Read time: 0; Write time: 287344 17:07:55 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 293441536; Read time: 0; Write time: 253204 17:07:55 INFO - Running post-run listener: _upload_blobber_files 17:07:55 INFO - Blob upload gear active. 17:07:55 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:07:55 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 17:07:55 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'] 17:07:55 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 17:07:56 INFO - (blobuploader) - INFO - Open directory for files ... 17:07:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:07:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:07:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:07:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:07:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:07:56 INFO - (blobuploader) - INFO - Done attempting. 17:07:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 17:07:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:07:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:07:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:07:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:07:57 INFO - (blobuploader) - INFO - Done attempting. 17:07:57 INFO - (blobuploader) - INFO - Iteration through files over. 17:07:57 INFO - Return code: 0 17:07:57 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:07:57 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:07:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac8c27a7eb955aa83dcbf9868e27fa0df8259bfb69ba90226ea49bedbd88addc2fee8b89285f2a4044a8877a12426c4bc4ee9aa25fa107967addde5e55e0a773", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c2ffe49fe0b618171e857d6cc8f1d30126b8b04374f044b7e64f0029b2a6153da81d80aa5b4a57bcbc48c50c61546f7047dbf0c9f64890f4503fad39e815e6e"} 17:07:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:07:57 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:07:57 INFO - Contents: 17:07:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ac8c27a7eb955aa83dcbf9868e27fa0df8259bfb69ba90226ea49bedbd88addc2fee8b89285f2a4044a8877a12426c4bc4ee9aa25fa107967addde5e55e0a773", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c2ffe49fe0b618171e857d6cc8f1d30126b8b04374f044b7e64f0029b2a6153da81d80aa5b4a57bcbc48c50c61546f7047dbf0c9f64890f4503fad39e815e6e"} 17:07:57 INFO - Running post-run listener: copy_logs_to_upload_dir 17:07:57 INFO - Copying logs to upload dir... 17:07:57 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 17:07:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.115373 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-03-03 17:07:57.575119) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-03 17:07:57.579117) ========= 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=523ca41ca1e0623de333ad52000001bf-1457050260.958677-1444022643 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/ac8c27a7eb955aa83dcbf9868e27fa0df8259bfb69ba90226ea49bedbd88addc2fee8b89285f2a4044a8877a12426c4bc4ee9aa25fa107967addde5e55e0a773", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c2ffe49fe0b618171e857d6cc8f1d30126b8b04374f044b7e64f0029b2a6153da81d80aa5b4a57bcbc48c50c61546f7047dbf0c9f64890f4503fad39e815e6e"} build_url:https://queue.taskcluster.net/v1/task/YrtD-JHvS0mko2YfDmCp_Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011218 build_url: 'https://queue.taskcluster.net/v1/task/YrtD-JHvS0mko2YfDmCp_Q/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/ac8c27a7eb955aa83dcbf9868e27fa0df8259bfb69ba90226ea49bedbd88addc2fee8b89285f2a4044a8877a12426c4bc4ee9aa25fa107967addde5e55e0a773", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5c2ffe49fe0b618171e857d6cc8f1d30126b8b04374f044b7e64f0029b2a6153da81d80aa5b4a57bcbc48c50c61546f7047dbf0c9f64890f4503fad39e815e6e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-03 17:07:57.604546) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 17:07:57.604954) ========= 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=523ca41ca1e0623de333ad52000001bf-1457050260.958677-1444022643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004557 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 17:07:57.688940) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-03 17:07:57.689341) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-03 17:07:57.689712) ========= ========= Total master_lag: 0.32 =========