builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-061 starttime: 1459317436.04 results: success (0) buildid: 20160329203125 builduid: bd8037414fc5435681d6417d75b86473 revision: c1a1079daea1be3b0beb8e63e6d41956a1f5642d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-29 22:57:16.035681) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-29 22:57:16.036100) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-29 22:57:16.036394) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1459315244.686269-325402054 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006464 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-29 22:57:16.062121) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-29 22:57:16.062459) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-29 22:57:16.077102) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 22:57:16.077520) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1459315244.686269-325402054 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004617 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 22:57:16.127473) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-29 22:57:16.127875) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-29 22:57:16.128386) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 22:57:16.128782) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1459315244.686269-325402054 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-29 22:57:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-03-29 22:57:17 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165426 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 22:57:16.306851) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 22:57:16.307189) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1459315244.686269-325402054 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015391 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 22:57:16.357459) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 22:57:16.357953) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c1a1079daea1be3b0beb8e63e6d41956a1f5642d --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 c1a1079daea1be3b0beb8e63e6d41956a1f5642d --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=516f8d7ca085b4d087ab0a71000001a4-1459315244.686269-325402054 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-29 22:57:17,159 truncating revision to first 12 chars 2016-03-29 22:57:17,159 Setting DEBUG logging. 2016-03-29 22:57:17,159 attempt 1/10 2016-03-29 22:57:17,159 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c1a1079daea1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-29 22:57:17,437 unpacking tar archive at: fx-team-c1a1079daea1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.553620 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 22:57:16.924306) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-29 22:57:16.924610) ========= echo c1a1079daea1be3b0beb8e63e6d41956a1f5642d in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c1a1079daea1be3b0beb8e63e6d41956a1f5642d'] 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=516f8d7ca085b4d087ab0a71000001a4-1459315244.686269-325402054 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False c1a1079daea1be3b0beb8e63e6d41956a1f5642d program finished with exit code 0 elapsedTime=0.003437 script_repo_revision: 'c1a1079daea1be3b0beb8e63e6d41956a1f5642d' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-29 22:57:16.975999) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-29 22:57:16.976405) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-29 22:57:16.991148) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-03-29 22:57:16.991457) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1459315244.686269-325402054 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:57:17 INFO - MultiFileLogger online at 20160329 22:57:17 in /builds/slave/test-pgo 22:57:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 22:57:17 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:57:17 INFO - {'append_to_log': False, 22:57:17 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:57:17 INFO - 'blob_upload_branch': 'Fx-Team', 22:57:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:57:17 INFO - 'branch': 'Fx-Team', 22:57:17 INFO - 'buildbot_json_path': 'buildprops.json', 22:57:17 INFO - 'config_files': ('talos/linux_config.py',), 22:57:17 INFO - 'default_actions': ('clobber', 22:57:17 INFO - 'read-buildbot-config', 22:57:17 INFO - 'download-and-extract', 22:57:17 INFO - 'populate-webroot', 22:57:17 INFO - 'create-virtualenv', 22:57:17 INFO - 'install', 22:57:17 INFO - 'run-tests'), 22:57:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:57:17 INFO - 'download_minidump_stackwalk': True, 22:57:17 INFO - 'download_symbols': 'ondemand', 22:57:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:57:17 INFO - 'tooltool.py': '/tools/tooltool.py', 22:57:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:57:17 INFO - '/tools/misc-python/virtualenv.py')}, 22:57:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:57:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:57:17 INFO - 'installer_path': 'installer.exe', 22:57:17 INFO - 'log_level': 'info', 22:57:17 INFO - 'log_name': 'talos', 22:57:17 INFO - 'log_to_console': True, 22:57:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:57:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:57:17 INFO - 'opt_config_files': (), 22:57:17 INFO - 'pip_index': False, 22:57:17 INFO - 'sps_profile': False, 22:57:17 INFO - 'sps_profile_interval': 0, 22:57:17 INFO - 'suite': 'dromaeojs', 22:57:17 INFO - 'system_bits': '32', 22:57:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:57:17 INFO - 'title': 'talos-linux64-ix-061', 22:57:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:57:17 INFO - 'use_talos_json': True, 22:57:17 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:57:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:57:17 INFO - 'work_dir': 'build'} 22:57:17 INFO - ##### 22:57:17 INFO - ##### Running clobber step. 22:57:17 INFO - ##### 22:57:17 INFO - Running pre-action listener: _resource_record_pre_action 22:57:17 INFO - Running main action method: clobber 22:57:17 INFO - rmtree: /builds/slave/test-pgo/build 22:57:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:57:18 INFO - Running post-action listener: _resource_record_post_action 22:57:18 INFO - ##### 22:57:18 INFO - ##### Running read-buildbot-config step. 22:57:18 INFO - ##### 22:57:18 INFO - Running pre-action listener: _resource_record_pre_action 22:57:18 INFO - Running main action method: read_buildbot_config 22:57:18 INFO - Using buildbot properties: 22:57:18 INFO - { 22:57:18 INFO - "project": "", 22:57:18 INFO - "product": "firefox", 22:57:18 INFO - "script_repo_revision": "production", 22:57:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:57:18 INFO - "repository": "", 22:57:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 22:57:18 INFO - "buildid": "20160329203125", 22:57:18 INFO - "pgo_build": "True", 22:57:18 INFO - "basedir": "/builds/slave/test-pgo", 22:57:18 INFO - "buildnumber": 2, 22:57:18 INFO - "slavename": "talos-linux64-ix-061", 22:57:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:57:18 INFO - "platform": "ubuntu64_hw", 22:57:18 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 22:57:18 INFO - "branch": "fx-team", 22:57:18 INFO - "repo_path": "integration/fx-team", 22:57:18 INFO - "revision": "c1a1079daea1be3b0beb8e63e6d41956a1f5642d", 22:57:18 INFO - "stage_platform": "linux64-pgo", 22:57:18 INFO - "builduid": "bd8037414fc5435681d6417d75b86473", 22:57:18 INFO - "slavebuilddir": "test" 22:57:18 INFO - } 22:57:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/EI5p0YRvTe2uaNzSkdwT8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 22:57:18 INFO - Running post-action listener: _resource_record_post_action 22:57:18 INFO - ##### 22:57:18 INFO - ##### Running download-and-extract step. 22:57:18 INFO - ##### 22:57:18 INFO - Running pre-action listener: _resource_record_pre_action 22:57:18 INFO - Running main action method: download_and_extract 22:57:18 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:57:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:18 INFO - https://queue.taskcluster.net/v1/task/EI5p0YRvTe2uaNzSkdwT8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:57:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI5p0YRvTe2uaNzSkdwT8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:57:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI5p0YRvTe2uaNzSkdwT8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:57:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI5p0YRvTe2uaNzSkdwT8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:57:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI5p0YRvTe2uaNzSkdwT8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:57:28 INFO - Downloaded 1361 bytes. 22:57:28 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:57:28 INFO - Using the following test package requirements: 22:57:28 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:57:28 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:57:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:57:28 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:57:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:57:28 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:57:28 INFO - u'jsshell-linux-x86_64.zip'], 22:57:28 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:57:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:57:28 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:57:28 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:57:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:57:28 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:57:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:57:28 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:57:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:57:28 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:57:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:57:28 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:57:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:28 INFO - https://queue.taskcluster.net/v1/task/EI5p0YRvTe2uaNzSkdwT8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:57:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI5p0YRvTe2uaNzSkdwT8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:57:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI5p0YRvTe2uaNzSkdwT8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:57:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI5p0YRvTe2uaNzSkdwT8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:57:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI5p0YRvTe2uaNzSkdwT8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:57:31 INFO - Downloaded 23673611 bytes. 22:57:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:57:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:57:32 INFO - Return code: 0 22:57:32 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:57:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:32 INFO - https://queue.taskcluster.net/v1/task/EI5p0YRvTe2uaNzSkdwT8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:57:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI5p0YRvTe2uaNzSkdwT8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:57:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI5p0YRvTe2uaNzSkdwT8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:57:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI5p0YRvTe2uaNzSkdwT8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:57:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI5p0YRvTe2uaNzSkdwT8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:57:39 INFO - Downloaded 23673611 bytes. 22:57:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:57:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:57:40 INFO - Return code: 0 22:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:40 INFO - https://queue.taskcluster.net/v1/task/EI5p0YRvTe2uaNzSkdwT8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:57:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI5p0YRvTe2uaNzSkdwT8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:57:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI5p0YRvTe2uaNzSkdwT8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:57:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI5p0YRvTe2uaNzSkdwT8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:57:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI5p0YRvTe2uaNzSkdwT8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:57:41 INFO - Downloaded 10847531 bytes. 22:57:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:57:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 22:57:42 INFO - Return code: 0 22:57:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:42 INFO - https://queue.taskcluster.net/v1/task/EI5p0YRvTe2uaNzSkdwT8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:57:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI5p0YRvTe2uaNzSkdwT8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:57:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI5p0YRvTe2uaNzSkdwT8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:57:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI5p0YRvTe2uaNzSkdwT8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:57:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EI5p0YRvTe2uaNzSkdwT8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:57:43 INFO - Downloaded 57705677 bytes. 22:57:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EI5p0YRvTe2uaNzSkdwT8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:57:43 INFO - mkdir: /builds/slave/test-pgo/properties 22:57:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:57:43 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:57:43 INFO - Contents: 22:57:43 INFO - build_url:https://queue.taskcluster.net/v1/task/EI5p0YRvTe2uaNzSkdwT8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:57:44 INFO - Running post-action listener: _resource_record_post_action 22:57:44 INFO - Running post-action listener: set_extra_try_arguments 22:57:44 INFO - ##### 22:57:44 INFO - ##### Running populate-webroot step. 22:57:44 INFO - ##### 22:57:44 INFO - Running pre-action listener: _resource_record_pre_action 22:57:44 INFO - Running main action method: populate_webroot 22:57:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:57:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:57:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:57:44 INFO - '--tppagecycles', 22:57:44 INFO - '7'], 22:57:44 INFO - 'tests': ['tsvgm']}}, 22:57:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:57:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:57:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:57:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:57:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:57:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:57:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:57:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:57:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:57:44 INFO - 'talos_options': ['--e10s'], 22:57:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:57:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:57:44 INFO - 'tests': ['damp', 'tps']}, 22:57:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:57:44 INFO - 'talos_options': ['--e10s'], 22:57:44 INFO - 'tests': ['damp', 'tps']}, 22:57:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:57:44 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 22:57:44 INFO - 'tests': ['dromaeo_dom']}, 22:57:44 INFO - 'other': {'tests': ['a11yr', 22:57:44 INFO - 'ts_paint', 22:57:44 INFO - 'tpaint', 22:57:44 INFO - 'sessionrestore', 22:57:44 INFO - 'sessionrestore_no_auto_restore', 22:57:44 INFO - 'tabpaint']}, 22:57:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:57:44 INFO - 'tests': ['a11yr', 22:57:44 INFO - 'ts_paint', 22:57:44 INFO - 'tpaint', 22:57:44 INFO - 'sessionrestore', 22:57:44 INFO - 'sessionrestore_no_auto_restore', 22:57:44 INFO - 'tabpaint']}, 22:57:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:57:44 INFO - 'tests': ['a11yr', 22:57:44 INFO - 'ts_paint', 22:57:44 INFO - 'tpaint', 22:57:44 INFO - 'sessionrestore', 22:57:44 INFO - 'sessionrestore_no_auto_restore', 22:57:44 INFO - 'tabpaint']}, 22:57:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:57:44 INFO - 'tests': ['a11yr', 22:57:44 INFO - 'ts_paint', 22:57:44 INFO - 'tpaint', 22:57:44 INFO - 'sessionrestore', 22:57:44 INFO - 'sessionrestore_no_auto_restore', 22:57:44 INFO - 'tabpaint']}, 22:57:44 INFO - 'other_l64': {'tests': ['a11yr', 22:57:44 INFO - 'ts_paint', 22:57:44 INFO - 'tpaint', 22:57:44 INFO - 'sessionrestore', 22:57:44 INFO - 'sessionrestore_no_auto_restore', 22:57:44 INFO - 'tabpaint']}, 22:57:44 INFO - 'other_nol64': {'tests': ['a11yr', 22:57:44 INFO - 'ts_paint', 22:57:44 INFO - 'tpaint', 22:57:44 INFO - 'sessionrestore', 22:57:44 INFO - 'sessionrestore_no_auto_restore', 22:57:44 INFO - 'tabpaint']}, 22:57:44 INFO - 'svgr': {'tests': ['tsvgx', 22:57:44 INFO - 'tsvgr_opacity', 22:57:44 INFO - 'tart', 22:57:44 INFO - 'tscrollx', 22:57:44 INFO - 'cart']}, 22:57:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:57:44 INFO - 'tests': ['tsvgx', 22:57:44 INFO - 'tsvgr_opacity', 22:57:44 INFO - 'tart', 22:57:44 INFO - 'tscrollx', 22:57:44 INFO - 'cart']}, 22:57:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:57:44 INFO - 'tests': ['tp5o']}, 22:57:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:57:44 INFO - 'talos_options': ['--e10s'], 22:57:44 INFO - 'tests': ['tp5o']}, 22:57:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:57:44 INFO - 'talos_options': ['--xperf_path', 22:57:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:57:44 INFO - 'tests': ['tp5n']}, 22:57:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:57:44 INFO - 'talos_options': ['--e10s', 22:57:44 INFO - '--xperf_path', 22:57:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:57:44 INFO - 'tests': ['tp5n']}}, 22:57:44 INFO - 'talos.zip': {'path': '', 22:57:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:57:44 INFO - Running post-action listener: _resource_record_post_action 22:57:44 INFO - ##### 22:57:44 INFO - ##### Running create-virtualenv step. 22:57:44 INFO - ##### 22:57:44 INFO - Running pre-action listener: _resource_record_pre_action 22:57:44 INFO - Running main action method: create_virtualenv 22:57:44 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:57:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 22:57:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:57:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:57:44 INFO - Using real prefix '/usr' 22:57:44 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:57:45 INFO - Installing distribute.............................................................................................................................................................................................done. 22:57:47 INFO - Installing pip.................done. 22:57:47 INFO - Return code: 0 22:57:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:57: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')]} 22:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57: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')]} 22:57:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb266366f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b56b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b01d0>, '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 0x14b3750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b3be0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1459315244.686269-325402054', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:57: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 22:57: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 pip>=1.5 22:57:47 INFO - Using env: {'DISPLAY': ':0', 22:57:47 INFO - 'HOME': '/home/cltbld', 22:57:47 INFO - 'LANG': 'en_US.UTF-8', 22:57:47 INFO - 'LANGUAGE': 'en_US:en', 22:57:47 INFO - 'LOGNAME': 'cltbld', 22:57:47 INFO - 'MAIL': '/var/mail/cltbld', 22:57:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:47 INFO - 'MOZ_NO_REMOTE': '1', 22:57:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:57:47 INFO - 'NO_EM_RESTART': '1', 22:57:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:57:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:57:47 INFO - 'PWD': '/builds/slave/test-pgo', 22:57:47 INFO - 'SHELL': '/bin/bash', 22:57:47 INFO - 'SHLVL': '1', 22:57:47 INFO - 'TERM': 'linux', 22:57:47 INFO - 'TMOUT': '86400', 22:57:47 INFO - 'USER': 'cltbld', 22:57:47 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1459315244.686269-325402054', 22:57:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:47 INFO - '_': '/tools/buildbot/bin/python'} 22:57:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:57:47 INFO - Cleaning up... 22:57:47 INFO - Return code: 0 22:57:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:57: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')]} 22:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57: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')]} 22:57:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57: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', '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 0x7fb266366f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b56b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b01d0>, '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 0x14b3750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b3be0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1459315244.686269-325402054', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:57: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 22:57: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 psutil>=0.7.1 22:57:47 INFO - Using env: {'DISPLAY': ':0', 22:57:47 INFO - 'HOME': '/home/cltbld', 22:57:47 INFO - 'LANG': 'en_US.UTF-8', 22:57:47 INFO - 'LANGUAGE': 'en_US:en', 22:57:47 INFO - 'LOGNAME': 'cltbld', 22:57:47 INFO - 'MAIL': '/var/mail/cltbld', 22:57:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:47 INFO - 'MOZ_NO_REMOTE': '1', 22:57:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:57:47 INFO - 'NO_EM_RESTART': '1', 22:57:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:57:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:57:47 INFO - 'PWD': '/builds/slave/test-pgo', 22:57:47 INFO - 'SHELL': '/bin/bash', 22:57:47 INFO - 'SHLVL': '1', 22:57:47 INFO - 'TERM': 'linux', 22:57:47 INFO - 'TMOUT': '86400', 22:57:47 INFO - 'USER': 'cltbld', 22:57:47 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1459315244.686269-325402054', 22:57:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:47 INFO - '_': '/tools/buildbot/bin/python'} 22:57:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:47 INFO - Downloading/unpacking psutil>=0.7.1 22:57: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 22:57: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 22:57: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 22:57: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 22:57: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 22:57: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 22:57:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:57:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:57:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:57:49 INFO - Installing collected packages: psutil 22:57:49 INFO - Running setup.py install for psutil 22:57:49 INFO - building 'psutil._psutil_linux' extension 22:57:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:57:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:57:49 INFO - building 'psutil._psutil_posix' extension 22:57:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:57:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:57:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:57:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:57:50 INFO - Successfully installed psutil 22:57:50 INFO - Cleaning up... 22:57:50 INFO - Return code: 0 22:57:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:57: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')]} 22:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57: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')]} 22:57:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:50 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 0x7fb266366f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b56b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b01d0>, '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 0x14b3750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b3be0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1459315244.686269-325402054', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:57:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 22:57:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:57:50 INFO - Using env: {'DISPLAY': ':0', 22:57:50 INFO - 'HOME': '/home/cltbld', 22:57:50 INFO - 'LANG': 'en_US.UTF-8', 22:57:50 INFO - 'LANGUAGE': 'en_US:en', 22:57:50 INFO - 'LOGNAME': 'cltbld', 22:57:50 INFO - 'MAIL': '/var/mail/cltbld', 22:57:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:50 INFO - 'MOZ_NO_REMOTE': '1', 22:57:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:57:50 INFO - 'NO_EM_RESTART': '1', 22:57:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:57:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:57:50 INFO - 'PWD': '/builds/slave/test-pgo', 22:57:50 INFO - 'SHELL': '/bin/bash', 22:57:50 INFO - 'SHLVL': '1', 22:57:50 INFO - 'TERM': 'linux', 22:57:50 INFO - 'TMOUT': '86400', 22:57:50 INFO - 'USER': 'cltbld', 22:57:50 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1459315244.686269-325402054', 22:57:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:50 INFO - '_': '/tools/buildbot/bin/python'} 22:57:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:57:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:57:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:57:52 INFO - Installing collected packages: mozsystemmonitor 22:57:52 INFO - Running setup.py install for mozsystemmonitor 22:57:52 INFO - Successfully installed mozsystemmonitor 22:57:52 INFO - Cleaning up... 22:57:52 INFO - Return code: 0 22:57:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb266366f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b56b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b01d0>, '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 0x14b3750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b3be0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1459315244.686269-325402054', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:57:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 22:57:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:57:52 INFO - Using env: {'DISPLAY': ':0', 22:57:52 INFO - 'HOME': '/home/cltbld', 22:57:52 INFO - 'LANG': 'en_US.UTF-8', 22:57:52 INFO - 'LANGUAGE': 'en_US:en', 22:57:52 INFO - 'LOGNAME': 'cltbld', 22:57:52 INFO - 'MAIL': '/var/mail/cltbld', 22:57:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:52 INFO - 'MOZ_NO_REMOTE': '1', 22:57:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:57:52 INFO - 'NO_EM_RESTART': '1', 22:57:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:57:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:57:52 INFO - 'PWD': '/builds/slave/test-pgo', 22:57:52 INFO - 'SHELL': '/bin/bash', 22:57:52 INFO - 'SHLVL': '1', 22:57:52 INFO - 'TERM': 'linux', 22:57:52 INFO - 'TMOUT': '86400', 22:57:52 INFO - 'USER': 'cltbld', 22:57:52 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1459315244.686269-325402054', 22:57:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:52 INFO - '_': '/tools/buildbot/bin/python'} 22:57:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:52 INFO - Downloading/unpacking blobuploader==1.2.4 22:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:54 INFO - Downloading blobuploader-1.2.4.tar.gz 22:57:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:57:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:57:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:57:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:57:55 INFO - Downloading docopt-0.6.1.tar.gz 22:57:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:57:55 INFO - Installing collected packages: blobuploader, requests, docopt 22:57:55 INFO - Running setup.py install for blobuploader 22:57:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:57:55 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:57:55 INFO - Running setup.py install for requests 22:57:55 INFO - Running setup.py install for docopt 22:57:55 INFO - Successfully installed blobuploader requests docopt 22:57:55 INFO - Cleaning up... 22:57:56 INFO - Return code: 0 22:57:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:56 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 0x7fb266366f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b56b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b01d0>, '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 0x14b3750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b3be0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1459315244.686269-325402054', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:57:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:57:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:57:56 INFO - Using env: {'DISPLAY': ':0', 22:57:56 INFO - 'HOME': '/home/cltbld', 22:57:56 INFO - 'LANG': 'en_US.UTF-8', 22:57:56 INFO - 'LANGUAGE': 'en_US:en', 22:57:56 INFO - 'LOGNAME': 'cltbld', 22:57:56 INFO - 'MAIL': '/var/mail/cltbld', 22:57:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:56 INFO - 'MOZ_NO_REMOTE': '1', 22:57:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:57:56 INFO - 'NO_EM_RESTART': '1', 22:57:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:57:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:57:56 INFO - 'PWD': '/builds/slave/test-pgo', 22:57:56 INFO - 'SHELL': '/bin/bash', 22:57:56 INFO - 'SHLVL': '1', 22:57:56 INFO - 'TERM': 'linux', 22:57:56 INFO - 'TMOUT': '86400', 22:57:56 INFO - 'USER': 'cltbld', 22:57:56 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1459315244.686269-325402054', 22:57:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:56 INFO - '_': '/tools/buildbot/bin/python'} 22:57:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:57:56 INFO - Running setup.py (path:/tmp/pip-crNAnG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:57:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:57:56 INFO - Running setup.py (path:/tmp/pip-6mYy7E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:57:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:57:56 INFO - Running setup.py (path:/tmp/pip-Qp0UXy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:57:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:57:56 INFO - Running setup.py (path:/tmp/pip-GQIwRI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:57:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:57:56 INFO - Running setup.py (path:/tmp/pip-GVizwe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:57:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:57:56 INFO - Running setup.py (path:/tmp/pip-7_Yk9s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:57:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:57:56 INFO - Running setup.py (path:/tmp/pip-soOAow-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:57:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:57:56 INFO - Running setup.py (path:/tmp/pip-sFjhKZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:57:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:57:56 INFO - Running setup.py (path:/tmp/pip-TojKmU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:57:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:57:56 INFO - Running setup.py (path:/tmp/pip-fgD6_m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:57:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:57:56 INFO - Running setup.py (path:/tmp/pip-GDaTb8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:57:57 INFO - Running setup.py (path:/tmp/pip-EhPSsk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:57:57 INFO - Running setup.py (path:/tmp/pip-IZsaZV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:57:57 INFO - Running setup.py (path:/tmp/pip-SWZ1LB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:57:57 INFO - Running setup.py (path:/tmp/pip-167otE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:57:57 INFO - Running setup.py (path:/tmp/pip-yAtIty-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:57:57 INFO - Running setup.py (path:/tmp/pip-Fn6v6C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:57:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:57:57 INFO - Running setup.py install for manifestparser 22:57:57 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:57:57 INFO - Running setup.py install for mozcrash 22:57:57 INFO - Running setup.py install for mozdebug 22:57:57 INFO - Running setup.py install for mozdevice 22:57:57 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:57:57 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:57:57 INFO - Running setup.py install for mozfile 22:57:58 INFO - Running setup.py install for mozhttpd 22:57:58 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:57:58 INFO - Running setup.py install for mozinfo 22:57:58 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:57:58 INFO - Running setup.py install for mozInstall 22:57:58 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:57:58 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:57:58 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:57:58 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:57:58 INFO - Running setup.py install for mozleak 22:57:58 INFO - Running setup.py install for mozlog 22:57:58 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:57:58 INFO - Running setup.py install for moznetwork 22:57:58 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:57:58 INFO - Running setup.py install for mozprocess 22:57:58 INFO - Running setup.py install for mozprofile 22:57:58 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:57:58 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:57:58 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:57:58 INFO - Running setup.py install for mozrunner 22:57:58 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:57:58 INFO - Running setup.py install for mozscreenshot 22:57:59 INFO - Running setup.py install for moztest 22:57:59 INFO - Running setup.py install for mozversion 22:57:59 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:57:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:57:59 INFO - Cleaning up... 22:57:59 INFO - Return code: 0 22:57:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:57:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:57:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:57:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:57:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:57:59 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 0x7fb266366f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b56b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b01d0>, '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 0x14b3750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b3be0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1459315244.686269-325402054', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:57:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:57:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:57:59 INFO - Using env: {'DISPLAY': ':0', 22:57:59 INFO - 'HOME': '/home/cltbld', 22:57:59 INFO - 'LANG': 'en_US.UTF-8', 22:57:59 INFO - 'LANGUAGE': 'en_US:en', 22:57:59 INFO - 'LOGNAME': 'cltbld', 22:57:59 INFO - 'MAIL': '/var/mail/cltbld', 22:57:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:57:59 INFO - 'MOZ_NO_REMOTE': '1', 22:57:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:57:59 INFO - 'NO_EM_RESTART': '1', 22:57:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:57:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:57:59 INFO - 'PWD': '/builds/slave/test-pgo', 22:57:59 INFO - 'SHELL': '/bin/bash', 22:57:59 INFO - 'SHLVL': '1', 22:57:59 INFO - 'TERM': 'linux', 22:57:59 INFO - 'TMOUT': '86400', 22:57:59 INFO - 'USER': 'cltbld', 22:57:59 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1459315244.686269-325402054', 22:57:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:57:59 INFO - '_': '/tools/buildbot/bin/python'} 22:57:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:57:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:57:59 INFO - Running setup.py (path:/tmp/pip-VZBn2h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:57:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 22:57:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:57:59 INFO - Running setup.py (path:/tmp/pip-RPGk_u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:57:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:57:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:57:59 INFO - Running setup.py (path:/tmp/pip-sJIpwg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:57:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:57:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:57:59 INFO - Running setup.py (path:/tmp/pip-i2uHW_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:57:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:57:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:57:59 INFO - Running setup.py (path:/tmp/pip-YOqfMQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:57:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 22:57:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:57:59 INFO - Running setup.py (path:/tmp/pip-Atc9TQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:57:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 22:57:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:57:59 INFO - Running setup.py (path:/tmp/pip-2Ru3w9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 22:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:58:00 INFO - Running setup.py (path:/tmp/pip-kIkUO6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 22:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:58:00 INFO - Running setup.py (path:/tmp/pip-lFwOiK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 22:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:58:00 INFO - Running setup.py (path:/tmp/pip-oeXHQ1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:58:00 INFO - Running setup.py (path:/tmp/pip-dWqDKI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 22:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:58:00 INFO - Running setup.py (path:/tmp/pip-gW7PPy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 22:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:58:00 INFO - Running setup.py (path:/tmp/pip-2aCYQx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 22:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:58:00 INFO - Running setup.py (path:/tmp/pip-5qYFYe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 22:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:58:00 INFO - Running setup.py (path:/tmp/pip-z_9lWi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 22:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:58:00 INFO - Running setup.py (path:/tmp/pip-WJiWhu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 22:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:58:00 INFO - Running setup.py (path:/tmp/pip-W2gbqM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 22:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:58:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:02 INFO - Downloading blessings-1.6.tar.gz 22:58:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:58:02 INFO - Installing collected packages: blessings 22:58:02 INFO - Running setup.py install for blessings 22:58:02 INFO - Successfully installed blessings 22:58:02 INFO - Cleaning up... 22:58:02 INFO - Return code: 0 22:58:02 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:58:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:58:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:58:03 INFO - Reading from file tmpfile_stdout 22:58:03 INFO - Current package versions: 22:58:03 INFO - argparse == 1.2.1 22:58:03 INFO - blessings == 1.6 22:58:03 INFO - blobuploader == 1.2.4 22:58:03 INFO - docopt == 0.6.1 22:58:03 INFO - manifestparser == 1.1 22:58:03 INFO - mozInstall == 1.12 22:58:03 INFO - mozcrash == 0.17 22:58:03 INFO - mozdebug == 0.1 22:58:03 INFO - mozdevice == 0.48 22:58:03 INFO - mozfile == 1.2 22:58:03 INFO - mozhttpd == 0.7 22:58:03 INFO - mozinfo == 0.9 22:58:03 INFO - mozleak == 0.1 22:58:03 INFO - mozlog == 3.1 22:58:03 INFO - moznetwork == 0.27 22:58:03 INFO - mozprocess == 0.22 22:58:03 INFO - mozprofile == 0.28 22:58:03 INFO - mozrunner == 6.11 22:58:03 INFO - mozscreenshot == 0.1 22:58:03 INFO - mozsystemmonitor == 0.0 22:58:03 INFO - moztest == 0.7 22:58:03 INFO - mozversion == 1.4 22:58:03 INFO - psutil == 3.1.1 22:58:03 INFO - requests == 1.2.3 22:58:03 INFO - wsgiref == 0.1.2 22:58:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:58:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:58:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:58:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:03 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 0x7fb266366f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b56b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b01d0>, '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 0x14b3750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b3be0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1459315244.686269-325402054', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:58:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 22:58:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:58:03 INFO - Using env: {'DISPLAY': ':0', 22:58:03 INFO - 'HOME': '/home/cltbld', 22:58:03 INFO - 'LANG': 'en_US.UTF-8', 22:58:03 INFO - 'LANGUAGE': 'en_US:en', 22:58:03 INFO - 'LOGNAME': 'cltbld', 22:58:03 INFO - 'MAIL': '/var/mail/cltbld', 22:58:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:03 INFO - 'MOZ_NO_REMOTE': '1', 22:58:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:58:03 INFO - 'NO_EM_RESTART': '1', 22:58:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:58:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:58:03 INFO - 'PWD': '/builds/slave/test-pgo', 22:58:03 INFO - 'SHELL': '/bin/bash', 22:58:03 INFO - 'SHLVL': '1', 22:58:03 INFO - 'TERM': 'linux', 22:58:03 INFO - 'TMOUT': '86400', 22:58:03 INFO - 'USER': 'cltbld', 22:58:03 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1459315244.686269-325402054', 22:58:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:03 INFO - '_': '/tools/buildbot/bin/python'} 22:58:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:58:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:58:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 22:58:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 22:58:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:58:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 22:58:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 22:58:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 22:58:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 22:58:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 22:58:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:58:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:58:03 INFO - Cleaning up... 22:58:03 INFO - Return code: 0 22:58:03 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:58:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:58:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:58:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:03 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 0x7fb266366f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b56b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b01d0>, '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 0x14b3750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b3be0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1459315244.686269-325402054', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:58:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 22:58:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:58:03 INFO - Using env: {'DISPLAY': ':0', 22:58:03 INFO - 'HOME': '/home/cltbld', 22:58:03 INFO - 'LANG': 'en_US.UTF-8', 22:58:03 INFO - 'LANGUAGE': 'en_US:en', 22:58:03 INFO - 'LOGNAME': 'cltbld', 22:58:03 INFO - 'MAIL': '/var/mail/cltbld', 22:58:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:03 INFO - 'MOZ_NO_REMOTE': '1', 22:58:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:58:03 INFO - 'NO_EM_RESTART': '1', 22:58:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:58:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:58:03 INFO - 'PWD': '/builds/slave/test-pgo', 22:58:03 INFO - 'SHELL': '/bin/bash', 22:58:03 INFO - 'SHLVL': '1', 22:58:03 INFO - 'TERM': 'linux', 22:58:03 INFO - 'TMOUT': '86400', 22:58:03 INFO - 'USER': 'cltbld', 22:58:03 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1459315244.686269-325402054', 22:58:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:03 INFO - '_': '/tools/buildbot/bin/python'} 22:58:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:58:03 INFO - Downloading/unpacking jsonschema 22:58: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 22:58: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 22:58: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 22:58: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 22:58: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 22:58: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 22:58:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:58:05 INFO - Downloading/unpacking functools32 (from jsonschema) 22:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:05 INFO - Downloading functools32-3.2.3-2.tar.gz 22:58:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:58:05 INFO - warning: no files found matching '*.txt' 22:58:05 INFO - no previously-included directories found matching 'build' 22:58:05 INFO - no previously-included directories found matching 'dist' 22:58:05 INFO - no previously-included directories found matching '.git*' 22:58:05 INFO - Installing collected packages: jsonschema, functools32 22:58:05 INFO - Running setup.py install for functools32 22:58:05 INFO - warning: no files found matching '*.txt' 22:58:05 INFO - no previously-included directories found matching 'build' 22:58:05 INFO - no previously-included directories found matching 'dist' 22:58:05 INFO - no previously-included directories found matching '.git*' 22:58:05 INFO - Successfully installed jsonschema functools32 22:58:05 INFO - Cleaning up... 22:58:05 INFO - Return code: 0 22:58:05 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:58:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:58:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:58:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:05 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 0x7fb266366f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b56b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b01d0>, '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 0x14b3750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b3be0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1459315244.686269-325402054', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:58:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 22:58:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:58:05 INFO - Using env: {'DISPLAY': ':0', 22:58:05 INFO - 'HOME': '/home/cltbld', 22:58:05 INFO - 'LANG': 'en_US.UTF-8', 22:58:05 INFO - 'LANGUAGE': 'en_US:en', 22:58:05 INFO - 'LOGNAME': 'cltbld', 22:58:05 INFO - 'MAIL': '/var/mail/cltbld', 22:58:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:05 INFO - 'MOZ_NO_REMOTE': '1', 22:58:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:58:05 INFO - 'NO_EM_RESTART': '1', 22:58:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:58:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:58:05 INFO - 'PWD': '/builds/slave/test-pgo', 22:58:05 INFO - 'SHELL': '/bin/bash', 22:58:05 INFO - 'SHLVL': '1', 22:58:05 INFO - 'TERM': 'linux', 22:58:05 INFO - 'TMOUT': '86400', 22:58:05 INFO - 'USER': 'cltbld', 22:58:05 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1459315244.686269-325402054', 22:58:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:05 INFO - '_': '/tools/buildbot/bin/python'} 22:58:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:58:06 INFO - Downloading/unpacking flake8 22:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:58:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:58:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:58:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:58:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:58:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:58:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:58:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:58:08 INFO - no previously-included directories found matching 'docs/_build' 22:58:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:58:08 INFO - Running setup.py install for pep8 22:58:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:58:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:58:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:58:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:58:08 INFO - no previously-included directories found matching 'docs/_build' 22:58:08 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:58:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:58:08 INFO - Cleaning up... 22:58:08 INFO - Return code: 0 22:58:08 INFO - Running post-action listener: _resource_record_post_action 22:58:08 INFO - Running post-action listener: _start_resource_monitoring 22:58:08 INFO - Starting resource monitoring. 22:58:08 INFO - ##### 22:58:08 INFO - ##### Running install step. 22:58:08 INFO - ##### 22:58:08 INFO - Running pre-action listener: _resource_record_pre_action 22:58:08 INFO - Running main action method: install 22:58:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:58:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:58:09 INFO - Reading from file tmpfile_stdout 22:58:09 INFO - Detecting whether we're running mozinstall >=1.0... 22:58:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:58:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:58:09 INFO - Reading from file tmpfile_stdout 22:58:09 INFO - Output received: 22:58:09 INFO - Usage: mozinstall [options] installer 22:58:09 INFO - Options: 22:58:09 INFO - -h, --help show this help message and exit 22:58:09 INFO - -d DEST, --destination=DEST 22:58:09 INFO - Directory to install application into. [default: 22:58:09 INFO - "/builds/slave/test-pgo"] 22:58:09 INFO - --app=APP Application being installed. [default: firefox] 22:58:09 INFO - mkdir: /builds/slave/test-pgo/build/application 22:58:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 22:58:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 22:58:25 INFO - Reading from file tmpfile_stdout 22:58:25 INFO - Output received: 22:58:25 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:58:25 INFO - Running post-action listener: _resource_record_post_action 22:58:25 INFO - ##### 22:58:25 INFO - ##### Running run-tests step. 22:58:25 INFO - ##### 22:58:25 INFO - Running pre-action listener: _resource_record_pre_action 22:58:25 INFO - Running main action method: run_tests 22:58:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:58:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:58:25 INFO - Python 2.7.3 22:58:25 INFO - Return code: 0 22:58:25 INFO - grabbing minidump binary from tooltool 22:58:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:25 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 0x14b01d0>, '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 0x14b3750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b3be0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:58:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 22:58:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:58:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:58:25 INFO - Return code: 0 22:58:25 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:58:25 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:58:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:58:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:58:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:58:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:58:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:58:26 INFO - Return code: 0 22:58:26 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/EI5p0YRvTe2uaNzSkdwT8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 22:58:26 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/EI5p0YRvTe2uaNzSkdwT8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 22:58:26 INFO - Using env: {'DISPLAY': ':0', 22:58:26 INFO - 'HOME': '/home/cltbld', 22:58:26 INFO - 'LANG': 'en_US.UTF-8', 22:58:26 INFO - 'LANGUAGE': 'en_US:en', 22:58:26 INFO - 'LOGNAME': 'cltbld', 22:58:26 INFO - 'MAIL': '/var/mail/cltbld', 22:58:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:58:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:58:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:26 INFO - 'MOZ_NO_REMOTE': '1', 22:58:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:58:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:58:26 INFO - 'NO_EM_RESTART': '1', 22:58:26 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:58:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:58:26 INFO - 'PWD': '/builds/slave/test-pgo', 22:58:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:58:26 INFO - 'SHELL': '/bin/bash', 22:58:26 INFO - 'SHLVL': '1', 22:58:26 INFO - 'TERM': 'linux', 22:58:26 INFO - 'TMOUT': '86400', 22:58:26 INFO - 'USER': 'cltbld', 22:58:26 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1459315244.686269-325402054', 22:58:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:26 INFO - '_': '/tools/buildbot/bin/python'} 22:58:26 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/EI5p0YRvTe2uaNzSkdwT8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:58:26 INFO - mozversion application_buildid: 20160329203125 22:58:26 INFO - mozversion application_changeset: c1a1079daea1be3b0beb8e63e6d41956a1f5642d 22:58:26 INFO - mozversion application_display_name: Nightly 22:58:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:58:26 INFO - mozversion application_name: Firefox 22:58:26 INFO - mozversion application_remotingname: firefox 22:58:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:58:26 INFO - mozversion application_vendor: Mozilla 22:58:26 INFO - mozversion application_version: 48.0a1 22:58:26 INFO - mozversion platform_buildid: 20160329203125 22:58:26 INFO - mozversion platform_changeset: c1a1079daea1be3b0beb8e63e6d41956a1f5642d 22:58:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:58:26 INFO - mozversion platform_version: 48.0a1 22:58:26 INFO - using testdate: 1459317506 22:58:26 INFO - actual date: 1459317506 22:58:26 INFO - starting webserver on 'localhost:47274' 22:58:26 INFO - SUITE-START | Running 2 tests 22:58:26 INFO - TEST-START | dromaeo_css 22:58:26 INFO - operating with platform_type : linux_ 22:58:26 INFO - Initialising browser for dromaeo_css test... 22:58:26 INFO - TEST-INFO | started process 7405 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkjSk_b/profile http://localhost:47274/getInfo.html) 22:58:31 INFO - PROCESS | 7405 | __metrics Screen width/height:1600/1200 22:58:31 INFO - PROCESS | 7405 | colorDepth:24 22:58:31 INFO - PROCESS | 7405 | Browser inner width/height: 1024/697 22:58:31 INFO - PROCESS | 7405 | __metrics 22:58:32 ERROR - PROCESS | 7405 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:58:32 INFO - PROCESS | 7405 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 22:58:32 INFO - TEST-INFO | 7405: exit 0 22:58:32 INFO - Browser initialized. 22:58:32 INFO - Running cycle 1/1 for dromaeo_css test... 22:58:32 INFO - TEST-INFO | started process 7500 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkjSk_b/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:58:44 INFO - PROCESS | 7500 | RSS: Main: 153137152 22:58:44 INFO - PROCESS | 7500 | 22:59:35 INFO - PROCESS | 7500 | 1459317575388 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] 23:01:43 INFO - PROCESS | 7500 | Cycle 1(1): loaded http://localhost:47274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47274/tests/dromaeo/cssquery-ext.html) 23:01:44 INFO - PROCESS | 7500 | RSS: Main: 253014016 23:01:44 INFO - PROCESS | 7500 | 23:04:46 INFO - PROCESS | 7500 | Cycle 1(1): loaded http://localhost:47274/tests/dromaeo/cssquery-ext.html (next: http://localhost:47274/tests/dromaeo/cssquery-jquery.html) 23:04:46 INFO - PROCESS | 7500 | RSS: Main: 229257216 23:04:46 INFO - PROCESS | 7500 | 23:07:48 INFO - PROCESS | 7500 | Cycle 1(1): loaded http://localhost:47274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47274/tests/dromaeo/cssquery-mootools.html) 23:07:49 INFO - PROCESS | 7500 | RSS: Main: 239988736 23:07:49 INFO - PROCESS | 7500 | 23:10:51 INFO - PROCESS | 7500 | Cycle 1(1): loaded http://localhost:47274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47274/tests/dromaeo/cssquery-prototype.html) 23:10:51 INFO - PROCESS | 7500 | RSS: Main: 220172288 23:10:51 INFO - PROCESS | 7500 | 23:13:54 INFO - PROCESS | 7500 | Cycle 1(1): loaded http://localhost:47274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47274/tests/dromaeo/cssquery-yui.html) 23:13:54 INFO - PROCESS | 7500 | RSS: Main: 220405760 23:13:54 INFO - PROCESS | 7500 | 23:16:57 INFO - PROCESS | 7500 | Cycle 1(1): loaded http://localhost:47274/tests/dromaeo/cssquery-yui.html (next: http://localhost:47274/tests/dromaeo/cssquery-dojo.html) 23:16:57 INFO - PROCESS | 7500 | RSS: Main: 321822720 23:16:57 INFO - PROCESS | 7500 | 23:16:57 INFO - PROCESS | 7500 | __start_tp_report 23:16:57 INFO - PROCESS | 7500 | _x_x_mozilla_page_load 23:16:57 INFO - PROCESS | 7500 | _x_x_mozilla_page_load_details 23:16:57 INFO - PROCESS | 7500 | |i|pagename|runs| 23:16:57 INFO - PROCESS | 7500 | |0;dojo.html;3103.782735208535;3152.574402455668;3180.586523751912;3182.6180858296993;3220.500822372532;5252.264682944391;5283.128283833163;5306.40995538859;5330.680159190451;5397.2174034764985;5403.756830942607;5414.296141501599;5417.485338892809;5446.455354464551;5473.698946557938;4786.71279723216;4837.0567739290855;4900.681455705368;4927.3348098006845;4966.9751651241695;4835.516448355172;4881.1213981483315;4892.217245240762;4909.803607855682;4931.013797240548;4813.157697402958;4849.296851956482;4850.927236091461;4897.902041959159;4898.559129678346;4790.041991601659;4794.328793968847;4802.543758342987;4820.445648750404;4844.588210002119;4776.259679749644;4785.306130611077;4794.808207671689;4797.352357431771;4823.5658790709;5238.554722848562;5254.3169387979315;5268.315119034501;5295.0998330283555;5311.7344132793205;5695.288088988877;5704.629199102086;5706.885862282773;5710.857228569277;5714.799982000652;5582.944170558283;5763.250777398953;5765.250517432749;5765.394633563457;5768.163616275659;5360.115580929142;5366.248725178478;5396.487333703292;5408.59435542332;5408.91886621701;5811.941880581225;5812;5813.244278243886;5815;5824.097264923944;5553.111502159635;5605.355384130796;5607.046802043662;5673.8297851064535;5690.516306113944;5671.2060311556415;5684.715764211773;5691.800786972436;5697.088465845445;5704.8859022819315;5634.070378387602;5670.376258611549;5670.461306175906;5674.687892165971;5677.14842773579;5594.832155035356;5648.717564121777;5707.514861236841;5767.22142510764;5769.365369809318;4336.76147811867;4340.045190058182;4341.6526677865695;4348.434703488526;4375.934360984587;3889.591592882763;3891.377379619247;3907.648311651965;3939.3893946438347;3944.7041471889725;5326.733663316819;5334.413214546396;5363.812266570651;5404.32445944257;5405.162199859028;5640.464155905182;5648.435156484401;5678.346990096109;5681.0910254359105;5681.744321505542;5325.760340784674;5326.041312563698;5327.946720532745;5328.094223981932;5379.193121031876;4773.832915847998;4896.387951506062;4943.777530011158;4980.576650984707;4985.675931064469;5860.882782344414;5866.7653293868625;5868.823935281948;5874.73563689635;5875.529957603381;5653;5707.514861236841;5714.342850572238;5715.685637289823;5721.5136713379;5875.618084824644;5978.641281523122;5987.191729116514;5998.310194327708;6017.398260174123;5664.37691853904;5672.688002159921;5677.829665110054;5718.656880587178;5751.884962300815;5684.948284567368;5693.5160511357;5736.971315143398;5740.827775166752;5819.592628515963;5703.429657034263;5704.286964129484;5708.286464191976;5711.457411545896;5747.827565173052;5641.576881733804;5644.520215781705;5648.661080335193;5656.321241451053;5673.858153546194;5481.260029895913;5521.668699878021;5566;5579.302587176603;5587.078132108157;5602.1036634138345;5603.10350343943;5615.803446879339;5619;5640.182173584889;5449.782008719607;5461.9180712290145;5463.754131064191;5465.37148227943;5473.233747275305 23:16:57 INFO - PROCESS | 7500 | |1;ext.html;533.9118951042354;554.9001179787639;584.1354794903543;584.7134903897091;598.0550729846842;38293.80853095734;38569.22861542771;38598.22803543927;38614.8069259654;38648.033799155;40560;40949.181016379654;40959.59040409595;41023;41121.58878411215;8658.523781192032;8817.867731984026;8839.867401988944;8845.513496757676;8862.734117976472;8657.567121643924;8724.956375218148;8816;8822.382433229677;8829.293656507496;8961.95519022404;9054.4114632549;9057.773555661128;9065.546722663874;9073.682421115262;8978.86531702025;9035.096490350978;9038.954805225965;9043.095690430937;9054.004059553445;8886.155815197546;8996.055414181483;9004.14460626246;9006.279497640238;9007.369484136114;40697.593024069676;41071.7946410266;41081.38377924333;41109.38335924964;41121.794391028154;3590.9461358079648;3798.9430158547366;3897.512810898638;4064.349704047338;4303.612674859246;31636.367272654647;31728.206794830316;31874;32013;32021.519677204862;4240.1307731914885;4255.765932873691;4276.893077673083;4303.677224208197;4308.289132293168;245987;246683;248647;248647.75676121685;248790;58372.12441813376;59272.70363648154;59306.406935930085;59351.406485935455;63701.681491592244;62089;67274.66362668155;72834.63582682052;73969;73987.63006184934;14954.62613434651;15061.774073388908;15116.773248401283;15145.545633631009;15201.163935983406;11770;11812.881871181178;11827.763444731057;11843.28940263587;11865.703357415961;19036.61926761457;21187.47031324229;22158.224462143746;22289;22316.553668926532;7588.257339163023;7609.733659321897;7879.448438609243;7921.485103468256;7932.484388514844;1065.2277099103244;1078.455380033094;1091.9672409827717;1105.5798796457295;1154.1171004181808;31807.681923180935;32001.51997720036;32164.839175803972;32208.677913221036;32494.83752581222;1121.669107613256;1134.9432528373547;1212.6362091372553;1224.577520755338;1236.9694249089766;16350.75473867893;16420.425285114965;16578.6684266314;16655.750163747554;16780.160991950353;424075;427825;429489;429521;431698;56218.15672764912;56770.43229567734;56832.14751778644;56876;56925.71537142288;1127.667338135252;1327.6282640860575;1340.7184491256946;1353.5127354152498;1392.0394927500195;29295.414091718474;31028.88318992427;31206.375872482877;32032.5195122078;32275.19312017218;45262.321065184704;45519;45546.54453455423;45597.316040260084;45678;267733;267798;269021;269237;269738;30252.394952100396;35547.64452355443;36141.63858361383;36243.09392265109;36319.63680363268;41478;41747.7912610435;41969.58030419657;42303.788481057396;49089.09109089062;36649.81675091608;36745.63254367529;36985.26029479449;37315;37831.81084094562;38254.61745382511;38378.61621383751;38615.42076868793;39778;39963.60036399599;39661;40569;40582.39126413047;40754.38868417036;40903.38644920388;34418.48372274368;35213.64786352206;35998.28003439864;36148.81925590461;36244.27511449703;27535.173944781687;27629.861850690617;27691.44617107687;27702;27815.721842782124 23:16:57 INFO - PROCESS | 7500 | |2;jquery.html;371.9163188282637;374.1525444867376;377.2135098320003;377.812982573626;385.1661153602451;17744.378946736866;18052;18872.622547549076;18913.810861891376;18918.337858174968;17803;18291.54271143222;18357.7246341305;18367.173477193526;18379.356722514716;5338.62629615927;5570;5597.524210442118;5604.215409842625;5604.551635869121;4132.400801883725;5500.834974950738;5896.646201227919;6150.600210986271;6167.7841275555365;6105.633661980273;6117.174181485487;6126;6131.386861313856;6140.140380346755;5867.354590994987;6065.787697430569;6066.726997285133;6074.605150665237;6077.270727512705;3714.145746478298;5257.947420525784;5361.919571206435;5457.2359869618285;5464.26232458617;20455.5908881823;20712.5857482851;20735.5852882943;20745.481362965897;20777;2242.5851217524646;2358.433975845802;2670.893164273427;2678.477696849115;3108.689131086896;13437.260950647711;13927.164370137723;14094.92952535241;14196.290185490685;14333.641658958506;1935.7483527141521;1957.8335841453493;1992.9402117936486;2006.4682859042366;2019.6465618516702;63040;63393.36606633921;63649.68175159094;65055.674721626565;65115.3488465114;10076.848847267296;10100.242481813893;10482.693807362368;10549.367037977747;10560.260781745204;14169.645758855904;14317.713645727026;14339.283035848166;14344.426222951173;14357.425702971765;7570.280823321776;7829.64766585505;7871.527708337518;7950.1254861965135;7978.162292959272;7626.54240745557;7639.159692433828;7691.730864407422;7700.499467534592;7787.571683557346;4454.688171828006;4494.37078808967;4494.438195225597;4540.114677637895;4587.220172570671;1715.408184176457;1812.7734033245845;1814.129217975379;1822.4259358302359;1877.6244751049844;874.3442418186361;967.6322997261136;991.3754334769194;1027.3084518561268;1093.9288946218471;17078.48764537066;17393.739093913602;17426.738598921027;17945;18004.9099754503;1025.1644909398817;1044.770150566874;1052.3633201912885;1053.052252972331;1060.0741952211952;10050.195984321237;10260.58957641686;10274.794504109876;10441.738956525996;10522.158227341793;446711;455440;475127;475790;477948;82609;88265.55867220623;88540.5572972131;88950.55524722335;89488.55255723679;1060.6287799270194;1063.1919740996898;1078.6710053433621;1104.1222228328497;1118.5861231344293;15858.682826343178;16850.00173191057;17029;17035.829641703425;17048.31806727717;37098.62901370952;37127.81436092802;37354.8132259337;37493.625063749016;37930.62069379381;51294.230586540485;54762;54770.45229547813;55112.72443637756;55792;8215.137410572042;8372.162783721578;8398.28614567744;8402.915970840459;8434.156584341517;8998;13046.478140874638;13161.210327380388;13216.537421190213;13509.121907076009;10981.39602321848;11157.935781880378;11239.381833998881;11673.182877198515;11731.0700018929;11085.778284434427;11392.715182120513;11430.599929002445;11450.255733377304;11473;10957.890421095686;11548.94225528867;11651.708707282385;11652.53389864396;11919.986801122002;8254.0507841599;8323.417360784686;8326.167383261625;8497.405181637227;8512.787180320542;10205.693829185137;11365.943170284096;11465.484053217791;11540.365279909349;11548.133889958119 23:16:57 INFO - PROCESS | 7500 | |3;mootools.html;1292.6186774901403;1455.4833034272833;1460.5837336359136;1648.1676753239612;1825.3428765644367;7633.0458692663415;7799.259070388304;7803.258690424414;7815.983922090128;7823.17856625054;7376.74181403651;7573.5834529100875;7590.089189297279;7602.087749470057;7610.657520411581;1914.0621095663093;1971.2804826238464;2095.329494561737;2103.631864423727;2125.6598944168936;2151;2161.848670593059;2166;2168.1002384010617;2170.5441857210003;1993.0135671380388;2020.666590012646;2022.1608032666427;2119.0676102514844;2137.8824164671014;2127.4681329667583;2137.316058861165;2145.914163433461;2147.699322094908;2156.02978659603;2150.8064274215394;2179.683945827862;2179.727534058243;2180.705604743371;2182.01809185867;7832.530048197126;7864.370850332017;7873.921260787376;7891.644875980537;7893.684252629888;4781.521847815226;4846.273059041137;4877.975610121962;4880.536349046835;4887.14474966883;3075.169704179859;3221.178599457147;3239.724623407013;3244.1240864966326;3251.4147453458368;1051.910587600055;1110.1729211737227;2133.189388032538;2135.274006837667;2164.7943445372666;10679.786404271948;10765.56937722498;10785.298955567941;10797.136229101732;10810.72973175669;4141.503019637603;4218.8523401680795;4277.508086570084;4300.78496075195;4309.224339618899;8731.694390696295;8775;8836.8674469883;8844.955775221082;8853.69012084574;4849.151398505318;4850.95149048512;4874.561289483963;4881.829135980223;4892.119418504632;4034.9798251008556;4397.2085024695225;4430.623397011225;4490.797914093873;4545.613622842029;3588.6411358863907;3663.4504824276037;3676.172861106283;3696.8890933272046;3707.536557930259;1125.870524889648;1126.1272513801869;1132.230083543182;1147.4738597665084;1149.683836944847;1131.7566723154562;1154.3881742676226;1158.3397463445756;1392.3455975691409;1446.9855301447062;7665.77002689909;7742;7784.338331241795;7791.883121753178;7813.726519571787;437.88614960109965;445.2253079641401;446.054364746739;447.5211523669642;452.9456465224194;6072.180255665517;6078.878422431527;6110.419510146529;6117.174181485531;6118;9133.086691330947;9766.853497197548;9775.90224097764;9840.163586095263;9844.950775246078;9581.904180958241;9707.951460242795;9721.756956076155;9743.65897193609;9750.414975101517;7404.851902961911;7731.458797884206;7766.650500727368;7771.222877712296;7783.961080194563;7214.74748383804;7488.326050655467;7502.062242219723;7507.474476786572;7526.059242594676;8716.259117975043;8736.956315218384;8797.956010220163;8813;8950.910490895269;8984.91015089867;9005.14451127142;9009.099090090938;9135.04082071373;9144.817103657757;6081.239845019372;6188.9690551546955;6587.2753997061245;6762.797116086525;6944;7628.504147230412;7653.846923061619;7676.80807979805;7689.692412303445;7698.884516732365;6752.426043786333;6812.693428795816;6829.69266383004;6923.099997000358;7028.508004439845;6935.202451718117;6986.336298051677;7003.719851205895;7021.543599666005;7048.894266585903;7306.561606303639;7315.707371705285;7394.519356241827;7413.221611730906;7428.73999410018;6824.93175068243;6833.214180369321;6847.07564478789;6878.071460352789;6881.587104773729;6722.092517510074;6754.729810807513;6834;6880.621565813928;6888.586684798928 23:16:57 INFO - PROCESS | 7500 | |4;prototype.html;320.22345811407337;325.22920677993153;339.44670187594215;344.80518507043536;347.272464187527;5963.045912653976;6041.06363513655;6054.818355449338;6064.090386442036;6072.483838873701;5971.193888825018;5984.431479009487;6003.369646187153;6044.425779550947;6054.636721796695;4386.0350722841;4472.127935052666;4532.27483602622;4549.431321084864;4553.521880202581;4503.954960450403;4530.388397566336;4540.364348991144;4542.841000564981;4543.386642803212;4384.167008268419;4480.081583275437;4483.663725220606;4485.1254005468945;4492.97753511232;4464.352668863013;4553;4553.112143132091;4559.840405585788;4567.474740404863;4009.3785463253244;4014.016565941363;4014.979925100356;4015.678745700337;4022.6178513041214;5709.942900571024;5712.685802280873;5716.828495145152;5721.8569535761935;5728.828135155952;5299.54953828925;5303.15149576066;5309.761060752276;5311.070562651521;5312.521873031407;6278.811635650938;6281.277653069864;6282.560220784547;6286.214223222098;6338.746450141989;4354.978225108885;4462.754548499831;4468.687191896536;4472.987155779912;4481.551844815525;6490.253620833618;6510.3489651034515;6517.152770139899;6521.413072823469;6526.412622863918;4556.794944227518;4559.4072770539615;4567.132244873464;4571.977140114278;4572.039871626996;4624.30635404692;4626.907461850744;4630.259158534618;4632.050429661978;4637.049404871993;5288.286081378965;5291.444398338119;5299.5230429261555;5299.920501192408;5302.284191634157;6175.197224360894;6320.494360451153;6321.620702757849;6323.114763933053;6331.810045698637;1620.513845846265;1627.617509885176;1636.3699975509276;1638.852503274711;1639.2459468644556;1012.6759436980243;1072.9302595331278;1084.0406240477234;1090.3893819461127;1113.9275947063416;5986.132010858489;5987.670678112746;5997.190379298739;6046.909296360558;6054.848628784315;6453.741850325934;6453.741850326029;6455.096286519891;6472.676366181672;6477.287498375175;6041.093835924558;6042.909356359658;6049.8487537811025;6052.909206361908;6060.727267272983;3464.6881780639865;3493.737969652286;3496.021114088059;3498.475228715713;3502.8949131526097;6621.9006714899315;6695.096162018065;6846.281140480178;6855.485838562127;6866.107406037283;6706.865862682816;6728.629925354153;6754.18949726036;6759.695813688396;6781;6805.251422343538;6816.352446517573;6827.0783444235385;6829.965850170717;6830.692618832164;6606.735730570724;6650.168728908887;6657;6659.766908158192;6669.433098186709;6305.369463053658;6528.902066469102;6532.281449040697;6532.771353002622;6544.4764418845425;6776.525643204928;6808.251092379735;6823.55646882951;6824.897626535507;6841.692123854339;4364.061726728769;4404.0971600822395;4404.295312749945;4405.669574781969;4407.911841763211;6542.509311801729;6556.0493728410065;6562.50781191403;6565.901511477236;6565.901511477236;6225.62646241227;6374.872502550016;6386.265579458236;6392.4246817786625;6400.743970241138;6338.144350512622;6364.299927008118;6368.872622547616;6371.5221358397375;6383.744650213939;6226.968865155645;6227.159333489921;6242.5942313751275;6263;6271.027990661455;6419.8395040122505;6420.422162005442;6421.068945003042;6423.678816059085;6428.871422571428;6013.398660134127;6151.846203844761;6154.015357542772;6279.058141278662;6280.937190628035 23:16:57 INFO - PROCESS | 7500 | |5;yui.html;839.7186942374304;841.9284360829329;848.4357901995173;856.503228127686;880.1374652840217;14609.561713148609;14618.926905365472;14648;14982.175980321104;15273.847261527382;15619.297131629104;15699.215039248049;15753.212339383042;15776.290066946985;15779.526614201564;667.0328024364691;821.7740121466585;825.451075035101;837.6105111123327;838.1618381618382;824.1099612418574;826.4173757500978;828.5360198288947;829.2039641943742;829.2702421868747;870.1907226279558;872.2019352292644;872.2324354567971;872.6945569050845;873.1748497669705;701.2111374703459;849.3120572336396;861.4658911474894;862.0259107208814;863.4258218284833;631.1321932343028;632.0929466215949;632.4718859752113;632.9208848893888;633.4900405173834;14718.63203419923;14786.55640330781;14796.926015369962;14801.40794368224;14805.925970370079;13307.866921330857;13529.59411217665;13575.592732218049;13625.114367566077;13940.302984850718;11409.429528523624;11506.654800356002;11567.76864462706;11659.358735269558;11921.94039029808;3807.4669546263544;3825.7895815730126;3848.5574158971795;3890.922181556353;3950.150717595731;51603.22595161076;51738;51877.48122518764;52327;52502.47497525014;10659.84010239847;10692.465376731288;10881.510332035077;10897.291676041032;10936.398498082683;19105.14026868794;19146.138423770684;19166.233350666094;19347.4195774127;19349.226030958605;8333.708320208763;8367.456115352483;8492.74521764348;8525.488470691778;8646.870296945552;4798.688085274446;4836.613070954386;4922.335484709519;4937.753112344369;5036.320096786887;3408.471686888536;3436.0722604896537;3444.1733983843696;3447.844846981892;3460.6539346065697;634.0837489827155;634.7810005548079;645.9354064593504;654.326044174501;654.6857508395997;710.989335159973;722.1875390186041;737.2995654128599;746.895434639151;758.8254701418705;9260.305477089245;9570.90429095714;9599.952000239955;9660.227181825438;9693.369930954465;722.544796778037;731.4290269702002;766.9424793140537;768.9384849212049;778.2878666020641;4440.933385999148;4564.64419400982;4595.287730401793;4704.882377940579;4777.737224452619;55052;55512.444875550726;55903.72048139733;56582.717086414305;65363.34636653668;49649.007019859404;49925.50074499209;57535.13697294544;57584.712076440184;58462.415375845696;52019.73990130101;52094;52427;52663.21005184925;53019;9897.158741507052;10090.394576325443;10110.8483372748;10133.986601339808;10165.847512287173;38474.422883657324;38630.22739545249;39037.43850245958;39170;39971.80014100027;45998;46226.30660540027;51813.22280165876;51859.48140518546;52179.73910130577;11911.940440297743;12101.515939362678;12184.57353992606;12343.259404435763;12712.618621441372;12428;13669.658258543615;14073.788893166406;14251.714965700836;14750.114993100447;12483.56307529232;12810.935945320214;12978;13339.436668773258;13469.595912122651;12742.49030038788;12765.872341276468;12776.041796865458;13179.472821087049;13313.201207927556;13112.213267203999;13165.407556660164;13283.136596121221;13297.26865022433;13632.182069075887;10890.183236257471;11002.33985960845;11208.607698730506;11217.887821121685;11279.180204948763;10452.581896724047;10494.317869338774;10737.785244295226;10769.892301076889;11521.827172592586 23:16:57 INFO - PROCESS | 7500 | __end_tp_report 23:16:57 INFO - PROCESS | 7500 | __start_cc_report 23:16:57 INFO - PROCESS | 7500 | _x_x_mozilla_cycle_collect,806 23:16:57 INFO - PROCESS | 7500 | __end_cc_report 23:16:57 INFO - PROCESS | 7500 | __startTimestamp1459318617775__endTimestamp 23:16:57 INFO - PROCESS | 7500 | 23:16:57 INFO - PROCESS | 7500 | ------- Summary: start ------- 23:16:57 INFO - PROCESS | 7500 | Number of tests: 6 23:16:57 INFO - PROCESS | 7500 | 23:16:57 INFO - PROCESS | 7500 | [#0] dojo.html Cycles:165 Average:5311.05 Median:5553.11 stddev:596.80 (10.7%) stddev-sans-first:572.96 23:16:57 INFO - PROCESS | 7500 | Values: 3103.8 3152.6 3180.6 3182.6 3220.5 5252.3 5283.1 5306.4 5330.7 5397.2 5403.8 5414.3 5417.5 5446.5 5473.7 4786.7 4837.1 4900.7 4927.3 4967.0 4835.5 4881.1 4892.2 4909.8 4931.0 4813.2 4849.3 4850.9 4897.9 4898.6 4790.0 4794.3 4802.5 4820.4 4844.6 4776.3 4785.3 4794.8 4797.4 4823.6 5238.6 5254.3 5268.3 5295.1 5311.7 5695.3 5704.6 5706.9 5710.9 5714.8 5582.9 5763.3 5765.3 5765.4 5768.2 5360.1 5366.2 5396.5 5408.6 5408.9 5811.9 5812.0 5813.2 5815.0 5824.1 5553.1 5605.4 5607.0 5673.8 5690.5 5671.2 5684.7 5691.8 5697.1 5704.9 5634.1 5670.4 5670.5 5674.7 5677.1 5594.8 5648.7 5707.5 5767.2 5769.4 4336.8 4340.0 4341.7 4348.4 4375.9 3889.6 3891.4 3907.6 3939.4 3944.7 5326.7 5334.4 5363.8 5404.3 5405.2 5640.5 5648.4 5678.3 5681.1 5681.7 5325.8 5326.0 5327.9 5328.1 5379.2 4773.8 4896.4 4943.8 4980.6 4985.7 5860.9 5866.8 5868.8 5874.7 5875.5 5653.0 5707.5 5714.3 5715.7 5721.5 5875.6 5978.6 5987.2 5998.3 6017.4 5664.4 5672.7 5677.8 5718.7 5751.9 5684.9 5693.5 5737.0 5740.8 5819.6 5703.4 5704.3 5708.3 5711.5 5747.8 5641.6 5644.5 5648.7 5656.3 5673.9 5481.3 5521.7 5566.0 5579.3 5587.1 5602.1 5603.1 5615.8 5619.0 5640.2 5449.8 5461.9 5463.8 5465.4 5473.2 23:16:57 INFO - PROCESS | 7500 | 23:16:57 INFO - PROCESS | 7500 | [#1] ext.html Cycles:180 Average:49462.60 Median:21779.26 stddev:85565.62 (392.9%) stddev-sans-first:85726.79 23:16:57 INFO - PROCESS | 7500 | Values: 533.9 554.9 584.1 584.7 598.1 38293.8 38569.2 38598.2 38614.8 38648.0 40560.0 40949.2 40959.6 41023.0 41121.6 8658.5 8817.9 8839.9 8845.5 8862.7 8657.6 8725.0 8816.0 8822.4 8829.3 8962.0 9054.4 9057.8 9065.5 9073.7 8978.9 9035.1 9039.0 9043.1 9054.0 8886.2 8996.1 9004.1 9006.3 9007.4 40697.6 41071.8 41081.4 41109.4 41121.8 3590.9 3798.9 3897.5 4064.3 4303.6 31636.4 31728.2 31874.0 32013.0 32021.5 4240.1 4255.8 4276.9 4303.7 4308.3 245987.0 246683.0 248647.0 248647.8 248790.0 58372.1 59272.7 59306.4 59351.4 63701.7 62089.0 67274.7 72834.6 73969.0 73987.6 14954.6 15061.8 15116.8 15145.5 15201.2 11770.0 11812.9 11827.8 11843.3 11865.7 19036.6 21187.5 22158.2 22289.0 22316.6 7588.3 7609.7 7879.4 7921.5 7932.5 1065.2 1078.5 1092.0 1105.6 1154.1 31807.7 32001.5 32164.8 32208.7 32494.8 1121.7 1134.9 1212.6 1224.6 1237.0 16350.8 16420.4 16578.7 16655.8 16780.2 424075.0 427825.0 429489.0 429521.0 431698.0 56218.2 56770.4 56832.1 56876.0 56925.7 1127.7 1327.6 1340.7 1353.5 1392.0 29295.4 31028.9 31206.4 32032.5 32275.2 45262.3 45519.0 45546.5 45597.3 45678.0 267733.0 267798.0 269021.0 269237.0 269738.0 30252.4 35547.6 36141.6 36243.1 36319.6 41478.0 41747.8 41969.6 42303.8 49089.1 36649.8 36745.6 36985.3 37315.0 37831.8 38254.6 38378.6 38615.4 39778.0 39963.6 39661.0 40569.0 40582.4 40754.4 40903.4 34418.5 35213.6 35998.3 36148.8 36244.3 27535.2 27629.9 27691.4 27702.0 27815.7 23:16:57 INFO - PROCESS | 7500 | 23:16:57 INFO - PROCESS | 7500 | [#2] jquery.html Cycles:180 Average:27310.87 Median:11509.79 stddev:76631.33 (665.8%) stddev-sans-first:76819.61 23:16:57 INFO - PROCESS | 7500 | Values: 371.9 374.2 377.2 377.8 385.2 17744.4 18052.0 18872.6 18913.8 18918.3 17803.0 18291.5 18357.7 18367.2 18379.4 5338.6 5570.0 5597.5 5604.2 5604.6 4132.4 5500.8 5896.6 6150.6 6167.8 6105.6 6117.2 6126.0 6131.4 6140.1 5867.4 6065.8 6066.7 6074.6 6077.3 3714.1 5257.9 5361.9 5457.2 5464.3 20455.6 20712.6 20735.6 20745.5 20777.0 2242.6 2358.4 2670.9 2678.5 3108.7 13437.3 13927.2 14094.9 14196.3 14333.6 1935.7 1957.8 1992.9 2006.5 2019.6 63040.0 63393.4 63649.7 65055.7 65115.3 10076.8 10100.2 10482.7 10549.4 10560.3 14169.6 14317.7 14339.3 14344.4 14357.4 7570.3 7829.6 7871.5 7950.1 7978.2 7626.5 7639.2 7691.7 7700.5 7787.6 4454.7 4494.4 4494.4 4540.1 4587.2 1715.4 1812.8 1814.1 1822.4 1877.6 874.3 967.6 991.4 1027.3 1093.9 17078.5 17393.7 17426.7 17945.0 18004.9 1025.2 1044.8 1052.4 1053.1 1060.1 10050.2 10260.6 10274.8 10441.7 10522.2 446711.0 455440.0 475127.0 475790.0 477948.0 82609.0 88265.6 88540.6 88950.6 89488.6 1060.6 1063.2 1078.7 1104.1 1118.6 15858.7 16850.0 17029.0 17035.8 17048.3 37098.6 37127.8 37354.8 37493.6 37930.6 51294.2 54762.0 54770.5 55112.7 55792.0 8215.1 8372.2 8398.3 8402.9 8434.2 8998.0 13046.5 13161.2 13216.5 13509.1 10981.4 11157.9 11239.4 11673.2 11731.1 11085.8 11392.7 11430.6 11450.3 11473.0 10957.9 11548.9 11651.7 11652.5 11920.0 8254.1 8323.4 8326.2 8497.4 8512.8 10205.7 11365.9 11465.5 11540.4 11548.1 23:16:57 INFO - PROCESS | 7500 | 23:16:57 INFO - PROCESS | 7500 | [#3] mootools.html Cycles:180 Average:5555.49 Median:6153.48 stddev:2923.34 (47.5%) stddev-sans-first:2913.98 23:16:57 INFO - PROCESS | 7500 | Values: 1292.6 1455.5 1460.6 1648.2 1825.3 7633.0 7799.3 7803.3 7816.0 7823.2 7376.7 7573.6 7590.1 7602.1 7610.7 1914.1 1971.3 2095.3 2103.6 2125.7 2151.0 2161.8 2166.0 2168.1 2170.5 1993.0 2020.7 2022.2 2119.1 2137.9 2127.5 2137.3 2145.9 2147.7 2156.0 2150.8 2179.7 2179.7 2180.7 2182.0 7832.5 7864.4 7873.9 7891.6 7893.7 4781.5 4846.3 4878.0 4880.5 4887.1 3075.2 3221.2 3239.7 3244.1 3251.4 1051.9 1110.2 2133.2 2135.3 2164.8 10679.8 10765.6 10785.3 10797.1 10810.7 4141.5 4218.9 4277.5 4300.8 4309.2 8731.7 8775.0 8836.9 8845.0 8853.7 4849.2 4851.0 4874.6 4881.8 4892.1 4035.0 4397.2 4430.6 4490.8 4545.6 3588.6 3663.5 3676.2 3696.9 3707.5 1125.9 1126.1 1132.2 1147.5 1149.7 1131.8 1154.4 1158.3 1392.3 1447.0 7665.8 7742.0 7784.3 7791.9 7813.7 437.9 445.2 446.1 447.5 452.9 6072.2 6078.9 6110.4 6117.2 6118.0 9133.1 9766.9 9775.9 9840.2 9845.0 9581.9 9708.0 9721.8 9743.7 9750.4 7404.9 7731.5 7766.7 7771.2 7784.0 7214.7 7488.3 7502.1 7507.5 7526.1 8716.3 8737.0 8798.0 8813.0 8950.9 8984.9 9005.1 9009.1 9135.0 9144.8 6081.2 6189.0 6587.3 6762.8 6944.0 7628.5 7653.8 7676.8 7689.7 7698.9 6752.4 6812.7 6829.7 6923.1 7028.5 6935.2 6986.3 7003.7 7021.5 7048.9 7306.6 7315.7 7394.5 7413.2 7428.7 6824.9 6833.2 6847.1 6878.1 6881.6 6722.1 6754.7 6834.0 6880.6 6888.6 23:16:57 INFO - PROCESS | 7500 | 23:16:57 INFO - PROCESS | 7500 | [#4] prototype.html Cycles:180 Average:5306.88 Median:6043.67 stddev:1602.48 (26.5%) stddev-sans-first:1562.65 23:16:57 INFO - PROCESS | 7500 | Values: 320.2 325.2 339.4 344.8 347.3 5963.0 6041.1 6054.8 6064.1 6072.5 5971.2 5984.4 6003.4 6044.4 6054.6 4386.0 4472.1 4532.3 4549.4 4553.5 4504.0 4530.4 4540.4 4542.8 4543.4 4384.2 4480.1 4483.7 4485.1 4493.0 4464.4 4553.0 4553.1 4559.8 4567.5 4009.4 4014.0 4015.0 4015.7 4022.6 5709.9 5712.7 5716.8 5721.9 5728.8 5299.5 5303.2 5309.8 5311.1 5312.5 6278.8 6281.3 6282.6 6286.2 6338.7 4355.0 4462.8 4468.7 4473.0 4481.6 6490.3 6510.3 6517.2 6521.4 6526.4 4556.8 4559.4 4567.1 4572.0 4572.0 4624.3 4626.9 4630.3 4632.1 4637.0 5288.3 5291.4 5299.5 5299.9 5302.3 6175.2 6320.5 6321.6 6323.1 6331.8 1620.5 1627.6 1636.4 1638.9 1639.2 1012.7 1072.9 1084.0 1090.4 1113.9 5986.1 5987.7 5997.2 6046.9 6054.8 6453.7 6453.7 6455.1 6472.7 6477.3 6041.1 6042.9 6049.8 6052.9 6060.7 3464.7 3493.7 3496.0 3498.5 3502.9 6621.9 6695.1 6846.3 6855.5 6866.1 6706.9 6728.6 6754.2 6759.7 6781.0 6805.3 6816.4 6827.1 6830.0 6830.7 6606.7 6650.2 6657.0 6659.8 6669.4 6305.4 6528.9 6532.3 6532.8 6544.5 6776.5 6808.3 6823.6 6824.9 6841.7 4364.1 4404.1 4404.3 4405.7 4407.9 6542.5 6556.0 6562.5 6565.9 6565.9 6225.6 6374.9 6386.3 6392.4 6400.7 6338.1 6364.3 6368.9 6371.5 6383.7 6227.0 6227.2 6242.6 6263.0 6271.0 6419.8 6420.4 6421.1 6423.7 6428.9 6013.4 6151.8 6154.0 6279.1 6280.9 23:16:57 INFO - PROCESS | 7500 | 23:16:57 INFO - PROCESS | 7500 | [#5] yui.html Cycles:180 Average:15143.64 Median:4579.97 stddev:17100.78 (373.4%) stddev-sans-first:17115.02 23:16:57 INFO - PROCESS | 7500 | Values: 839.7 841.9 848.4 856.5 880.1 14609.6 14618.9 14648.0 14982.2 15273.8 15619.3 15699.2 15753.2 15776.3 15779.5 667.0 821.8 825.5 837.6 838.2 824.1 826.4 828.5 829.2 829.3 870.2 872.2 872.2 872.7 873.2 701.2 849.3 861.5 862.0 863.4 631.1 632.1 632.5 632.9 633.5 14718.6 14786.6 14796.9 14801.4 14805.9 13307.9 13529.6 13575.6 13625.1 13940.3 11409.4 11506.7 11567.8 11659.4 11921.9 3807.5 3825.8 3848.6 3890.9 3950.2 51603.2 51738.0 51877.5 52327.0 52502.5 10659.8 10692.5 10881.5 10897.3 10936.4 19105.1 19146.1 19166.2 19347.4 19349.2 8333.7 8367.5 8492.7 8525.5 8646.9 4798.7 4836.6 4922.3 4937.8 5036.3 3408.5 3436.1 3444.2 3447.8 3460.7 634.1 634.8 645.9 654.3 654.7 711.0 722.2 737.3 746.9 758.8 9260.3 9570.9 9600.0 9660.2 9693.4 722.5 731.4 766.9 768.9 778.3 4440.9 4564.6 4595.3 4704.9 4777.7 55052.0 55512.4 55903.7 56582.7 65363.3 49649.0 49925.5 57535.1 57584.7 58462.4 52019.7 52094.0 52427.0 52663.2 53019.0 9897.2 10090.4 10110.8 10134.0 10165.8 38474.4 38630.2 39037.4 39170.0 39971.8 45998.0 46226.3 51813.2 51859.5 52179.7 11911.9 12101.5 12184.6 12343.3 12712.6 12428.0 13669.7 14073.8 14251.7 14750.1 12483.6 12810.9 12978.0 13339.4 13469.6 12742.5 12765.9 12776.0 13179.5 13313.2 13112.2 13165.4 13283.1 13297.3 13632.2 10890.2 11002.3 11208.6 11217.9 11279.2 10452.6 10494.3 10737.8 10769.9 11521.8 23:16:57 INFO - PROCESS | 7500 | -------- Summary: end -------- 23:16:57 INFO - PROCESS | 7500 | 23:16:58 INFO - TEST-INFO | 7500: exit 0 23:16:58 INFO - TEST-OK | dromaeo_css | took 1111645ms 23:16:58 INFO - TEST-START | kraken 23:16:58 INFO - operating with platform_type : linux_ 23:16:58 INFO - Initialising browser for kraken test... 23:16:58 INFO - TEST-INFO | started process 7687 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSbSYfI/profile http://localhost:47274/getInfo.html) 23:17:02 INFO - PROCESS | 7687 | __metrics Screen width/height:1600/1200 23:17:02 INFO - PROCESS | 7687 | colorDepth:24 23:17:02 INFO - PROCESS | 7687 | Browser inner width/height: 1024/697 23:17:02 INFO - PROCESS | 7687 | __metrics 23:17:03 ERROR - PROCESS | 7687 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:17:04 INFO - TEST-INFO | 7687: exit 0 23:17:04 INFO - Browser initialized. 23:17:04 INFO - Running cycle 1/1 for kraken test... 23:17:04 INFO - TEST-INFO | started process 7775 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSbSYfI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:17:16 INFO - PROCESS | 7775 | RSS: Main: 152420352 23:17:16 INFO - PROCESS | 7775 | 23:17:18 INFO - PROCESS | 7775 | Cycle 1(1): loaded http://localhost:47274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47274/tests/kraken/driver.html?testName=audio-beat-detection) 23:17:19 INFO - PROCESS | 7775 | RSS: Main: 195538944 23:17:19 INFO - PROCESS | 7775 | 23:17:22 INFO - PROCESS | 7775 | Cycle 1(1): loaded http://localhost:47274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47274/tests/kraken/driver.html?testName=audio-dft) 23:17:22 INFO - PROCESS | 7775 | RSS: Main: 185065472 23:17:22 INFO - PROCESS | 7775 | 23:17:25 INFO - PROCESS | 7775 | Cycle 1(1): loaded http://localhost:47274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47274/tests/kraken/driver.html?testName=audio-fft) 23:17:26 INFO - PROCESS | 7775 | RSS: Main: 167612416 23:17:26 INFO - PROCESS | 7775 | 23:17:28 INFO - PROCESS | 7775 | Cycle 1(1): loaded http://localhost:47274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47274/tests/kraken/driver.html?testName=audio-oscillator) 23:17:28 INFO - PROCESS | 7775 | RSS: Main: 169709568 23:17:28 INFO - PROCESS | 7775 | 23:17:31 INFO - PROCESS | 7775 | Cycle 1(1): loaded http://localhost:47274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:17:31 INFO - PROCESS | 7775 | RSS: Main: 171970560 23:17:31 INFO - PROCESS | 7775 | 23:17:34 INFO - PROCESS | 7775 | Cycle 1(1): loaded http://localhost:47274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47274/tests/kraken/driver.html?testName=imaging-darkroom) 23:17:35 INFO - PROCESS | 7775 | RSS: Main: 172224512 23:17:35 INFO - PROCESS | 7775 | 23:17:38 INFO - PROCESS | 7775 | Cycle 1(1): loaded http://localhost:47274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47274/tests/kraken/driver.html?testName=imaging-desaturate) 23:17:39 INFO - PROCESS | 7775 | RSS: Main: 172838912 23:17:39 INFO - PROCESS | 7775 | 23:17:42 INFO - PROCESS | 7775 | Cycle 1(1): loaded http://localhost:47274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47274/tests/kraken/driver.html?testName=json-parse-financial) 23:17:42 INFO - PROCESS | 7775 | RSS: Main: 174186496 23:17:42 INFO - PROCESS | 7775 | 23:17:44 INFO - PROCESS | 7775 | Cycle 1(1): loaded http://localhost:47274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:17:44 INFO - PROCESS | 7775 | RSS: Main: 184090624 23:17:44 INFO - PROCESS | 7775 | 23:17:46 INFO - PROCESS | 7775 | Cycle 1(1): loaded http://localhost:47274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47274/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:17:47 INFO - PROCESS | 7775 | RSS: Main: 182329344 23:17:47 INFO - PROCESS | 7775 | 23:17:49 INFO - PROCESS | 7775 | Cycle 1(1): loaded http://localhost:47274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:17:49 INFO - PROCESS | 7775 | RSS: Main: 194224128 23:17:49 INFO - PROCESS | 7775 | 23:17:51 INFO - PROCESS | 7775 | Cycle 1(1): loaded http://localhost:47274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:17:52 INFO - PROCESS | 7775 | RSS: Main: 200224768 23:17:52 INFO - PROCESS | 7775 | 23:17:55 INFO - PROCESS | 7775 | Cycle 1(1): loaded http://localhost:47274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:17:55 INFO - PROCESS | 7775 | RSS: Main: 199106560 23:17:55 INFO - PROCESS | 7775 | 23:17:57 INFO - PROCESS | 7775 | Cycle 1(1): loaded http://localhost:47274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47274/tests/kraken/driver.html?testName=ai-astar) 23:17:57 INFO - PROCESS | 7775 | RSS: Main: 260763648 23:17:57 INFO - PROCESS | 7775 | 23:17:57 INFO - PROCESS | 7775 | __start_tp_report 23:17:57 INFO - PROCESS | 7775 | _x_x_mozilla_page_load 23:17:57 INFO - PROCESS | 7775 | _x_x_mozilla_page_load_details 23:17:57 INFO - PROCESS | 7775 | |i|pagename|runs| 23:17:57 INFO - PROCESS | 7775 | |0;ai-astar;111;109;103;109;110;110;100;109;109;109 23:17:57 INFO - PROCESS | 7775 | |1;audio-beat-detection;159;125;152;178;127;162;158;128;184;126 23:17:57 INFO - PROCESS | 7775 | |2;audio-dft;161;161;162;161;162;160;163;165;162;162 23:17:57 INFO - PROCESS | 7775 | |3;audio-fft;73;73;103;97;73;73;76;120;98;73 23:17:57 INFO - PROCESS | 7775 | |4;audio-oscillator;93;94;149;93;93;93;145;93;93;141 23:17:57 INFO - PROCESS | 7775 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;117;117;117 23:17:57 INFO - PROCESS | 7775 | |6;imaging-darkroom;145;146;146;146;146;146;146;145;145;145 23:17:57 INFO - PROCESS | 7775 | |7;imaging-desaturate;96;96;95;95;96;95;97;96;96;95 23:17:57 INFO - PROCESS | 7775 | |8;json-parse-financial;57;57;56;56;57;56;58;64;55;54 23:17:57 INFO - PROCESS | 7775 | |9;json-stringify-tinderbox;61;61;61;61;61;62;61;60;62;61 23:17:57 INFO - PROCESS | 7775 | |10;stanford-crypto-aes;77;78;79;80;78;79;86;79;79;79 23:17:57 INFO - PROCESS | 7775 | |11;stanford-crypto-ccm;112;111;118;119;110;113;112;119;124;111 23:17:57 INFO - PROCESS | 7775 | |12;stanford-crypto-pbkdf2;152;142;155;143;146;134;145;139;138;145 23:17:57 INFO - PROCESS | 7775 | |13;stanford-crypto-sha256-iterative;65;63;62;65;63;64;61;66;63;61 23:17:57 INFO - PROCESS | 7775 | __end_tp_report 23:17:57 INFO - PROCESS | 7775 | __start_cc_report 23:17:57 INFO - PROCESS | 7775 | _x_x_mozilla_cycle_collect,1045 23:17:57 INFO - PROCESS | 7775 | __end_cc_report 23:17:57 INFO - PROCESS | 7775 | __startTimestamp1459318677592__endTimestamp 23:17:57 INFO - PROCESS | 7775 | 23:17:57 INFO - PROCESS | 7775 | ------- Summary: start ------- 23:17:57 INFO - PROCESS | 7775 | Number of tests: 14 23:17:57 INFO - PROCESS | 7775 | 23:17:57 INFO - PROCESS | 7775 | [#0] ai-astar Cycles:10 Average:107.90 Median:109.00 stddev:3.51 (3.2%) stddev-sans-first:3.54 23:17:57 INFO - PROCESS | 7775 | Values: 111.0 109.0 103.0 109.0 110.0 110.0 100.0 109.0 109.0 109.0 23:17:57 INFO - PROCESS | 7775 | 23:17:57 INFO - PROCESS | 7775 | [#1] audio-beat-detection Cycles:10 Average:149.90 Median:158.50 stddev:22.23 (14.0%) stddev-sans-first:23.33 23:17:57 INFO - PROCESS | 7775 | Values: 159.0 125.0 152.0 178.0 127.0 162.0 158.0 128.0 184.0 126.0 23:17:57 INFO - PROCESS | 7775 | 23:17:57 INFO - PROCESS | 7775 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.37 (0.8%) stddev-sans-first:1.41 23:17:57 INFO - PROCESS | 7775 | Values: 161.0 161.0 162.0 161.0 162.0 160.0 163.0 165.0 162.0 162.0 23:17:57 INFO - PROCESS | 7775 | 23:17:57 INFO - PROCESS | 7775 | [#3] audio-fft Cycles:10 Average:85.90 Median:73.00 stddev:17.18 (23.5%) stddev-sans-first:17.57 23:17:57 INFO - PROCESS | 7775 | Values: 73.0 73.0 103.0 97.0 73.0 73.0 76.0 120.0 98.0 73.0 23:17:57 INFO - PROCESS | 7775 | 23:17:57 INFO - PROCESS | 7775 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:93.00 stddev:25.12 (27.0%) stddev-sans-first:26.00 23:17:57 INFO - PROCESS | 7775 | Values: 93.0 94.0 149.0 93.0 93.0 93.0 145.0 93.0 93.0 141.0 23:17:57 INFO - PROCESS | 7775 | 23:17:57 INFO - PROCESS | 7775 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 23:17:57 INFO - PROCESS | 7775 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 23:17:57 INFO - PROCESS | 7775 | 23:17:57 INFO - PROCESS | 7775 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 23:17:57 INFO - PROCESS | 7775 | Values: 145.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 145.0 145.0 23:17:57 INFO - PROCESS | 7775 | 23:17:57 INFO - PROCESS | 7775 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 23:17:57 INFO - PROCESS | 7775 | Values: 96.0 96.0 95.0 95.0 96.0 95.0 97.0 96.0 96.0 95.0 23:17:57 INFO - PROCESS | 7775 | 23:17:57 INFO - PROCESS | 7775 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:57.00 stddev:2.71 (4.8%) stddev-sans-first:2.87 23:17:57 INFO - PROCESS | 7775 | Values: 57.0 57.0 56.0 56.0 57.0 56.0 58.0 64.0 55.0 54.0 23:17:57 INFO - PROCESS | 7775 | 23:17:57 INFO - PROCESS | 7775 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 23:17:57 INFO - PROCESS | 7775 | Values: 61.0 61.0 61.0 61.0 61.0 62.0 61.0 60.0 62.0 61.0 23:17:57 INFO - PROCESS | 7775 | 23:17:57 INFO - PROCESS | 7775 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:79.00 stddev:2.46 (3.1%) stddev-sans-first:2.45 23:17:57 INFO - PROCESS | 7775 | Values: 77.0 78.0 79.0 80.0 78.0 79.0 86.0 79.0 79.0 79.0 23:17:57 INFO - PROCESS | 7775 | 23:17:57 INFO - PROCESS | 7775 | [#11] stanford-crypto-ccm Cycles:10 Average:114.90 Median:115.50 stddev:4.72 (4.1%) stddev-sans-first:4.89 23:17:57 INFO - PROCESS | 7775 | Values: 112.0 111.0 118.0 119.0 110.0 113.0 112.0 119.0 124.0 111.0 23:17:57 INFO - PROCESS | 7775 | 23:17:57 INFO - PROCESS | 7775 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.90 Median:145.00 stddev:6.30 (4.3%) stddev-sans-first:5.96 23:17:57 INFO - PROCESS | 7775 | Values: 152.0 142.0 155.0 143.0 146.0 134.0 145.0 139.0 138.0 145.0 23:17:57 INFO - PROCESS | 7775 | 23:17:57 INFO - PROCESS | 7775 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.50 stddev:1.70 (2.7%) stddev-sans-first:1.69 23:17:57 INFO - PROCESS | 7775 | Values: 65.0 63.0 62.0 65.0 63.0 64.0 61.0 66.0 63.0 61.0 23:17:57 INFO - PROCESS | 7775 | -------- Summary: end -------- 23:17:57 INFO - PROCESS | 7775 | 23:17:58 INFO - TEST-INFO | 7775: exit 0 23:17:58 INFO - TEST-OK | kraken | took 60045ms 23:17:58 INFO - SUITE-END | took 1171s 23:17:58 INFO - Completed test suite (00:19:31) 23:17:58 INFO - javascript benchmark 23:17:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3103.782735208535, 3152.574402455668, 3180.586523751912, 3182.6180858296993, 3220.500822372532, 5252.264682944391, 5283.128283833163, 5306.40995538859, 5330.680159190451, 5397.2174034764985, 5403.756830942607, 5414.296141501599, 5417.485338892809, 5446.455354464551, 5473.698946557938, 4786.71279723216, 4837.0567739290855, 4900.681455705368, 4927.3348098006845, 4966.9751651241695, 4835.516448355172, 4881.1213981483315, 4892.217245240762, 4909.803607855682, 4931.013797240548, 4813.157697402958, 4849.296851956482, 4850.927236091461, 4897.902041959159, 4898.559129678346, 4790.041991601659, 4794.328793968847, 4802.543758342987, 4820.445648750404, 4844.588210002119, 4776.259679749644, 4785.306130611077, 4794.808207671689, 4797.352357431771, 4823.5658790709, 5238.554722848562, 5254.3169387979315, 5268.315119034501, 5295.0998330283555, 5311.7344132793205, 5695.288088988877, 5704.629199102086, 5706.885862282773, 5710.857228569277, 5714.799982000652, 5582.944170558283, 5763.250777398953, 5765.250517432749, 5765.394633563457, 5768.163616275659, 5360.115580929142, 5366.248725178478, 5396.487333703292, 5408.59435542332, 5408.91886621701, 5811.941880581225, 5812.0, 5813.244278243886, 5815.0, 5824.097264923944, 5553.111502159635, 5605.355384130796, 5607.046802043662, 5673.8297851064535, 5690.516306113944, 5671.2060311556415, 5684.715764211773, 5691.800786972436, 5697.088465845445, 5704.8859022819315, 5634.070378387602, 5670.376258611549, 5670.461306175906, 5674.687892165971, 5677.14842773579, 5594.832155035356, 5648.717564121777, 5707.514861236841, 5767.22142510764, 5769.365369809318, 4336.76147811867, 4340.045190058182, 4341.6526677865695, 4348.434703488526, 4375.934360984587, 3889.591592882763, 3891.377379619247, 3907.648311651965, 3939.3893946438347, 3944.7041471889725, 5326.733663316819, 5334.413214546396, 5363.812266570651, 5404.32445944257, 5405.162199859028, 5640.464155905182, 5648.435156484401, 5678.346990096109, 5681.0910254359105, 5681.744321505542, 5325.760340784674, 5326.041312563698, 5327.946720532745, 5328.094223981932, 5379.193121031876, 4773.832915847998, 4896.387951506062, 4943.777530011158, 4980.576650984707, 4985.675931064469, 5860.882782344414, 5866.7653293868625, 5868.823935281948, 5874.73563689635, 5875.529957603381, 5653.0, 5707.514861236841, 5714.342850572238, 5715.685637289823, 5721.5136713379, 5875.618084824644, 5978.641281523122, 5987.191729116514, 5998.310194327708, 6017.398260174123, 5664.37691853904, 5672.688002159921, 5677.829665110054, 5718.656880587178, 5751.884962300815, 5684.948284567368, 5693.5160511357, 5736.971315143398, 5740.827775166752, 5819.592628515963, 5703.429657034263, 5704.286964129484, 5708.286464191976, 5711.457411545896, 5747.827565173052, 5641.576881733804, 5644.520215781705, 5648.661080335193, 5656.321241451053, 5673.858153546194, 5481.260029895913, 5521.668699878021, 5566.0, 5579.302587176603, 5587.078132108157, 5602.1036634138345, 5603.10350343943, 5615.803446879339, 5619.0, 5640.182173584889, 5449.782008719607, 5461.9180712290145, 5463.754131064191, 5465.37148227943, 5473.233747275305], "unit": "score", "name": "dojo.html", "value": 5271.519916808838}, {"lowerIsBetter": false, "replicates": [533.9118951042354, 554.9001179787639, 584.1354794903543, 584.7134903897091, 598.0550729846842, 38293.80853095734, 38569.22861542771, 38598.22803543927, 38614.8069259654, 38648.033799155, 40560.0, 40949.181016379654, 40959.59040409595, 41023.0, 41121.58878411215, 8658.523781192032, 8817.867731984026, 8839.867401988944, 8845.513496757676, 8862.734117976472, 8657.567121643924, 8724.956375218148, 8816.0, 8822.382433229677, 8829.293656507496, 8961.95519022404, 9054.4114632549, 9057.773555661128, 9065.546722663874, 9073.682421115262, 8978.86531702025, 9035.096490350978, 9038.954805225965, 9043.095690430937, 9054.004059553445, 8886.155815197546, 8996.055414181483, 9004.14460626246, 9006.279497640238, 9007.369484136114, 40697.593024069676, 41071.7946410266, 41081.38377924333, 41109.38335924964, 41121.794391028154, 3590.9461358079648, 3798.9430158547366, 3897.512810898638, 4064.349704047338, 4303.612674859246, 31636.367272654647, 31728.206794830316, 31874.0, 32013.0, 32021.519677204862, 4240.1307731914885, 4255.765932873691, 4276.893077673083, 4303.677224208197, 4308.289132293168, 245987.0, 246683.0, 248647.0, 248647.75676121685, 248790.0, 58372.12441813376, 59272.70363648154, 59306.406935930085, 59351.406485935455, 63701.681491592244, 62089.0, 67274.66362668155, 72834.63582682052, 73969.0, 73987.63006184934, 14954.62613434651, 15061.774073388908, 15116.773248401283, 15145.545633631009, 15201.163935983406, 11770.0, 11812.881871181178, 11827.763444731057, 11843.28940263587, 11865.703357415961, 19036.61926761457, 21187.47031324229, 22158.224462143746, 22289.0, 22316.553668926532, 7588.257339163023, 7609.733659321897, 7879.448438609243, 7921.485103468256, 7932.484388514844, 1065.2277099103244, 1078.455380033094, 1091.9672409827717, 1105.5798796457295, 1154.1171004181808, 31807.681923180935, 32001.51997720036, 32164.839175803972, 32208.677913221036, 32494.83752581222, 1121.669107613256, 1134.9432528373547, 1212.6362091372553, 1224.577520755338, 1236.9694249089766, 16350.75473867893, 16420.425285114965, 16578.6684266314, 16655.750163747554, 16780.160991950353, 424075.0, 427825.0, 429489.0, 429521.0, 431698.0, 56218.15672764912, 56770.43229567734, 56832.14751778644, 56876.0, 56925.71537142288, 1127.667338135252, 1327.6282640860575, 1340.7184491256946, 1353.5127354152498, 1392.0394927500195, 29295.414091718474, 31028.88318992427, 31206.375872482877, 32032.5195122078, 32275.19312017218, 45262.321065184704, 45519.0, 45546.54453455423, 45597.316040260084, 45678.0, 267733.0, 267798.0, 269021.0, 269237.0, 269738.0, 30252.394952100396, 35547.64452355443, 36141.63858361383, 36243.09392265109, 36319.63680363268, 41478.0, 41747.7912610435, 41969.58030419657, 42303.788481057396, 49089.09109089062, 36649.81675091608, 36745.63254367529, 36985.26029479449, 37315.0, 37831.81084094562, 38254.61745382511, 38378.61621383751, 38615.42076868793, 39778.0, 39963.60036399599, 39661.0, 40569.0, 40582.39126413047, 40754.38868417036, 40903.38644920388, 34418.48372274368, 35213.64786352206, 35998.28003439864, 36148.81925590461, 36244.27511449703, 27535.173944781687, 27629.861850690617, 27691.44617107687, 27702.0, 27815.721842782124], "unit": "score", "name": "ext.html", "value": 19458.369449019283}, {"lowerIsBetter": false, "replicates": [371.9163188282637, 374.1525444867376, 377.2135098320003, 377.812982573626, 385.1661153602451, 17744.378946736866, 18052.0, 18872.622547549076, 18913.810861891376, 18918.337858174968, 17803.0, 18291.54271143222, 18357.7246341305, 18367.173477193526, 18379.356722514716, 5338.62629615927, 5570.0, 5597.524210442118, 5604.215409842625, 5604.551635869121, 4132.400801883725, 5500.834974950738, 5896.646201227919, 6150.600210986271, 6167.7841275555365, 6105.633661980273, 6117.174181485487, 6126.0, 6131.386861313856, 6140.140380346755, 5867.354590994987, 6065.787697430569, 6066.726997285133, 6074.605150665237, 6077.270727512705, 3714.145746478298, 5257.947420525784, 5361.919571206435, 5457.2359869618285, 5464.26232458617, 20455.5908881823, 20712.5857482851, 20735.5852882943, 20745.481362965897, 20777.0, 2242.5851217524646, 2358.433975845802, 2670.893164273427, 2678.477696849115, 3108.689131086896, 13437.260950647711, 13927.164370137723, 14094.92952535241, 14196.290185490685, 14333.641658958506, 1935.7483527141521, 1957.8335841453493, 1992.9402117936486, 2006.4682859042366, 2019.6465618516702, 63040.0, 63393.36606633921, 63649.68175159094, 65055.674721626565, 65115.3488465114, 10076.848847267296, 10100.242481813893, 10482.693807362368, 10549.367037977747, 10560.260781745204, 14169.645758855904, 14317.713645727026, 14339.283035848166, 14344.426222951173, 14357.425702971765, 7570.280823321776, 7829.64766585505, 7871.527708337518, 7950.1254861965135, 7978.162292959272, 7626.54240745557, 7639.159692433828, 7691.730864407422, 7700.499467534592, 7787.571683557346, 4454.688171828006, 4494.37078808967, 4494.438195225597, 4540.114677637895, 4587.220172570671, 1715.408184176457, 1812.7734033245845, 1814.129217975379, 1822.4259358302359, 1877.6244751049844, 874.3442418186361, 967.6322997261136, 991.3754334769194, 1027.3084518561268, 1093.9288946218471, 17078.48764537066, 17393.739093913602, 17426.738598921027, 17945.0, 18004.9099754503, 1025.1644909398817, 1044.770150566874, 1052.3633201912885, 1053.052252972331, 1060.0741952211952, 10050.195984321237, 10260.58957641686, 10274.794504109876, 10441.738956525996, 10522.158227341793, 446711.0, 455440.0, 475127.0, 475790.0, 477948.0, 82609.0, 88265.55867220623, 88540.5572972131, 88950.55524722335, 89488.55255723679, 1060.6287799270194, 1063.1919740996898, 1078.6710053433621, 1104.1222228328497, 1118.5861231344293, 15858.682826343178, 16850.00173191057, 17029.0, 17035.829641703425, 17048.31806727717, 37098.62901370952, 37127.81436092802, 37354.8132259337, 37493.625063749016, 37930.62069379381, 51294.230586540485, 54762.0, 54770.45229547813, 55112.72443637756, 55792.0, 8215.137410572042, 8372.162783721578, 8398.28614567744, 8402.915970840459, 8434.156584341517, 8998.0, 13046.478140874638, 13161.210327380388, 13216.537421190213, 13509.121907076009, 10981.39602321848, 11157.935781880378, 11239.381833998881, 11673.182877198515, 11731.0700018929, 11085.778284434427, 11392.715182120513, 11430.599929002445, 11450.255733377304, 11473.0, 10957.890421095686, 11548.94225528867, 11651.708707282385, 11652.53389864396, 11919.986801122002, 8254.0507841599, 8323.417360784686, 8326.167383261625, 8497.405181637227, 8512.787180320542, 10205.693829185137, 11365.943170284096, 11465.484053217791, 11540.365279909349, 11548.133889958119], "unit": "score", "name": "jquery.html", "value": 8985.702154065024}, {"lowerIsBetter": false, "replicates": [1292.6186774901403, 1455.4833034272833, 1460.5837336359136, 1648.1676753239612, 1825.3428765644367, 7633.0458692663415, 7799.259070388304, 7803.258690424414, 7815.983922090128, 7823.17856625054, 7376.74181403651, 7573.5834529100875, 7590.089189297279, 7602.087749470057, 7610.657520411581, 1914.0621095663093, 1971.2804826238464, 2095.329494561737, 2103.631864423727, 2125.6598944168936, 2151.0, 2161.848670593059, 2166.0, 2168.1002384010617, 2170.5441857210003, 1993.0135671380388, 2020.666590012646, 2022.1608032666427, 2119.0676102514844, 2137.8824164671014, 2127.4681329667583, 2137.316058861165, 2145.914163433461, 2147.699322094908, 2156.02978659603, 2150.8064274215394, 2179.683945827862, 2179.727534058243, 2180.705604743371, 2182.01809185867, 7832.530048197126, 7864.370850332017, 7873.921260787376, 7891.644875980537, 7893.684252629888, 4781.521847815226, 4846.273059041137, 4877.975610121962, 4880.536349046835, 4887.14474966883, 3075.169704179859, 3221.178599457147, 3239.724623407013, 3244.1240864966326, 3251.4147453458368, 1051.910587600055, 1110.1729211737227, 2133.189388032538, 2135.274006837667, 2164.7943445372666, 10679.786404271948, 10765.56937722498, 10785.298955567941, 10797.136229101732, 10810.72973175669, 4141.503019637603, 4218.8523401680795, 4277.508086570084, 4300.78496075195, 4309.224339618899, 8731.694390696295, 8775.0, 8836.8674469883, 8844.955775221082, 8853.69012084574, 4849.151398505318, 4850.95149048512, 4874.561289483963, 4881.829135980223, 4892.119418504632, 4034.9798251008556, 4397.2085024695225, 4430.623397011225, 4490.797914093873, 4545.613622842029, 3588.6411358863907, 3663.4504824276037, 3676.172861106283, 3696.8890933272046, 3707.536557930259, 1125.870524889648, 1126.1272513801869, 1132.230083543182, 1147.4738597665084, 1149.683836944847, 1131.7566723154562, 1154.3881742676226, 1158.3397463445756, 1392.3455975691409, 1446.9855301447062, 7665.77002689909, 7742.0, 7784.338331241795, 7791.883121753178, 7813.726519571787, 437.88614960109965, 445.2253079641401, 446.054364746739, 447.5211523669642, 452.9456465224194, 6072.180255665517, 6078.878422431527, 6110.419510146529, 6117.174181485531, 6118.0, 9133.086691330947, 9766.853497197548, 9775.90224097764, 9840.163586095263, 9844.950775246078, 9581.904180958241, 9707.951460242795, 9721.756956076155, 9743.65897193609, 9750.414975101517, 7404.851902961911, 7731.458797884206, 7766.650500727368, 7771.222877712296, 7783.961080194563, 7214.74748383804, 7488.326050655467, 7502.062242219723, 7507.474476786572, 7526.059242594676, 8716.259117975043, 8736.956315218384, 8797.956010220163, 8813.0, 8950.910490895269, 8984.91015089867, 9005.14451127142, 9009.099090090938, 9135.04082071373, 9144.817103657757, 6081.239845019372, 6188.9690551546955, 6587.2753997061245, 6762.797116086525, 6944.0, 7628.504147230412, 7653.846923061619, 7676.80807979805, 7689.692412303445, 7698.884516732365, 6752.426043786333, 6812.693428795816, 6829.69266383004, 6923.099997000358, 7028.508004439845, 6935.202451718117, 6986.336298051677, 7003.719851205895, 7021.543599666005, 7048.894266585903, 7306.561606303639, 7315.707371705285, 7394.519356241827, 7413.221611730906, 7428.73999410018, 6824.93175068243, 6833.214180369321, 6847.07564478789, 6878.071460352789, 6881.587104773729, 6722.092517510074, 6754.729810807513, 6834.0, 6880.621565813928, 6888.586684798928], "unit": "score", "name": "mootools.html", "value": 4476.705662129125}, {"lowerIsBetter": false, "replicates": [320.22345811407337, 325.22920677993153, 339.44670187594215, 344.80518507043536, 347.272464187527, 5963.045912653976, 6041.06363513655, 6054.818355449338, 6064.090386442036, 6072.483838873701, 5971.193888825018, 5984.431479009487, 6003.369646187153, 6044.425779550947, 6054.636721796695, 4386.0350722841, 4472.127935052666, 4532.27483602622, 4549.431321084864, 4553.521880202581, 4503.954960450403, 4530.388397566336, 4540.364348991144, 4542.841000564981, 4543.386642803212, 4384.167008268419, 4480.081583275437, 4483.663725220606, 4485.1254005468945, 4492.97753511232, 4464.352668863013, 4553.0, 4553.112143132091, 4559.840405585788, 4567.474740404863, 4009.3785463253244, 4014.016565941363, 4014.979925100356, 4015.678745700337, 4022.6178513041214, 5709.942900571024, 5712.685802280873, 5716.828495145152, 5721.8569535761935, 5728.828135155952, 5299.54953828925, 5303.15149576066, 5309.761060752276, 5311.070562651521, 5312.521873031407, 6278.811635650938, 6281.277653069864, 6282.560220784547, 6286.214223222098, 6338.746450141989, 4354.978225108885, 4462.754548499831, 4468.687191896536, 4472.987155779912, 4481.551844815525, 6490.253620833618, 6510.3489651034515, 6517.152770139899, 6521.413072823469, 6526.412622863918, 4556.794944227518, 4559.4072770539615, 4567.132244873464, 4571.977140114278, 4572.039871626996, 4624.30635404692, 4626.907461850744, 4630.259158534618, 4632.050429661978, 4637.049404871993, 5288.286081378965, 5291.444398338119, 5299.5230429261555, 5299.920501192408, 5302.284191634157, 6175.197224360894, 6320.494360451153, 6321.620702757849, 6323.114763933053, 6331.810045698637, 1620.513845846265, 1627.617509885176, 1636.3699975509276, 1638.852503274711, 1639.2459468644556, 1012.6759436980243, 1072.9302595331278, 1084.0406240477234, 1090.3893819461127, 1113.9275947063416, 5986.132010858489, 5987.670678112746, 5997.190379298739, 6046.909296360558, 6054.848628784315, 6453.741850325934, 6453.741850326029, 6455.096286519891, 6472.676366181672, 6477.287498375175, 6041.093835924558, 6042.909356359658, 6049.8487537811025, 6052.909206361908, 6060.727267272983, 3464.6881780639865, 3493.737969652286, 3496.021114088059, 3498.475228715713, 3502.8949131526097, 6621.9006714899315, 6695.096162018065, 6846.281140480178, 6855.485838562127, 6866.107406037283, 6706.865862682816, 6728.629925354153, 6754.18949726036, 6759.695813688396, 6781.0, 6805.251422343538, 6816.352446517573, 6827.0783444235385, 6829.965850170717, 6830.692618832164, 6606.735730570724, 6650.168728908887, 6657.0, 6659.766908158192, 6669.433098186709, 6305.369463053658, 6528.902066469102, 6532.281449040697, 6532.771353002622, 6544.4764418845425, 6776.525643204928, 6808.251092379735, 6823.55646882951, 6824.897626535507, 6841.692123854339, 4364.061726728769, 4404.0971600822395, 4404.295312749945, 4405.669574781969, 4407.911841763211, 6542.509311801729, 6556.0493728410065, 6562.50781191403, 6565.901511477236, 6565.901511477236, 6225.62646241227, 6374.872502550016, 6386.265579458236, 6392.4246817786625, 6400.743970241138, 6338.144350512622, 6364.299927008118, 6368.872622547616, 6371.5221358397375, 6383.744650213939, 6226.968865155645, 6227.159333489921, 6242.5942313751275, 6263.0, 6271.027990661455, 6419.8395040122505, 6420.422162005442, 6421.068945003042, 6423.678816059085, 6428.871422571428, 6013.398660134127, 6151.846203844761, 6154.015357542772, 6279.058141278662, 6280.937190628035], "unit": "score", "name": "prototype.html", "value": 4786.184406396449}, {"lowerIsBetter": false, "replicates": [839.7186942374304, 841.9284360829329, 848.4357901995173, 856.503228127686, 880.1374652840217, 14609.561713148609, 14618.926905365472, 14648.0, 14982.175980321104, 15273.847261527382, 15619.297131629104, 15699.215039248049, 15753.212339383042, 15776.290066946985, 15779.526614201564, 667.0328024364691, 821.7740121466585, 825.451075035101, 837.6105111123327, 838.1618381618382, 824.1099612418574, 826.4173757500978, 828.5360198288947, 829.2039641943742, 829.2702421868747, 870.1907226279558, 872.2019352292644, 872.2324354567971, 872.6945569050845, 873.1748497669705, 701.2111374703459, 849.3120572336396, 861.4658911474894, 862.0259107208814, 863.4258218284833, 631.1321932343028, 632.0929466215949, 632.4718859752113, 632.9208848893888, 633.4900405173834, 14718.63203419923, 14786.55640330781, 14796.926015369962, 14801.40794368224, 14805.925970370079, 13307.866921330857, 13529.59411217665, 13575.592732218049, 13625.114367566077, 13940.302984850718, 11409.429528523624, 11506.654800356002, 11567.76864462706, 11659.358735269558, 11921.94039029808, 3807.4669546263544, 3825.7895815730126, 3848.5574158971795, 3890.922181556353, 3950.150717595731, 51603.22595161076, 51738.0, 51877.48122518764, 52327.0, 52502.47497525014, 10659.84010239847, 10692.465376731288, 10881.510332035077, 10897.291676041032, 10936.398498082683, 19105.14026868794, 19146.138423770684, 19166.233350666094, 19347.4195774127, 19349.226030958605, 8333.708320208763, 8367.456115352483, 8492.74521764348, 8525.488470691778, 8646.870296945552, 4798.688085274446, 4836.613070954386, 4922.335484709519, 4937.753112344369, 5036.320096786887, 3408.471686888536, 3436.0722604896537, 3444.1733983843696, 3447.844846981892, 3460.6539346065697, 634.0837489827155, 634.7810005548079, 645.9354064593504, 654.326044174501, 654.6857508395997, 710.989335159973, 722.1875390186041, 737.2995654128599, 746.895434639151, 758.8254701418705, 9260.305477089245, 9570.90429095714, 9599.952000239955, 9660.227181825438, 9693.369930954465, 722.544796778037, 731.4290269702002, 766.9424793140537, 768.9384849212049, 778.2878666020641, 4440.933385999148, 4564.64419400982, 4595.287730401793, 4704.882377940579, 4777.737224452619, 55052.0, 55512.444875550726, 55903.72048139733, 56582.717086414305, 65363.34636653668, 49649.007019859404, 49925.50074499209, 57535.13697294544, 57584.712076440184, 58462.415375845696, 52019.73990130101, 52094.0, 52427.0, 52663.21005184925, 53019.0, 9897.158741507052, 10090.394576325443, 10110.8483372748, 10133.986601339808, 10165.847512287173, 38474.422883657324, 38630.22739545249, 39037.43850245958, 39170.0, 39971.80014100027, 45998.0, 46226.30660540027, 51813.22280165876, 51859.48140518546, 52179.73910130577, 11911.940440297743, 12101.515939362678, 12184.57353992606, 12343.259404435763, 12712.618621441372, 12428.0, 13669.658258543615, 14073.788893166406, 14251.714965700836, 14750.114993100447, 12483.56307529232, 12810.935945320214, 12978.0, 13339.436668773258, 13469.595912122651, 12742.49030038788, 12765.872341276468, 12776.041796865458, 13179.472821087049, 13313.201207927556, 13112.213267203999, 13165.407556660164, 13283.136596121221, 13297.26865022433, 13632.182069075887, 10890.183236257471, 11002.33985960845, 11208.607698730506, 11217.887821121685, 11279.180204948763, 10452.581896724047, 10494.317869338774, 10737.785244295226, 10769.892301076889, 11521.827172592586], "unit": "score", "name": "yui.html", "value": 6941.331195358908}], "name": "dromaeo_css", "value": 7180.768383745348}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 109.0, 103.0, 109.0, 110.0, 110.0, 100.0, 109.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 107.9}, {"lowerIsBetter": true, "replicates": [159.0, 125.0, 152.0, 178.0, 127.0, 162.0, 158.0, 128.0, 184.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 149.9}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 162.0, 161.0, 162.0, 160.0, 163.0, 165.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.9}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 103.0, 97.0, 73.0, 73.0, 76.0, 120.0, 98.0, 73.0], "unit": "score", "name": "audio-fft", "value": 85.9}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 149.0, 93.0, 93.0, 93.0, 145.0, 93.0, 93.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 108.7}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.1}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 97.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 56.0, 56.0, 57.0, 56.0, 58.0, 64.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.0}, {"lowerIsBetter": true, "replicates": [61.0, 61.0, 61.0, 61.0, 61.0, 62.0, 61.0, 60.0, 62.0, 61.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 61.1}, {"lowerIsBetter": true, "replicates": [77.0, 78.0, 79.0, 80.0, 78.0, 79.0, 86.0, 79.0, 79.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.4}, {"lowerIsBetter": true, "replicates": [112.0, 111.0, 118.0, 119.0, 110.0, 113.0, 112.0, 119.0, 124.0, 111.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 114.9}, {"lowerIsBetter": true, "replicates": [152.0, 142.0, 155.0, 143.0, 146.0, 134.0, 145.0, 139.0, 138.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.9}, {"lowerIsBetter": true, "replicates": [65.0, 63.0, 62.0, 65.0, 63.0, 64.0, 61.0, 66.0, 63.0, 61.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 63.3}], "name": "kraken", "value": 1492.3000000000004}]} 23:17:58 INFO - Return code: 0 23:17:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:17:58 ERROR - # TBPL SUCCESS # 23:17:58 INFO - Running post-action listener: _resource_record_post_action 23:17:58 INFO - Running post-run listener: _resource_record_post_run 23:17:59 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 12288; Write bytes: 536215552; Read time: 436; Write time: 421132 23:17:59 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 243163136; Read time: 256; Write time: 226816 23:17:59 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 8192; Write bytes: 293052416; Read time: 180; Write time: 194316 23:17:59 INFO - Running post-run listener: _upload_blobber_files 23:17:59 INFO - Blob upload gear active. 23:17:59 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:17:59 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:17:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 23:17:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 23:18:00 INFO - (blobuploader) - INFO - Open directory for files ... 23:18:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 23:18:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:18:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:18:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:18:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:18:02 INFO - (blobuploader) - INFO - Done attempting. 23:18:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:18:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:18:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:18:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:18:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:18:03 INFO - (blobuploader) - INFO - Done attempting. 23:18:03 INFO - (blobuploader) - INFO - Iteration through files over. 23:18:03 INFO - Return code: 0 23:18:03 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:18:03 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:18:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c9b1b0e924325513fa9cb07b8394f9b8548a14e2a0603148e6479f890be099eda420eca6883aa279a21499eff3e71e68220665bceb90448cf7c09bba0c3062c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/17f2cba103edff8f5c484753dbcf86eb9d44d76e7d1af7350f741befb1d264043a9080d53c03f4919ae1f38930e34936e205277f2c89896bf1fb8b4cc088ca35"} 23:18:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:18:03 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:18:03 INFO - Contents: 23:18:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c9b1b0e924325513fa9cb07b8394f9b8548a14e2a0603148e6479f890be099eda420eca6883aa279a21499eff3e71e68220665bceb90448cf7c09bba0c3062c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/17f2cba103edff8f5c484753dbcf86eb9d44d76e7d1af7350f741befb1d264043a9080d53c03f4919ae1f38930e34936e205277f2c89896bf1fb8b4cc088ca35"} 23:18:03 INFO - Running post-run listener: copy_logs_to_upload_dir 23:18:03 INFO - Copying logs to upload dir... 23:18:03 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 23:18:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.610950 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-03-29 23:18:02.635106) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-29 23:18:02.638690) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1459315244.686269-325402054 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/3c9b1b0e924325513fa9cb07b8394f9b8548a14e2a0603148e6479f890be099eda420eca6883aa279a21499eff3e71e68220665bceb90448cf7c09bba0c3062c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/17f2cba103edff8f5c484753dbcf86eb9d44d76e7d1af7350f741befb1d264043a9080d53c03f4919ae1f38930e34936e205277f2c89896bf1fb8b4cc088ca35"} build_url:https://queue.taskcluster.net/v1/task/EI5p0YRvTe2uaNzSkdwT8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011289 build_url: 'https://queue.taskcluster.net/v1/task/EI5p0YRvTe2uaNzSkdwT8Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c9b1b0e924325513fa9cb07b8394f9b8548a14e2a0603148e6479f890be099eda420eca6883aa279a21499eff3e71e68220665bceb90448cf7c09bba0c3062c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/17f2cba103edff8f5c484753dbcf86eb9d44d76e7d1af7350f741befb1d264043a9080d53c03f4919ae1f38930e34936e205277f2c89896bf1fb8b4cc088ca35"}' ========= master_lag: 0.11 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-29 23:18:02.757309) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 23:18:02.757658) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1459315244.686269-325402054 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.15 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 23:18:02.910157) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-29 23:18:02.910481) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-29 23:18:02.910805) ========= ========= Total master_lag: 0.46 =========