builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1455086772.09 results: success (0) buildid: 20160209203213 builduid: 7b8c0cfb50e34242a4c094b129a1e312 revision: 337331f990883ff125b1e764cb919d5029e9883b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-09 22:46:12.088521) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-09 22:46:12.089138) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-09 22:46:12.089492) ========= 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=df17445c3590ff7897617a0e00000225-1455077768.147086-1596626838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004829 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-09 22:46:12.127019) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-09 22:46:12.127389) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-09 22:46:12.149715) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 22:46:12.150134) ========= 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=df17445c3590ff7897617a0e00000225-1455077768.147086-1596626838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015674 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 22:46:12.202924) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-09 22:46:12.203588) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-09 22:46:12.204067) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 22:46:12.204413) ========= 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=df17445c3590ff7897617a0e00000225-1455077768.147086-1596626838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-09 22:46:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.7M=0s 2016-02-09 22:46:12 (34.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.259526 ========= master_lag: 0.43 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 22:46:12.893981) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 22:46:12.894385) ========= 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=df17445c3590ff7897617a0e00000225-1455077768.147086-1596626838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.113618 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 22:46:13.046500) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 22:46:13.046873) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 337331f990883ff125b1e764cb919d5029e9883b --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 337331f990883ff125b1e764cb919d5029e9883b --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=df17445c3590ff7897617a0e00000225-1455077768.147086-1596626838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-09 22:46:13,163 truncating revision to first 12 chars 2016-02-09 22:46:13,163 Setting DEBUG logging. 2016-02-09 22:46:13,163 attempt 1/10 2016-02-09 22:46:13,163 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/337331f99088?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-09 22:46:13,426 unpacking tar archive at: fx-team-337331f99088/testing/mozharness/ program finished with exit code 0 elapsedTime=0.584785 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 22:46:13.654074) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-09 22:46:13.657501) ========= echo 337331f990883ff125b1e764cb919d5029e9883b in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'337331f990883ff125b1e764cb919d5029e9883b'] 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=df17445c3590ff7897617a0e00000225-1455077768.147086-1596626838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 337331f990883ff125b1e764cb919d5029e9883b program finished with exit code 0 elapsedTime=0.004212 script_repo_revision: '337331f990883ff125b1e764cb919d5029e9883b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-09 22:46:13.710651) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-09 22:46:13.711037) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-09 22:46:13.750693) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-02-09 22:46:13.751099) ========= /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=df17445c3590ff7897617a0e00000225-1455077768.147086-1596626838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:46:14 INFO - MultiFileLogger online at 20160209 22:46:14 in /builds/slave/test-pgo 22:46:14 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:46:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:46:14 INFO - {'append_to_log': False, 22:46:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:46:14 INFO - 'blob_upload_branch': 'Fx-Team', 22:46:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:46:14 INFO - 'branch': 'Fx-Team', 22:46:14 INFO - 'buildbot_json_path': 'buildprops.json', 22:46:14 INFO - 'config_files': ('talos/linux_config.py',), 22:46:14 INFO - 'default_actions': ('clobber', 22:46:14 INFO - 'read-buildbot-config', 22:46:14 INFO - 'download-and-extract', 22:46:14 INFO - 'populate-webroot', 22:46:14 INFO - 'create-virtualenv', 22:46:14 INFO - 'install', 22:46:14 INFO - 'run-tests'), 22:46:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:46:14 INFO - 'download_minidump_stackwalk': True, 22:46:14 INFO - 'download_symbols': 'ondemand', 22:46:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:46:14 INFO - 'tooltool.py': '/tools/tooltool.py', 22:46:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:46:14 INFO - '/tools/misc-python/virtualenv.py')}, 22:46:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:46:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:46:14 INFO - 'installer_path': 'installer.exe', 22:46:14 INFO - 'log_level': 'info', 22:46:14 INFO - 'log_name': 'talos', 22:46:14 INFO - 'log_to_console': True, 22:46:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:46:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:46:14 INFO - 'opt_config_files': (), 22:46:14 INFO - 'pip_index': False, 22:46:14 INFO - 'sps_profile': False, 22:46:14 INFO - 'sps_profile_interval': 0, 22:46:14 INFO - 'suite': 'dromaeojs', 22:46:14 INFO - 'system_bits': '32', 22:46:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:46:14 INFO - 'title': 'talos-linux64-ix-021', 22:46:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:46:14 INFO - 'use_talos_json': True, 22:46:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:46:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:46:14 INFO - 'work_dir': 'build'} 22:46:14 INFO - ##### 22:46:14 INFO - ##### Running clobber step. 22:46:14 INFO - ##### 22:46:14 INFO - Running pre-action listener: _resource_record_pre_action 22:46:14 INFO - Running main action method: clobber 22:46:14 INFO - rmtree: /builds/slave/test-pgo/build 22:46:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:46:19 INFO - Running post-action listener: _resource_record_post_action 22:46:19 INFO - ##### 22:46:19 INFO - ##### Running read-buildbot-config step. 22:46:19 INFO - ##### 22:46:19 INFO - Running pre-action listener: _resource_record_pre_action 22:46:19 INFO - Running main action method: read_buildbot_config 22:46:19 INFO - Using buildbot properties: 22:46:19 INFO - { 22:46:19 INFO - "project": "", 22:46:19 INFO - "product": "firefox", 22:46:19 INFO - "script_repo_revision": "production", 22:46:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:46:19 INFO - "repository": "", 22:46:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 22:46:19 INFO - "buildid": "20160209203213", 22:46:19 INFO - "pgo_build": "True", 22:46:19 INFO - "basedir": "/builds/slave/test-pgo", 22:46:19 INFO - "buildnumber": 931, 22:46:19 INFO - "slavename": "talos-linux64-ix-021", 22:46:19 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:46:19 INFO - "platform": "ubuntu64_hw", 22:46:19 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 22:46:19 INFO - "branch": "fx-team", 22:46:19 INFO - "repo_path": "integration/fx-team", 22:46:19 INFO - "revision": "337331f990883ff125b1e764cb919d5029e9883b", 22:46:19 INFO - "stage_platform": "linux64-pgo", 22:46:19 INFO - "builduid": "7b8c0cfb50e34242a4c094b129a1e312", 22:46:19 INFO - "slavebuilddir": "test" 22:46:19 INFO - } 22:46:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/POXjeZiRQQiDmeZXKPwxQg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 22:46:19 INFO - Running post-action listener: _resource_record_post_action 22:46:19 INFO - ##### 22:46:19 INFO - ##### Running download-and-extract step. 22:46:19 INFO - ##### 22:46:19 INFO - Running pre-action listener: _resource_record_pre_action 22:46:19 INFO - Running main action method: download_and_extract 22:46:19 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:46:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:46:19 INFO - https://queue.taskcluster.net/v1/task/POXjeZiRQQiDmeZXKPwxQg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:46:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POXjeZiRQQiDmeZXKPwxQg/artifacts/public/build/test_packages.json 22:46:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POXjeZiRQQiDmeZXKPwxQg/artifacts/public/build/test_packages.json 22:46:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POXjeZiRQQiDmeZXKPwxQg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:46:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POXjeZiRQQiDmeZXKPwxQg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:46:21 INFO - Downloaded 1448 bytes. 22:46:21 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:46:21 INFO - Using the following test package requirements: 22:46:21 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:46:21 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:46:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:46:21 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:46:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:46:21 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:46:21 INFO - u'jsshell-linux-x86_64.zip'], 22:46:21 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:46:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:46:21 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:46:21 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:46:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:46:21 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:46:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:46:21 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:46:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:46:21 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:46:21 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:46:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:46:21 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:46:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:46:21 INFO - https://queue.taskcluster.net/v1/task/POXjeZiRQQiDmeZXKPwxQg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:46:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POXjeZiRQQiDmeZXKPwxQg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:46:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POXjeZiRQQiDmeZXKPwxQg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:46:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POXjeZiRQQiDmeZXKPwxQg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:46:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POXjeZiRQQiDmeZXKPwxQg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:46:23 INFO - Downloaded 23289725 bytes. 22:46:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:46:23 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:46:24 INFO - Return code: 0 22:46:24 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:46:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:46:24 INFO - https://queue.taskcluster.net/v1/task/POXjeZiRQQiDmeZXKPwxQg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:46:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POXjeZiRQQiDmeZXKPwxQg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:46:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POXjeZiRQQiDmeZXKPwxQg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:46:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POXjeZiRQQiDmeZXKPwxQg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:46:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POXjeZiRQQiDmeZXKPwxQg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:46:27 INFO - Downloaded 23289725 bytes. 22:46:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:46:27 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:46:34 INFO - Return code: 0 22:46:34 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:46:34 INFO - https://queue.taskcluster.net/v1/task/POXjeZiRQQiDmeZXKPwxQg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:46:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POXjeZiRQQiDmeZXKPwxQg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:46:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POXjeZiRQQiDmeZXKPwxQg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:46:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POXjeZiRQQiDmeZXKPwxQg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:46:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POXjeZiRQQiDmeZXKPwxQg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:46:36 INFO - Downloaded 10706547 bytes. 22:46:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:46:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 22:46:37 INFO - Return code: 0 22:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:46:37 INFO - https://queue.taskcluster.net/v1/task/POXjeZiRQQiDmeZXKPwxQg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:46:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POXjeZiRQQiDmeZXKPwxQg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:46:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POXjeZiRQQiDmeZXKPwxQg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:46:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POXjeZiRQQiDmeZXKPwxQg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:46:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POXjeZiRQQiDmeZXKPwxQg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:46:38 INFO - Downloaded 56530808 bytes. 22:46:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/POXjeZiRQQiDmeZXKPwxQg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:46:39 INFO - mkdir: /builds/slave/test-pgo/properties 22:46:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:46:39 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:46:39 INFO - Contents: 22:46:39 INFO - build_url:https://queue.taskcluster.net/v1/task/POXjeZiRQQiDmeZXKPwxQg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:46:40 INFO - Running post-action listener: _resource_record_post_action 22:46:40 INFO - Running post-action listener: set_extra_try_arguments 22:46:40 INFO - ##### 22:46:40 INFO - ##### Running populate-webroot step. 22:46:40 INFO - ##### 22:46:40 INFO - Running pre-action listener: _resource_record_pre_action 22:46:40 INFO - Running main action method: populate_webroot 22:46:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:46:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:46:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:46:40 INFO - '--tppagecycles', 22:46:40 INFO - '7'], 22:46:40 INFO - 'tests': ['tsvgm']}}, 22:46:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:46:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:46:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:46:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:46:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:46:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:46:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:46:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:40 INFO - 'talos_options': ['--e10s'], 22:46:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:46:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:40 INFO - 'tests': ['damp', 'tps']}, 22:46:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:40 INFO - 'talos_options': ['--e10s'], 22:46:40 INFO - 'tests': ['damp', 'tps']}, 22:46:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:46:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:46:40 INFO - 'other': {'tests': ['a11yr', 22:46:40 INFO - 'ts_paint', 22:46:40 INFO - 'tpaint', 22:46:40 INFO - 'sessionrestore', 22:46:40 INFO - 'sessionrestore_no_auto_restore']}, 22:46:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:46:40 INFO - 'tests': ['a11yr', 22:46:40 INFO - 'ts_paint', 22:46:40 INFO - 'tpaint', 22:46:40 INFO - 'sessionrestore', 22:46:40 INFO - 'sessionrestore_no_auto_restore']}, 22:46:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:46:40 INFO - 'tests': ['a11yr', 22:46:40 INFO - 'ts_paint', 22:46:40 INFO - 'tpaint', 22:46:40 INFO - 'sessionrestore', 22:46:40 INFO - 'sessionrestore_no_auto_restore']}, 22:46:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:46:40 INFO - 'tests': ['a11yr', 22:46:40 INFO - 'ts_paint', 22:46:40 INFO - 'tpaint', 22:46:40 INFO - 'sessionrestore', 22:46:40 INFO - 'sessionrestore_no_auto_restore']}, 22:46:40 INFO - 'other_l64': {'tests': ['a11yr', 22:46:40 INFO - 'ts_paint', 22:46:40 INFO - 'tpaint', 22:46:40 INFO - 'sessionrestore', 22:46:40 INFO - 'sessionrestore_no_auto_restore']}, 22:46:40 INFO - 'other_nol64': {'tests': ['a11yr', 22:46:40 INFO - 'ts_paint', 22:46:40 INFO - 'tpaint', 22:46:40 INFO - 'sessionrestore', 22:46:40 INFO - 'sessionrestore_no_auto_restore']}, 22:46:40 INFO - 'svgr': {'tests': ['tsvgx', 22:46:40 INFO - 'tsvgr_opacity', 22:46:40 INFO - 'tart', 22:46:40 INFO - 'tscrollx', 22:46:40 INFO - 'cart']}, 22:46:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:46:40 INFO - 'tests': ['tsvgx', 22:46:40 INFO - 'tsvgr_opacity', 22:46:40 INFO - 'tart', 22:46:40 INFO - 'tscrollx', 22:46:40 INFO - 'cart']}, 22:46:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:40 INFO - 'tests': ['tp5o']}, 22:46:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:40 INFO - 'talos_options': ['--e10s'], 22:46:40 INFO - 'tests': ['tp5o']}, 22:46:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:40 INFO - 'talos_options': ['--xperf_path', 22:46:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:46:40 INFO - 'tests': ['tp5n']}, 22:46:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:46:40 INFO - 'talos_options': ['--e10s', 22:46:40 INFO - '--xperf_path', 22:46:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:46:40 INFO - 'tests': ['tp5n']}}, 22:46:40 INFO - 'talos.zip': {'path': '', 22:46:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:46:40 INFO - Running post-action listener: _resource_record_post_action 22:46:40 INFO - ##### 22:46:40 INFO - ##### Running create-virtualenv step. 22:46:40 INFO - ##### 22:46:40 INFO - Running pre-action listener: _resource_record_pre_action 22:46:40 INFO - Running main action method: create_virtualenv 22:46:40 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:46:40 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:46:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:46:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:46:40 INFO - Using real prefix '/usr' 22:46:40 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:46:41 INFO - Installing distribute.............................................................................................................................................................................................done. 22:46:43 INFO - Installing pip.................done. 22:46:43 INFO - Return code: 0 22:46:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:46:43 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:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:43 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:46:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:43 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 0x7f8cd4aaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a01670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a908c0>, '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 0x1a917c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a91c50>, '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': 'df17445c3590ff7897617a0e00000225-1455077768.147086-1596626838', '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:46:43 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:46:43 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:46:43 INFO - Using env: {'DISPLAY': ':0', 22:46:43 INFO - 'HOME': '/home/cltbld', 22:46:43 INFO - 'LANG': 'en_US.UTF-8', 22:46:43 INFO - 'LANGUAGE': 'en_US:en', 22:46:43 INFO - 'LOGNAME': 'cltbld', 22:46:43 INFO - 'MAIL': '/var/mail/cltbld', 22:46:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:43 INFO - 'MOZ_NO_REMOTE': '1', 22:46:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:46:43 INFO - 'NO_EM_RESTART': '1', 22:46:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:46:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:46:43 INFO - 'PWD': '/builds/slave/test-pgo', 22:46:43 INFO - 'SHELL': '/bin/bash', 22:46:43 INFO - 'SHLVL': '1', 22:46:43 INFO - 'TERM': 'linux', 22:46:43 INFO - 'TMOUT': '86400', 22:46:43 INFO - 'USER': 'cltbld', 22:46:43 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1455077768.147086-1596626838', 22:46:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:43 INFO - '_': '/tools/buildbot/bin/python'} 22:46:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:44 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:46:44 INFO - Cleaning up... 22:46:44 INFO - Return code: 0 22:46:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:46:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:46:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:44 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 0x7f8cd4aaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a01670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a908c0>, '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 0x1a917c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a91c50>, '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': 'df17445c3590ff7897617a0e00000225-1455077768.147086-1596626838', '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:46:44 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:46:44 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:46:44 INFO - Using env: {'DISPLAY': ':0', 22:46:44 INFO - 'HOME': '/home/cltbld', 22:46:44 INFO - 'LANG': 'en_US.UTF-8', 22:46:44 INFO - 'LANGUAGE': 'en_US:en', 22:46:44 INFO - 'LOGNAME': 'cltbld', 22:46:44 INFO - 'MAIL': '/var/mail/cltbld', 22:46:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:44 INFO - 'MOZ_NO_REMOTE': '1', 22:46:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:46:44 INFO - 'NO_EM_RESTART': '1', 22:46:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:46:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:46:44 INFO - 'PWD': '/builds/slave/test-pgo', 22:46:44 INFO - 'SHELL': '/bin/bash', 22:46:44 INFO - 'SHLVL': '1', 22:46:44 INFO - 'TERM': 'linux', 22:46:44 INFO - 'TMOUT': '86400', 22:46:44 INFO - 'USER': 'cltbld', 22:46:44 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1455077768.147086-1596626838', 22:46:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:44 INFO - '_': '/tools/buildbot/bin/python'} 22:46:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:44 INFO - Downloading/unpacking psutil>=0.7.1 22:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:46:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:46:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:46:47 INFO - Installing collected packages: psutil 22:46:47 INFO - Running setup.py install for psutil 22:46:47 INFO - building 'psutil._psutil_linux' extension 22:46:47 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:46: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:46:49 INFO - building 'psutil._psutil_posix' extension 22:46: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:46:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:46:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:46:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:46:49 INFO - Successfully installed psutil 22:46:49 INFO - Cleaning up... 22:46:49 INFO - Return code: 0 22:46:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:46:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:46:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cd4aaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a01670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a908c0>, '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 0x1a917c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a91c50>, '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': 'df17445c3590ff7897617a0e00000225-1455077768.147086-1596626838', '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:46:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 22:46:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:46:49 INFO - Using env: {'DISPLAY': ':0', 22:46:49 INFO - 'HOME': '/home/cltbld', 22:46:49 INFO - 'LANG': 'en_US.UTF-8', 22:46:49 INFO - 'LANGUAGE': 'en_US:en', 22:46:49 INFO - 'LOGNAME': 'cltbld', 22:46:49 INFO - 'MAIL': '/var/mail/cltbld', 22:46:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:49 INFO - 'MOZ_NO_REMOTE': '1', 22:46:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:46:49 INFO - 'NO_EM_RESTART': '1', 22:46:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:46:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:46:49 INFO - 'PWD': '/builds/slave/test-pgo', 22:46:49 INFO - 'SHELL': '/bin/bash', 22:46:49 INFO - 'SHLVL': '1', 22:46:49 INFO - 'TERM': 'linux', 22:46:49 INFO - 'TMOUT': '86400', 22:46:49 INFO - 'USER': 'cltbld', 22:46:49 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1455077768.147086-1596626838', 22:46:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:49 INFO - '_': '/tools/buildbot/bin/python'} 22:46:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:46:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:46:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:46:51 INFO - Installing collected packages: mozsystemmonitor 22:46:51 INFO - Running setup.py install for mozsystemmonitor 22:46:51 INFO - Successfully installed mozsystemmonitor 22:46:51 INFO - Cleaning up... 22:46:51 INFO - Return code: 0 22:46:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:46:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cd4aaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a01670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a908c0>, '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 0x1a917c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a91c50>, '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': 'df17445c3590ff7897617a0e00000225-1455077768.147086-1596626838', '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:46:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 22:46:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:46:51 INFO - Using env: {'DISPLAY': ':0', 22:46:51 INFO - 'HOME': '/home/cltbld', 22:46:51 INFO - 'LANG': 'en_US.UTF-8', 22:46:51 INFO - 'LANGUAGE': 'en_US:en', 22:46:51 INFO - 'LOGNAME': 'cltbld', 22:46:51 INFO - 'MAIL': '/var/mail/cltbld', 22:46:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:51 INFO - 'MOZ_NO_REMOTE': '1', 22:46:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:46:51 INFO - 'NO_EM_RESTART': '1', 22:46:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:46:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:46:51 INFO - 'PWD': '/builds/slave/test-pgo', 22:46:51 INFO - 'SHELL': '/bin/bash', 22:46:51 INFO - 'SHLVL': '1', 22:46:51 INFO - 'TERM': 'linux', 22:46:51 INFO - 'TMOUT': '86400', 22:46:51 INFO - 'USER': 'cltbld', 22:46:51 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1455077768.147086-1596626838', 22:46:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:51 INFO - '_': '/tools/buildbot/bin/python'} 22:46:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:51 INFO - Downloading/unpacking blobuploader==1.2.4 22:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:53 INFO - Downloading blobuploader-1.2.4.tar.gz 22:46:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:46:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:46:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:46: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:46: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:46: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:46: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:46: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:46: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:46:54 INFO - Downloading docopt-0.6.1.tar.gz 22:46:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:46:54 INFO - Installing collected packages: blobuploader, requests, docopt 22:46:54 INFO - Running setup.py install for blobuploader 22:46:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:46:54 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:46:54 INFO - Running setup.py install for requests 22:46:54 INFO - Running setup.py install for docopt 22:46:54 INFO - Successfully installed blobuploader requests docopt 22:46:54 INFO - Cleaning up... 22:46:55 INFO - Return code: 0 22:46:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:46:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:46:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:55 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 0x7f8cd4aaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a01670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a908c0>, '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 0x1a917c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a91c50>, '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': 'df17445c3590ff7897617a0e00000225-1455077768.147086-1596626838', '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:46:55 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:46:55 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:46:55 INFO - Using env: {'DISPLAY': ':0', 22:46:55 INFO - 'HOME': '/home/cltbld', 22:46:55 INFO - 'LANG': 'en_US.UTF-8', 22:46:55 INFO - 'LANGUAGE': 'en_US:en', 22:46:55 INFO - 'LOGNAME': 'cltbld', 22:46:55 INFO - 'MAIL': '/var/mail/cltbld', 22:46:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:55 INFO - 'MOZ_NO_REMOTE': '1', 22:46:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:46:55 INFO - 'NO_EM_RESTART': '1', 22:46:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:46:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:46:55 INFO - 'PWD': '/builds/slave/test-pgo', 22:46:55 INFO - 'SHELL': '/bin/bash', 22:46:55 INFO - 'SHLVL': '1', 22:46:55 INFO - 'TERM': 'linux', 22:46:55 INFO - 'TMOUT': '86400', 22:46:55 INFO - 'USER': 'cltbld', 22:46:55 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1455077768.147086-1596626838', 22:46:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:55 INFO - '_': '/tools/buildbot/bin/python'} 22:46:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:46:55 INFO - Running setup.py (path:/tmp/pip-UP0r_e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:46:55 INFO - Running setup.py (path:/tmp/pip-ezJnfP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:46:55 INFO - Running setup.py (path:/tmp/pip-jWrOZr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:46:55 INFO - Running setup.py (path:/tmp/pip-qG3jNx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:46:55 INFO - Running setup.py (path:/tmp/pip-wVIkRU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:46:55 INFO - Running setup.py (path:/tmp/pip-eZQfsC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:46:55 INFO - Running setup.py (path:/tmp/pip-moQn8o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:46:55 INFO - Running setup.py (path:/tmp/pip-PALbaC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:46:55 INFO - Running setup.py (path:/tmp/pip-kdoffc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:46:55 INFO - Running setup.py (path:/tmp/pip-qgXlNi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:46:55 INFO - Running setup.py (path:/tmp/pip-Ez4NQ4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:46:56 INFO - Running setup.py (path:/tmp/pip-uK9VtC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:46:56 INFO - Running setup.py (path:/tmp/pip-LNRBHm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:46:56 INFO - Running setup.py (path:/tmp/pip-w06u8f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:46:56 INFO - Running setup.py (path:/tmp/pip-AtEKS7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:46:56 INFO - Running setup.py (path:/tmp/pip-KceHqa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:46:56 INFO - Running setup.py (path:/tmp/pip-txHOjo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:46:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:46:56 INFO - Running setup.py install for manifestparser 22:46:56 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:46:56 INFO - Running setup.py install for mozcrash 22:46:56 INFO - Running setup.py install for mozdebug 22:46:56 INFO - Running setup.py install for mozdevice 22:46:56 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:46:56 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:46:56 INFO - Running setup.py install for mozfile 22:46:56 INFO - Running setup.py install for mozhttpd 22:46:57 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:46:57 INFO - Running setup.py install for mozinfo 22:46:57 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:46:57 INFO - Running setup.py install for mozInstall 22:46:57 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:46:57 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:46:57 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:46:57 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:46:57 INFO - Running setup.py install for mozleak 22:46:57 INFO - Running setup.py install for mozlog 22:46:57 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:46:57 INFO - Running setup.py install for moznetwork 22:46:57 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:46:57 INFO - Running setup.py install for mozprocess 22:46:57 INFO - Running setup.py install for mozprofile 22:46:57 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:46:57 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:46:57 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:46:57 INFO - Running setup.py install for mozrunner 22:46:57 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:46:57 INFO - Running setup.py install for mozscreenshot 22:46:58 INFO - Running setup.py install for moztest 22:46:58 INFO - Running setup.py install for mozversion 22:46:58 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:46:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:46:58 INFO - Cleaning up... 22:46:58 INFO - Return code: 0 22:46:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:46:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:46:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:46:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:46:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cd4aaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a01670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a908c0>, '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 0x1a917c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a91c50>, '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': 'df17445c3590ff7897617a0e00000225-1455077768.147086-1596626838', '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:46:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:46:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:46:58 INFO - Using env: {'DISPLAY': ':0', 22:46:58 INFO - 'HOME': '/home/cltbld', 22:46:58 INFO - 'LANG': 'en_US.UTF-8', 22:46:58 INFO - 'LANGUAGE': 'en_US:en', 22:46:58 INFO - 'LOGNAME': 'cltbld', 22:46:58 INFO - 'MAIL': '/var/mail/cltbld', 22:46:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:46:58 INFO - 'MOZ_NO_REMOTE': '1', 22:46:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:46:58 INFO - 'NO_EM_RESTART': '1', 22:46:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:46:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:46:58 INFO - 'PWD': '/builds/slave/test-pgo', 22:46:58 INFO - 'SHELL': '/bin/bash', 22:46:58 INFO - 'SHLVL': '1', 22:46:58 INFO - 'TERM': 'linux', 22:46:58 INFO - 'TMOUT': '86400', 22:46:58 INFO - 'USER': 'cltbld', 22:46:58 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1455077768.147086-1596626838', 22:46:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:46:58 INFO - '_': '/tools/buildbot/bin/python'} 22:46:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:46:58 INFO - Running setup.py (path:/tmp/pip-_Uj6KE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:46:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 22:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:46:58 INFO - Running setup.py (path:/tmp/pip-tOt79D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:46:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:46:58 INFO - Running setup.py (path:/tmp/pip-TlmcMK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:46:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:46:58 INFO - Running setup.py (path:/tmp/pip-NkWM_8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:46:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:46:58 INFO - Running setup.py (path:/tmp/pip-iV8ehm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:46:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 22:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:46:58 INFO - Running setup.py (path:/tmp/pip-0InAbI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:46:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 22:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:46:58 INFO - Running setup.py (path:/tmp/pip-6_tWqc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:46:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 22:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:46:58 INFO - Running setup.py (path:/tmp/pip-6f3_0F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:46:59 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:46:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:46:59 INFO - Running setup.py (path:/tmp/pip-wsMTK3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:46:59 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:46:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:46:59 INFO - Running setup.py (path:/tmp/pip-CWQ1wY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:46:59 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:46:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:46:59 INFO - Running setup.py (path:/tmp/pip-LTqHRv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 22:46:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:46:59 INFO - Running setup.py (path:/tmp/pip-rI8kcO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 22:46:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:46:59 INFO - Running setup.py (path:/tmp/pip-ZqVGdR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 22:46:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:46:59 INFO - Running setup.py (path:/tmp/pip-iXEp04-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 22:46:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:46:59 INFO - Running setup.py (path:/tmp/pip-94UBbo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 22:46:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:46:59 INFO - Running setup.py (path:/tmp/pip-Igxod7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 22:46:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:46:59 INFO - Running setup.py (path:/tmp/pip-zu0wip-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 22:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:46:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:46:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:46:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:01 INFO - Downloading blessings-1.6.tar.gz 22:47:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:47:01 INFO - Installing collected packages: blessings 22:47:01 INFO - Running setup.py install for blessings 22:47:01 INFO - Successfully installed blessings 22:47:01 INFO - Cleaning up... 22:47:01 INFO - Return code: 0 22:47:01 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:47:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:47:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:47:02 INFO - Reading from file tmpfile_stdout 22:47:02 INFO - Current package versions: 22:47:02 INFO - argparse == 1.2.1 22:47:02 INFO - blessings == 1.6 22:47:02 INFO - blobuploader == 1.2.4 22:47:02 INFO - docopt == 0.6.1 22:47:02 INFO - manifestparser == 1.1 22:47:02 INFO - mozInstall == 1.12 22:47:02 INFO - mozcrash == 0.16 22:47:02 INFO - mozdebug == 0.1 22:47:02 INFO - mozdevice == 0.48 22:47:02 INFO - mozfile == 1.2 22:47:02 INFO - mozhttpd == 0.7 22:47:02 INFO - mozinfo == 0.9 22:47:02 INFO - mozleak == 0.1 22:47:02 INFO - mozlog == 3.1 22:47:02 INFO - moznetwork == 0.27 22:47:02 INFO - mozprocess == 0.22 22:47:02 INFO - mozprofile == 0.28 22:47:02 INFO - mozrunner == 6.11 22:47:02 INFO - mozscreenshot == 0.1 22:47:02 INFO - mozsystemmonitor == 0.0 22:47:02 INFO - moztest == 0.7 22:47:02 INFO - mozversion == 1.4 22:47:02 INFO - psutil == 3.1.1 22:47:02 INFO - requests == 1.2.3 22:47:02 INFO - wsgiref == 0.1.2 22:47:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:47:02 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:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:02 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:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:02 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 0x7f8cd4aaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a01670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a908c0>, '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 0x1a917c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a91c50>, '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': 'df17445c3590ff7897617a0e00000225-1455077768.147086-1596626838', '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:47:02 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:47:02 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:47:02 INFO - Using env: {'DISPLAY': ':0', 22:47:02 INFO - 'HOME': '/home/cltbld', 22:47:02 INFO - 'LANG': 'en_US.UTF-8', 22:47:02 INFO - 'LANGUAGE': 'en_US:en', 22:47:02 INFO - 'LOGNAME': 'cltbld', 22:47:02 INFO - 'MAIL': '/var/mail/cltbld', 22:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:02 INFO - 'MOZ_NO_REMOTE': '1', 22:47:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:02 INFO - 'NO_EM_RESTART': '1', 22:47:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:47:02 INFO - 'PWD': '/builds/slave/test-pgo', 22:47:02 INFO - 'SHELL': '/bin/bash', 22:47:02 INFO - 'SHLVL': '1', 22:47:02 INFO - 'TERM': 'linux', 22:47:02 INFO - 'TMOUT': '86400', 22:47:02 INFO - 'USER': 'cltbld', 22:47:02 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1455077768.147086-1596626838', 22:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:02 INFO - '_': '/tools/buildbot/bin/python'} 22:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:02 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:47:02 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:47:02 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:47:02 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:47:02 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:47:02 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:47:02 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:47:02 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:47:02 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:47:02 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:47:02 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:47:02 INFO - Cleaning up... 22:47:02 INFO - Return code: 0 22:47:02 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:47:02 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:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:02 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:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:02 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 0x7f8cd4aaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a01670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a908c0>, '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 0x1a917c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a91c50>, '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': 'df17445c3590ff7897617a0e00000225-1455077768.147086-1596626838', '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:47:02 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:47:02 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:47:02 INFO - Using env: {'DISPLAY': ':0', 22:47:02 INFO - 'HOME': '/home/cltbld', 22:47:02 INFO - 'LANG': 'en_US.UTF-8', 22:47:02 INFO - 'LANGUAGE': 'en_US:en', 22:47:02 INFO - 'LOGNAME': 'cltbld', 22:47:02 INFO - 'MAIL': '/var/mail/cltbld', 22:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:02 INFO - 'MOZ_NO_REMOTE': '1', 22:47:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:02 INFO - 'NO_EM_RESTART': '1', 22:47:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:47:02 INFO - 'PWD': '/builds/slave/test-pgo', 22:47:02 INFO - 'SHELL': '/bin/bash', 22:47:02 INFO - 'SHLVL': '1', 22:47:02 INFO - 'TERM': 'linux', 22:47:02 INFO - 'TMOUT': '86400', 22:47:02 INFO - 'USER': 'cltbld', 22:47:02 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1455077768.147086-1596626838', 22:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:02 INFO - '_': '/tools/buildbot/bin/python'} 22:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:02 INFO - Downloading/unpacking jsonschema 22:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:47:04 INFO - Downloading/unpacking functools32 (from jsonschema) 22:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:04 INFO - Downloading functools32-3.2.3-2.tar.gz 22:47:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:47:04 INFO - warning: no files found matching '*.txt' 22:47:04 INFO - no previously-included directories found matching 'build' 22:47:04 INFO - no previously-included directories found matching 'dist' 22:47:04 INFO - no previously-included directories found matching '.git*' 22:47:04 INFO - Installing collected packages: jsonschema, functools32 22:47:04 INFO - Running setup.py install for functools32 22:47:04 INFO - warning: no files found matching '*.txt' 22:47:04 INFO - no previously-included directories found matching 'build' 22:47:04 INFO - no previously-included directories found matching 'dist' 22:47:04 INFO - no previously-included directories found matching '.git*' 22:47:04 INFO - Successfully installed jsonschema functools32 22:47:04 INFO - Cleaning up... 22:47:04 INFO - Return code: 0 22:47:04 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cd4aaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a01670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a908c0>, '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 0x1a917c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a91c50>, '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': 'df17445c3590ff7897617a0e00000225-1455077768.147086-1596626838', '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:47:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 22:47:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:47:04 INFO - Using env: {'DISPLAY': ':0', 22:47:04 INFO - 'HOME': '/home/cltbld', 22:47:04 INFO - 'LANG': 'en_US.UTF-8', 22:47:04 INFO - 'LANGUAGE': 'en_US:en', 22:47:04 INFO - 'LOGNAME': 'cltbld', 22:47:04 INFO - 'MAIL': '/var/mail/cltbld', 22:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:04 INFO - 'MOZ_NO_REMOTE': '1', 22:47:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:04 INFO - 'NO_EM_RESTART': '1', 22:47:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:47:04 INFO - 'PWD': '/builds/slave/test-pgo', 22:47:04 INFO - 'SHELL': '/bin/bash', 22:47:04 INFO - 'SHLVL': '1', 22:47:04 INFO - 'TERM': 'linux', 22:47:04 INFO - 'TMOUT': '86400', 22:47:04 INFO - 'USER': 'cltbld', 22:47:04 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1455077768.147086-1596626838', 22:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:04 INFO - '_': '/tools/buildbot/bin/python'} 22:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:04 INFO - Downloading/unpacking flake8 22:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:47:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:47: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:47: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:47: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:47: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:47: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:47: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:47:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:47:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:47: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:47: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:47: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:47: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:47: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:47: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:47:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:47: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:47: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:47: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:47: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:47: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:47: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:47:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:47:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:47:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:47:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:47:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:47:07 INFO - no previously-included directories found matching 'docs/_build' 22:47:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:47:07 INFO - Running setup.py install for pep8 22:47:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:47:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:47:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:47:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:47:07 INFO - no previously-included directories found matching 'docs/_build' 22:47:07 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:47:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:47:07 INFO - Cleaning up... 22:47:07 INFO - Return code: 0 22:47:07 INFO - Running post-action listener: _resource_record_post_action 22:47:07 INFO - Running post-action listener: _start_resource_monitoring 22:47:07 INFO - Starting resource monitoring. 22:47:07 INFO - ##### 22:47:07 INFO - ##### Running install step. 22:47:07 INFO - ##### 22:47:07 INFO - Running pre-action listener: _resource_record_pre_action 22:47:07 INFO - Running main action method: install 22:47:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:47:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:47:07 INFO - Reading from file tmpfile_stdout 22:47:07 INFO - Detecting whether we're running mozinstall >=1.0... 22:47:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:47:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:47:08 INFO - Reading from file tmpfile_stdout 22:47:08 INFO - Output received: 22:47:08 INFO - Usage: mozinstall [options] installer 22:47:08 INFO - Options: 22:47:08 INFO - -h, --help show this help message and exit 22:47:08 INFO - -d DEST, --destination=DEST 22:47:08 INFO - Directory to install application into. [default: 22:47:08 INFO - "/builds/slave/test-pgo"] 22:47:08 INFO - --app=APP Application being installed. [default: firefox] 22:47:08 INFO - mkdir: /builds/slave/test-pgo/build/application 22:47:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 22:47:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 22:47:24 INFO - Reading from file tmpfile_stdout 22:47:24 INFO - Output received: 22:47:24 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:47:24 INFO - Running post-action listener: _resource_record_post_action 22:47:24 INFO - ##### 22:47:24 INFO - ##### Running run-tests step. 22:47:24 INFO - ##### 22:47:24 INFO - Running pre-action listener: _resource_record_pre_action 22:47:24 INFO - Running main action method: run_tests 22:47:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:47:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:47:24 INFO - Python 2.7.3 22:47:24 INFO - Return code: 0 22:47:24 INFO - grabbing minidump binary from tooltool 22:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:24 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 0x1a908c0>, '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 0x1a917c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a91c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:47:24 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:47:24 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:47:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:47:24 INFO - Return code: 0 22:47:24 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:47:24 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:47:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:47:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:47:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:47:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:47:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:47:25 INFO - Return code: 0 22:47:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/POXjeZiRQQiDmeZXKPwxQg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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:47:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/POXjeZiRQQiDmeZXKPwxQg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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:47:25 INFO - Using env: {'DISPLAY': ':0', 22:47:25 INFO - 'HOME': '/home/cltbld', 22:47:25 INFO - 'LANG': 'en_US.UTF-8', 22:47:25 INFO - 'LANGUAGE': 'en_US:en', 22:47:25 INFO - 'LOGNAME': 'cltbld', 22:47:25 INFO - 'MAIL': '/var/mail/cltbld', 22:47:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:47:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:47:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:25 INFO - 'MOZ_NO_REMOTE': '1', 22:47:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:47:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:25 INFO - 'NO_EM_RESTART': '1', 22:47:25 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:47:25 INFO - 'PWD': '/builds/slave/test-pgo', 22:47:25 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:47:25 INFO - 'SHELL': '/bin/bash', 22:47:25 INFO - 'SHLVL': '1', 22:47:25 INFO - 'TERM': 'linux', 22:47:25 INFO - 'TMOUT': '86400', 22:47:25 INFO - 'USER': 'cltbld', 22:47:25 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1455077768.147086-1596626838', 22:47:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:25 INFO - '_': '/tools/buildbot/bin/python'} 22:47:25 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/POXjeZiRQQiDmeZXKPwxQg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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:47:26 INFO - mozversion application_buildid: 20160209203213 22:47:26 INFO - mozversion application_changeset: 337331f990883ff125b1e764cb919d5029e9883b 22:47:26 INFO - mozversion application_display_name: Nightly 22:47:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:47:26 INFO - mozversion application_name: Firefox 22:47:26 INFO - mozversion application_remotingname: firefox 22:47:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:47:26 INFO - mozversion application_vendor: Mozilla 22:47:26 INFO - mozversion application_version: 47.0a1 22:47:26 INFO - mozversion platform_buildid: 20160209203213 22:47:26 INFO - mozversion platform_changeset: 337331f990883ff125b1e764cb919d5029e9883b 22:47:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:47:26 INFO - mozversion platform_version: 47.0a1 22:47:26 INFO - using testdate: 1455086846 22:47:26 INFO - actual date: 1455086846 22:47:26 INFO - starting webserver on 'localhost:51746' 22:47:26 INFO - SUITE-START | Running 2 tests 22:47:26 INFO - TEST-START | dromaeo_css 22:47:26 INFO - operating with platform_type : linux_ 22:47:26 INFO - Initialising browser for dromaeo_css test... 22:47:26 INFO - TEST-INFO | started process 3372 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp22MMib/profile http://localhost:51746/getInfo.html) 22:47:33 INFO - PROCESS | 3372 | __metrics Screen width/height:1600/1200 22:47:33 INFO - PROCESS | 3372 | colorDepth:24 22:47:33 INFO - PROCESS | 3372 | Browser inner width/height: 1024/697 22:47:33 INFO - PROCESS | 3372 | __metrics 22:47:33 INFO - PROCESS | 3372 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:47:34 INFO - TEST-INFO | 3372: exit 0 22:47:34 INFO - Browser initialized. 22:47:34 INFO - Running cycle 1/1 for dromaeo_css test... 22:47:34 INFO - TEST-INFO | started process 3463 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp22MMib/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:47:46 INFO - PROCESS | 3463 | RSS: Main: 152862720 22:47:46 INFO - PROCESS | 3463 | 22:48:37 INFO - PROCESS | 3463 | 1455086917912 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] 22:50:46 INFO - PROCESS | 3463 | Cycle 1(1): loaded http://localhost:51746/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51746/tests/dromaeo/cssquery-ext.html) 22:50:47 INFO - PROCESS | 3463 | RSS: Main: 268627968 22:50:47 INFO - PROCESS | 3463 | 22:53:50 INFO - PROCESS | 3463 | Cycle 1(1): loaded http://localhost:51746/tests/dromaeo/cssquery-ext.html (next: http://localhost:51746/tests/dromaeo/cssquery-jquery.html) 22:53:50 INFO - PROCESS | 3463 | RSS: Main: 234631168 22:53:50 INFO - PROCESS | 3463 | 22:56:52 INFO - PROCESS | 3463 | Cycle 1(1): loaded http://localhost:51746/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51746/tests/dromaeo/cssquery-mootools.html) 22:56:53 INFO - PROCESS | 3463 | RSS: Main: 241561600 22:56:53 INFO - PROCESS | 3463 | 22:59:55 INFO - PROCESS | 3463 | Cycle 1(1): loaded http://localhost:51746/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51746/tests/dromaeo/cssquery-prototype.html) 22:59:55 INFO - PROCESS | 3463 | RSS: Main: 213704704 22:59:55 INFO - PROCESS | 3463 | 23:02:58 INFO - PROCESS | 3463 | Cycle 1(1): loaded http://localhost:51746/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51746/tests/dromaeo/cssquery-yui.html) 23:02:59 INFO - PROCESS | 3463 | RSS: Main: 218406912 23:02:59 INFO - PROCESS | 3463 | 23:06:01 INFO - PROCESS | 3463 | Cycle 1(1): loaded http://localhost:51746/tests/dromaeo/cssquery-yui.html (next: http://localhost:51746/tests/dromaeo/cssquery-dojo.html) 23:06:02 INFO - PROCESS | 3463 | RSS: Main: 273399808 23:06:02 INFO - PROCESS | 3463 | 23:06:02 INFO - PROCESS | 3463 | __start_tp_report 23:06:02 INFO - PROCESS | 3463 | _x_x_mozilla_page_load 23:06:02 INFO - PROCESS | 3463 | _x_x_mozilla_page_load_details 23:06:02 INFO - PROCESS | 3463 | |i|pagename|runs| 23:06:02 INFO - PROCESS | 3463 | |0;dojo.html;3160.715535601796;3181.17289504729;3205.5512228288044;3222.4038552867723;3255.8209298488587;5085.694858308504;5155.4586768389345;5188.533032027117;5196.0647083525;5226.24219488174;5251.396089449714;5260.894782104356;5262.736863156846;5269.420363759983;5288.92066619001;4740.36005139307;4759.976200119003;4783.736894470802;4826.927596086061;4956.157453232941;4761.190597598416;4868.318435419026;4873.366462359888;4901.509849015088;4946.282788995593;4755.120302744003;4755.286706993944;4766.428028636568;4808.158572249842;4854.757262136896;4676.929846052312;4687.601553867926;4714.740689262124;4715.43414790224;4759.928601070987;4698.647601429906;4711.199096153628;4745.383100196987;4783.904321913542;4784.186688263004;4992.575631071363;5056;5111.105556527593;5177.896442071175;5216.426193118754;5654.943450565524;5669.801556945528;5670.716464176775;5670.943290567083;5671.319441666985;5554.166874968747;5681.204631351614;5697.6866272355;5699;5707.828765137053;5202.0116177926075;5209.505097015777;5209.661372010807;5227.372715274191;5356;5699.430056994267;5717.914876303662;5722.656640601577;5726.942730572724;5775.249217601769;5482.013237617188;5491.560675146058;5501.092319767274;5502.257195278667;5517.751701173457;5507.834764957058;5566.888662226814;5583.0787919992745;5610.13042978339;5670.461306175906;5562.360328562268;5569.693666848281;5573.442655734475;5589.80435684749;5619.494245517923;5572.972135139298;5573.247611572467;5581.553475721932;5588.804391846347;5590.580706446952;4255.893602659897;4341.9131617367475;4358.934615980763;4403.9779801100785;4433.379326894237;3884.1454879926373;3886.6502014818802;3888.1640447303967;3889.5138107736534;3945.388464787905;5263.605229607795;5270.393904701008;5271.393789714232;5280.9207861882105;5282.81510147143;5522.447755224445;5616.663000219918;5621.915671264935;5634.4365563443325;5715.48560629537;5317.893642127213;5325.760340784674;5326;5336.91994620081;5362.195670649356;4816.133096042676;4822.421309442819;4830.9275360869615;4834.444038935568;4876.512348765095;5644.689542075225;5747.281589801275;5859.2382990211;5905.202797622352;5906.8818623627285;5598.384177740527;5640.943590564206;5656.264685591012;5676.489115979582;5722.456366645162;5817;5841.065429531254;5860.062390017577;5869.73586188614;5871.4715675589405;5443.673379597237;5517.117261238182;5559.6664200148125;5571.192177134212;5592.916106258328;5544.140658197985;5565.749541270571;5574.665520068809;5625.409332020243;5683.175939488834;5446.836594902159;5449.64577302474;5460.044492213926;5464.415558543689;5473.2063850742215;5424.321959755031;5456.427075157051;5501.972490137524;5508.807191748269;5515.61390702647;5338.492843179892;5401.243825864461;5442.428545002717;5444.3194600674915;5447.428020057837;5531.834044978657;5547.472990065938;5564.721763911707;5572.387037425961;5576.163575463713;5350.973245133905;5428.70142142186;5436.700981446058;5440.075187218104;5447.645903016291 23:06:02 INFO - PROCESS | 3463 | |1;ext.html;506.50109642002644;539.8569379114538;556.374079160944;570.5948776368776;589.3634874335718;35611;36451.27097458049;36474.81762591183;36492.45261321079;36501.269974600524;38618.80690596543;39150;39208.41187382192;39256.21487570247;39336.409953850714;8542.572871356439;8745.081766414498;8746.475211487299;8747;8748.168923952215;8535.231829135377;8663.176998185163;8664.913350866505;8821.073787252342;8883.378163528556;8892;8985.595648195847;8991.730248092535;8995.775105622346;8995.865062024075;8828.558572071403;8893.555322233895;8896.199342059246;8901.866472002925;8913.55432228386;8760.824783504358;8869.866951995726;8890.244329232022;8898.688545900863;8899.421537600036;39180.60819391798;39581.60418395837;39624.60375396238;39633.40549891754;39647.80176099101;2107.8208352290076;3229.3541291741512;3303.702666760003;3361.983190084034;3382.695557399821;26274.21177364682;26979.190624281302;27055.45889082227;27197.592036119473;27686;3645.398509245971;3724.4599533067826;3741.5323084614424;3874.2832575973534;3905.2775236581324;166327.99999999878;166436.16781916012;166705.16647416807;167276;167314;51809;56149.43850561524;56484.71757641186;56527.71736141293;59770.402295976484;54049.72975135099;54307.45692543024;54443.45556544463;54507.72746136244;54521.45478545243;15839.445619403496;16046.277917493508;16052.27764750589;16072;16073.598160046093;12368.257904525757;12427.627171184879;12457.501699931901;12459.750804983849;12477.251364917953;19040.61918761617;19982.70025949612;19988.90005549963;20079.598408031758;20107.698384524243;7436.256374362629;7552.962235188898;7569.962150189213;7670.501417407851;7714.3442807362;945.1304799584399;1095.8246680531236;1102.1127991966384;1136.596508239563;1140.9731241882373;30032.84983575068;30173;31906.361872762416;32289.838550807097;32739.345213095603;1008.5763979128784;1052.1582733813073;1057.3655806516028;1059.6079450603172;1082.8213344798178;15322.770158447633;15465;15555.45555905538;15727.921360393353;16182.75725864113;340077;352221;352435;352797;352842;53835;53883.461165387846;53939.730301349024;54381.45618543764;54417.45582544203;1332;1339.7052648417528;1365.7746471832236;1368.9931550342383;1370.5751217122724;23622.52754944926;28929.855350723952;31722.841385792923;34387.312253755284;35129;49629.50370496249;50577.74711126421;50579.747101264256;50586;50713;252396;275888;278384;279062;279632;31364.686353136178;31503;31602.841985789924;31833.840830795696;31847.68152318447;40762.59237407588;41302.586974129874;41324.38013429861;41656.791716041225;42285.788571056946;33409.83295083509;35368.11579710528;35521.64478355287;35561;36100.638993609726;34598.65401345954;34962.47556286708;35257.118572035906;35388.82305588455;35664;33439.66560334463;33764.32471350608;40471;41264.58735412607;41307.7934610325;30074.69925300719;33329.83335083309;33770;33814;34035.65964340325;25080.60732503495;25369.492610148063;25654.102106426184;25661.486770264863;26056.34859128461 23:06:02 INFO - PROCESS | 3463 | |2;jquery.html;344.42652982783665;351.6465951718523;355.4561520873064;358.53390592230113;359.8308794866412;13670.384832682528;14137.717245655107;16323.183840807957;16886.72029276049;18286.074228123503;15633.452829150981;15886;17006.914965425185;17057.488275351727;17061.061641609736;4784.497627749097;4995.925061124086;4996.150654388763;4997.700137991714;5000.67495612784;3694.907627309312;3755.4179102239195;3890.396988466778;5379.058664733676;5572.4706152915405;5543.168524721284;5577.553795696354;5589.7205139743055;5593.188987596816;5877.265341832271;5963.9403605964035;5999.730012149442;6146.692665366714;6151.200343955279;6155.261368635747;5040.521150490697;5309.734513274359;5314.893702125974;5319.148936170232;5342.091844386464;19602.215911363528;19661.410157695293;20082.497937551532;20332.08505617251;20344.491387715276;2156.148321413049;2228.19784877444;2284.3946354216146;2366.1008816649737;2777.5833624956217;9622.37454565451;11969.042476601851;12746.872531274754;12875.004993408704;13464.730705385837;1865.253898440621;1879.8966056866866;1896.924123035077;1919.7984211657715;1936.7579052618423;57468.42531574715;57597.7120114401;57666.42333576652;57807.42192578105;57924;10057.497125143713;10067;10083.445410502492;10088.546015429176;10176.643817466353;13183.340832958314;13348;13380.19718816874;13381.197128172145;13400.262985535888;7637.732679356196;7759.068911730628;7820.491668041559;7900.841983160304;7903;7642.617869106522;7658.2724641159;7718.884216736754;7736.497127686683;7766.92233077662;4074.4499492568716;4141.130362623822;4211.578842115825;4447.533009034069;4535.455745310518;1800.5318617159633;1815.9092045397676;1827;1859.739636450898;1870.6165236126562;948.1608776232946;966.0050148347214;1010.3887148275335;1016.5082940100777;1034.1881622925966;16087.517374478784;16789.832101679072;16976.660466790596;17042.573935651708;17111.914440427718;940.5250348574064;942.6983365323168;966.1594412860716;1033.8242498775076;1039.7660526381655;9603;9697.369670971506;10220.642277520252;10238.18094552434;10589.417582032907;340359;388315;553796;562035;568506;43823.12353752971;44444;46021.76989115033;53175;71339.64330178316;1124.4377811094453;1157.2709193208393;1163.7381589142544;1176.5940750441084;1183.9995204052561;12544.24734515932;14899.553013409615;15103.093814371174;15137.07918751001;15287.159206243763;24986;33298.5005224917;33544.32911341711;33797.986060418225;34655.48016779801;41528;42499.36250956176;43491.130177395644;44969.32546011747;45013.549864500936;7322.3775979042375;7495.250474952461;7534.623268836646;7593.810154745955;7604.42966777505;3925.43081253211;11344;11609.83901609866;11788.115891308014;11929.403529823649;10353.171746260432;10515.631952881613;10618.575256989634;10693.88323812179;10841.18691098155;10471.895281047093;10474;10499.005189014062;10647.254692171473;10733.195010374096;10174.01606686689;10231.641892534024;10464.424456654653;10837.67486975392;11020.614278500214;7489.176190619137;7559.924400756142;7648.120466146464;7688.654010569426;7699.88450173259;9540.33217674756;10257.74355641115;10573.312734672221;10607.840882386925;10799.892001079888 23:06:02 INFO - PROCESS | 3463 | |3;mootools.html;1338.0366136381801;1449.0436312034058;1457.5044484875143;1632.2573229180716;1810.6921823290031;6826;7408.259174082596;7618.7714368568895;7628.771136865896;7632.771016869503;7308.196098429168;7542.69829206831;7542.962285188566;7554.169041405441;7641;1975.338261682338;2025.3721346382595;2223.3330000999717;2225.5771403433296;2255.9210427635035;2287.553926984239;2291.7249930008425;2295.265515035181;2306.6078766609717;2307.0195167054017;2214.6124428225075;2285.394370491821;2285.5086156476355;2287.3595393289906;2289.267434420986;2238.3844442778286;2250.5723912456583;2302.3438320078862;2319.5592837360846;2325.755795641467;2255.57144142614;2259.9209027684115;2266.5693518231483;2271.9772802272096;2315.525317309964;7953.5227886327;7992.760217193435;8009.51942883423;8014.438989270753;8016.35869130474;4717.834875779366;4830.613550915953;4837.685550439211;4837.7097374157665;4841.370621819141;3080.3993221321853;3083.075077476748;3101.61814880585;3120.6723294054023;3156.6369867465305;964.8890377606594;970.4565443351675;989.945552994585;1006.6074231049823;1011.2466212671533;11083.50124244411;11090.445477726162;11111;11112.333260004425;11123.944380278046;4246.745195288231;4249.426327445817;4351.8476853309985;4367.061081867414;4376.868693939187;9493.572789224501;9496.572654230577;9501.192398646193;9506.287028472892;9523.809523809485;4805.807767689324;4814.277858321209;4816.8073277069225;4825.10735513931;4825.806967721252;4415.249407600716;4420.646348292129;4422.027154026109;4423.093265880487;4426.822927082945;3435.0725304167736;3539.7168226541817;3651.707863370924;3693.7968411737074;3700.796456194881;1173.2901594535183;1176.4176732517458;1207.0464333176867;1218.469965564982;1236.2397125767768;1043.3687618990552;1062.792755412687;1064.520965565483;1201.5614300780153;1333.3466601365456;7019.3682568569075;7097.503174777819;7132.893006604905;7138.571685698771;7144.392726618192;1084.4794498640697;1103.3600511703194;1104.2049724198564;1137.294877176156;1152.3777160333493;5566.2207290979295;5660.886782264414;5662.490375866109;5666.065099258576;5666.829995100154;9566.856497152548;9595.520223988773;9878.506074696237;9986.700398988041;9988;9575.329726919048;9681.709548713408;9684.661036863676;9761.121499064977;9837.360571562825;7167.677454514559;7300.941363502262;7332.486725929134;7355.705771769176;7420.332170104716;7059.894101588377;7094.396976257076;7177.3899218567;7232.963835180791;7238.457115716447;8251.2986396157;8568.957155214184;8839.911600884167;8844.823103537765;8900.821983560163;8496.235338819535;8582.0988796178;8682.218600326001;8716.38985271025;8734.868976965477;6901.89647155283;6937.202221744362;6990.405815505739;6992.930070699228;7006.544574602634;6625.469962403093;7128.180259270251;7275.126984761862;7322.853542929218;7344.081989751281;6811.863762724817;6898.206706228848;6962.268961759145;6997.755078572225;7021.824454388477;6947.44420446353;6963.860722785617;6968.477364197807;6987.5108742389575;6988.126484189476;7008.544444611084;7033.542819716702;7043.718251269892;7060.364567188978;7069.469789765685;6375.936240637534;6512.6743662815725;6574.408303252731;6584.8353791155605;6585.967070164618;6607.405333520006;6631.701573429111;6637.2699003108655;6644.867102658017;6650.73397064112 23:06:02 INFO - PROCESS | 3463 | |4;prototype.html;334.64193313154937;341.57473944938545;343.48477284073897;348.3120836348214;351.07316683954366;5686.943130568693;5873.236479257701;5879.559033072521;5938.554608404365;5950.642961422318;5729.656220626765;5771.047777116782;5796.217510636063;5800.100984347422;5809.796657117002;4534.732633683167;4546.568076032771;4581.1753884300815;4587.816487340502;4589.5410458954175;4336.284513055342;4402.713823601472;4545.36364908913;4550.340200670901;4588.403507544014;4524.751138687371;4524.773761311922;4530.841420550281;4539.72761634303;4543.704659197141;4543.931841022388;4545.886352841172;4547.226971414867;4550.112728018038;4561.6806823522365;4027.8993025174314;4030.556638769733;4032.0927791246736;4032.74984754727;4035.273650742865;5460.26286451328;5602.915956260659;5623.718814059322;5647.43525647436;5654.9151762723595;5313.681179129265;5315.335583052119;5321.946780532184;5324.254604355355;5333.946660533384;5941.168236446901;6306.527010474233;6309.116723658692;6310.558260921737;6322.0516922462;4379.080393117417;4496.2805951048;4528.230200865861;4534.841280555164;4535.229011068126;6477.967610161919;6535.15043044406;6606.570572912745;6612.43794277487;6618.338166183391;4494.07871386365;4496.415465989466;4500.594946454835;4506.909861802746;4507.81968721254;4476.328550717419;4553.271476563734;4566.70316429431;4628.97685511577;4637.652176086807;5309.840704778863;5314.946850531445;5315.113134837077;5317.229001794795;5324.1747529133045;6267.968660156761;6312.705895291454;6319.905201421982;6319.905201421982;6324.747010119636;1600.3198640577707;1606.2771752711326;1607.9919600401922;1608.5254849819332;1609.7826793382978;1122.186414849244;1131.5926266544038;1135.3131355529952;1145.931244125355;1168.1881092640704;5927.229460170151;5928.318243402064;5933.139694744238;5936.614120082181;5941.970290148522;6407;6432.356764323624;6466.773662921775;6469.5794773339585;6470.4823614110755;5923.585349025613;5927.288725352985;5930.169776231331;5941.910871336933;5944.078667806497;3363.1423986883187;3485;3495.8252087395526;3510.8946731598094;3517.278957813642;6781;6786.898196527056;6794.626295553693;6798.490113241527;6801.319868013159;6687.799366019027;6715;6728.966355168192;6734.696938637773;6735.8989615155815;6549.476041916635;6764.222114456802;6772;6776.322367763283;6778.661066946534;6232.968835155976;6370.58591191571;6505.51208659343;6515.381038801306;6516.771912983023;6271.811845644638;6301.936980630135;6318.810435686937;6320.5259605528845;6342.429181373698;6749.156355455568;6759.391654751096;6760.459163267025;6839.110915580943;6841.760538381332;4351.97824010878;4384.846530371422;4445.644348452181;4449.955500444954;4453.576910193527;6513.869722605426;6517;6522.739090436329;6525;6526.216853977553;6327.3988971047675;6341.334159913143;6345.302016778059;6352.174217351715;6356.364363563606;6161.322254552086;6318.4313411793155;6339.651319177489;6341.936580634319;6345.904811427925;6225.501959843292;6227.0970709246;6227.283862355705;6232.968835155795;6235.781747638811;6367.936320636734;6370.713317900798;6370.936290637034;6384.808455746335;6386.105945167587;6055.303640081447;6202.511397264714;6214.725981173758;6215.564910456405;6220.688965551795 23:06:02 INFO - PROCESS | 3463 | |5;yui.html;651.791426743442;714.4820005496013;718.9317014883587;727.428968259916;730.6200775596689;12416.81374779378;12492.06309526787;12676.239425634469;13359.864411525032;13844.446222151102;14686.706265874676;14880.47918322859;14923.776143357858;14926.776098358507;14935.327910244037;684.274668851017;691.2258270736781;809.522381794741;817.0848649512525;826.1696994520498;821.0639870547581;827.1108558299821;833.0752864320599;833.0960907415462;833.4374297349295;860.6213266162899;860.9139086091373;862.995685021574;863.0592654007131;865.1953683074738;697.8848489999144;845.8350621628784;861.2033868671485;863.1454859688926;864.321507616518;629.7921685843706;631.3339426904614;632.0424556796457;632.7121159872293;633.3634697129402;12937.805932911015;12948.741025179537;12969.027322950722;12971.481140754453;12986.805197921944;12265.141440099196;12558.623241302776;12971.573126956027;13034.283114428703;13112.541061062913;9019.188273055457;9064.410813297114;9126.543672816333;9182.63269469227;9195.172434480863;3517.0855577549764;3534.0988048047584;3565.5186549815962;3567.108222944264;3568.411212150018;48137.51862481365;48392;48597.51402485965;48598.514014860106;48638.513614863754;9769.462679552693;9779.168770654574;9992.850107248398;10209.234307426972;10292.279540432099;17700.46898593044;17862.19620117098;17887;17892.46322610324;17959;7459.738909138263;7669.424793140425;7731.7680469586;7874.448788584744;7884.526928384315;4122.381642753551;4228.467018456431;4247.341662042389;4288.914439774841;4300.78496075195;3028.712272334125;3060.4491191585284;3063.831489268067;3066.23344163959;3073.0627158716807;617.5059952038351;627.802242293676;628.1739512540994;646.0470805561758;648.1120864415781;496.1169118968242;500.989980200394;535.2934126952385;555.1229058088211;577.2985822226016;7911.208879112043;8005.839883202303;8057.566827513248;8182.795430114175;8259.545724985184;480.8485327121945;500.7871654546803;558.2798190334423;586.9530437564985;605.1014243847883;3819.3698039823676;3860;3880.689544836406;3913.3542965410957;4011.6389524942897;54328.185077223876;54793.72603137039;54919.45080549143;55097;56029.43970560324;48276.758616206695;48978;49150.75424622854;49168.75415622899;49236.50763492391;43371.34942975858;44442.33336499955;44567.331490027675;44607.776961114985;44933.55066449359;7833.764987050397;7881.5665138417935;7916.485428447363;8029.317508011651;8107.351411887153;33017.33965320632;33787;34193.829030854686;35925;36818.63181368152;41322.58677413187;41748.58251417447;42881.35677964771;43043;43481.78259108684;11149.888501114885;11166.385848778395;11459.828102578635;11479.25384849982;11739.530418783153;11437.428128593703;11574.826377604511;11577.826332605186;11744.647660570197;12615.243085414904;11158.888411115784;11439.942800285946;11507.597234096766;11521.078313734713;11547.364894930859;11611.419429028683;11977.281363118242;12016.098792590416;12128;12395.876041239471;8242.041249161259;10645.627403040857;11238;11976.520939162685;12011.879881201427;9910.454924978907;9996.200303975518;10012.949935250277;10017.649382271586;10096.94951525267;9468.810623787347;9470.621175153192;9474.905250947402;9569.473678947446;9596.280278978966 23:06:02 INFO - PROCESS | 3463 | __end_tp_report 23:06:02 INFO - PROCESS | 3463 | __start_cc_report 23:06:02 INFO - PROCESS | 3463 | _x_x_mozilla_cycle_collect,948 23:06:02 INFO - PROCESS | 3463 | __end_cc_report 23:06:02 INFO - PROCESS | 3463 | __startTimestamp1455087962066__endTimestamp 23:06:02 INFO - PROCESS | 3463 | 23:06:02 INFO - PROCESS | 3463 | ------- Summary: start ------- 23:06:02 INFO - PROCESS | 3463 | Number of tests: 6 23:06:02 INFO - PROCESS | 3463 | 23:06:02 INFO - PROCESS | 3463 | [#0] dojo.html Cycles:165 Average:5222.81 Median:5442.43 stddev:567.23 (10.4%) stddev-sans-first:545.42 23:06:02 INFO - PROCESS | 3463 | Values: 3160.7 3181.2 3205.6 3222.4 3255.8 5085.7 5155.5 5188.5 5196.1 5226.2 5251.4 5260.9 5262.7 5269.4 5288.9 4740.4 4760.0 4783.7 4826.9 4956.2 4761.2 4868.3 4873.4 4901.5 4946.3 4755.1 4755.3 4766.4 4808.2 4854.8 4676.9 4687.6 4714.7 4715.4 4759.9 4698.6 4711.2 4745.4 4783.9 4784.2 4992.6 5056.0 5111.1 5177.9 5216.4 5654.9 5669.8 5670.7 5670.9 5671.3 5554.2 5681.2 5697.7 5699.0 5707.8 5202.0 5209.5 5209.7 5227.4 5356.0 5699.4 5717.9 5722.7 5726.9 5775.2 5482.0 5491.6 5501.1 5502.3 5517.8 5507.8 5566.9 5583.1 5610.1 5670.5 5562.4 5569.7 5573.4 5589.8 5619.5 5573.0 5573.2 5581.6 5588.8 5590.6 4255.9 4341.9 4358.9 4404.0 4433.4 3884.1 3886.7 3888.2 3889.5 3945.4 5263.6 5270.4 5271.4 5280.9 5282.8 5522.4 5616.7 5621.9 5634.4 5715.5 5317.9 5325.8 5326.0 5336.9 5362.2 4816.1 4822.4 4830.9 4834.4 4876.5 5644.7 5747.3 5859.2 5905.2 5906.9 5598.4 5640.9 5656.3 5676.5 5722.5 5817.0 5841.1 5860.1 5869.7 5871.5 5443.7 5517.1 5559.7 5571.2 5592.9 5544.1 5565.7 5574.7 5625.4 5683.2 5446.8 5449.6 5460.0 5464.4 5473.2 5424.3 5456.4 5502.0 5508.8 5515.6 5338.5 5401.2 5442.4 5444.3 5447.4 5531.8 5547.5 5564.7 5572.4 5576.2 5351.0 5428.7 5436.7 5440.1 5447.6 23:06:02 INFO - PROCESS | 3463 | 23:06:02 INFO - PROCESS | 3463 | [#1] ext.html Cycles:180 Average:43772.73 Median:35378.47 stddev:71829.53 (203.0%) stddev-sans-first:71957.57 23:06:02 INFO - PROCESS | 3463 | Values: 506.5 539.9 556.4 570.6 589.4 35611.0 36451.3 36474.8 36492.5 36501.3 38618.8 39150.0 39208.4 39256.2 39336.4 8542.6 8745.1 8746.5 8747.0 8748.2 8535.2 8663.2 8664.9 8821.1 8883.4 8892.0 8985.6 8991.7 8995.8 8995.9 8828.6 8893.6 8896.2 8901.9 8913.6 8760.8 8869.9 8890.2 8898.7 8899.4 39180.6 39581.6 39624.6 39633.4 39647.8 2107.8 3229.4 3303.7 3362.0 3382.7 26274.2 26979.2 27055.5 27197.6 27686.0 3645.4 3724.5 3741.5 3874.3 3905.3 166328.0 166436.2 166705.2 167276.0 167314.0 51809.0 56149.4 56484.7 56527.7 59770.4 54049.7 54307.5 54443.5 54507.7 54521.5 15839.4 16046.3 16052.3 16072.0 16073.6 12368.3 12427.6 12457.5 12459.8 12477.3 19040.6 19982.7 19988.9 20079.6 20107.7 7436.3 7553.0 7570.0 7670.5 7714.3 945.1 1095.8 1102.1 1136.6 1141.0 30032.8 30173.0 31906.4 32289.8 32739.3 1008.6 1052.2 1057.4 1059.6 1082.8 15322.8 15465.0 15555.5 15727.9 16182.8 340077.0 352221.0 352435.0 352797.0 352842.0 53835.0 53883.5 53939.7 54381.5 54417.5 1332.0 1339.7 1365.8 1369.0 1370.6 23622.5 28929.9 31722.8 34387.3 35129.0 49629.5 50577.7 50579.7 50586.0 50713.0 252396.0 275888.0 278384.0 279062.0 279632.0 31364.7 31503.0 31602.8 31833.8 31847.7 40762.6 41302.6 41324.4 41656.8 42285.8 33409.8 35368.1 35521.6 35561.0 36100.6 34598.7 34962.5 35257.1 35388.8 35664.0 33439.7 33764.3 40471.0 41264.6 41307.8 30074.7 33329.8 33770.0 33814.0 34035.7 25080.6 25369.5 25654.1 25661.5 26056.3 23:06:02 INFO - PROCESS | 3463 | 23:06:02 INFO - PROCESS | 3463 | [#2] jquery.html Cycles:180 Average:25559.44 Median:18038.04 stddev:80315.88 (445.3%) stddev-sans-first:80518.87 23:06:02 INFO - PROCESS | 3463 | Values: 344.4 351.6 355.5 358.5 359.8 13670.4 14137.7 16323.2 16886.7 18286.1 15633.5 15886.0 17006.9 17057.5 17061.1 4784.5 4995.9 4996.2 4997.7 5000.7 3694.9 3755.4 3890.4 5379.1 5572.5 5543.2 5577.6 5589.7 5593.2 5877.3 5963.9 5999.7 6146.7 6151.2 6155.3 5040.5 5309.7 5314.9 5319.1 5342.1 19602.2 19661.4 20082.5 20332.1 20344.5 2156.1 2228.2 2284.4 2366.1 2777.6 9622.4 11969.0 12746.9 12875.0 13464.7 1865.3 1879.9 1896.9 1919.8 1936.8 57468.4 57597.7 57666.4 57807.4 57924.0 10057.5 10067.0 10083.4 10088.5 10176.6 13183.3 13348.0 13380.2 13381.2 13400.3 7637.7 7759.1 7820.5 7900.8 7903.0 7642.6 7658.3 7718.9 7736.5 7766.9 4074.4 4141.1 4211.6 4447.5 4535.5 1800.5 1815.9 1827.0 1859.7 1870.6 948.2 966.0 1010.4 1016.5 1034.2 16087.5 16789.8 16976.7 17042.6 17111.9 940.5 942.7 966.2 1033.8 1039.8 9603.0 9697.4 10220.6 10238.2 10589.4 340359.0 388315.0 553796.0 562035.0 568506.0 43823.1 44444.0 46021.8 53175.0 71339.6 1124.4 1157.3 1163.7 1176.6 1184.0 12544.2 14899.6 15103.1 15137.1 15287.2 24986.0 33298.5 33544.3 33798.0 34655.5 41528.0 42499.4 43491.1 44969.3 45013.5 7322.4 7495.3 7534.6 7593.8 7604.4 3925.4 11344.0 11609.8 11788.1 11929.4 10353.2 10515.6 10618.6 10693.9 10841.2 10471.9 10474.0 10499.0 10647.3 10733.2 10174.0 10231.6 10464.4 10837.7 11020.6 7489.2 7559.9 7648.1 7688.7 7699.9 9540.3 10257.7 10573.3 10607.8 10799.9 23:06:02 INFO - PROCESS | 3463 | 23:06:02 INFO - PROCESS | 3463 | [#3] mootools.html Cycles:180 Average:5504.68 Median:6585.40 stddev:2888.73 (43.9%) stddev-sans-first:2879.85 23:06:02 INFO - PROCESS | 3463 | Values: 1338.0 1449.0 1457.5 1632.3 1810.7 6826.0 7408.3 7618.8 7628.8 7632.8 7308.2 7542.7 7543.0 7554.2 7641.0 1975.3 2025.4 2223.3 2225.6 2255.9 2287.6 2291.7 2295.3 2306.6 2307.0 2214.6 2285.4 2285.5 2287.4 2289.3 2238.4 2250.6 2302.3 2319.6 2325.8 2255.6 2259.9 2266.6 2272.0 2315.5 7953.5 7992.8 8009.5 8014.4 8016.4 4717.8 4830.6 4837.7 4837.7 4841.4 3080.4 3083.1 3101.6 3120.7 3156.6 964.9 970.5 989.9 1006.6 1011.2 11083.5 11090.4 11111.0 11112.3 11123.9 4246.7 4249.4 4351.8 4367.1 4376.9 9493.6 9496.6 9501.2 9506.3 9523.8 4805.8 4814.3 4816.8 4825.1 4825.8 4415.2 4420.6 4422.0 4423.1 4426.8 3435.1 3539.7 3651.7 3693.8 3700.8 1173.3 1176.4 1207.0 1218.5 1236.2 1043.4 1062.8 1064.5 1201.6 1333.3 7019.4 7097.5 7132.9 7138.6 7144.4 1084.5 1103.4 1104.2 1137.3 1152.4 5566.2 5660.9 5662.5 5666.1 5666.8 9566.9 9595.5 9878.5 9986.7 9988.0 9575.3 9681.7 9684.7 9761.1 9837.4 7167.7 7300.9 7332.5 7355.7 7420.3 7059.9 7094.4 7177.4 7233.0 7238.5 8251.3 8569.0 8839.9 8844.8 8900.8 8496.2 8582.1 8682.2 8716.4 8734.9 6901.9 6937.2 6990.4 6992.9 7006.5 6625.5 7128.2 7275.1 7322.9 7344.1 6811.9 6898.2 6962.3 6997.8 7021.8 6947.4 6963.9 6968.5 6987.5 6988.1 7008.5 7033.5 7043.7 7060.4 7069.5 6375.9 6512.7 6574.4 6584.8 6586.0 6607.4 6631.7 6637.3 6644.9 6650.7 23:06:02 INFO - PROCESS | 3463 | 23:06:02 INFO - PROCESS | 3463 | [#4] prototype.html Cycles:180 Average:5271.09 Median:5927.80 stddev:1576.01 (26.6%) stddev-sans-first:1536.26 23:06:02 INFO - PROCESS | 3463 | Values: 334.6 341.6 343.5 348.3 351.1 5686.9 5873.2 5879.6 5938.6 5950.6 5729.7 5771.0 5796.2 5800.1 5809.8 4534.7 4546.6 4581.2 4587.8 4589.5 4336.3 4402.7 4545.4 4550.3 4588.4 4524.8 4524.8 4530.8 4539.7 4543.7 4543.9 4545.9 4547.2 4550.1 4561.7 4027.9 4030.6 4032.1 4032.7 4035.3 5460.3 5602.9 5623.7 5647.4 5654.9 5313.7 5315.3 5321.9 5324.3 5333.9 5941.2 6306.5 6309.1 6310.6 6322.1 4379.1 4496.3 4528.2 4534.8 4535.2 6478.0 6535.2 6606.6 6612.4 6618.3 4494.1 4496.4 4500.6 4506.9 4507.8 4476.3 4553.3 4566.7 4629.0 4637.7 5309.8 5314.9 5315.1 5317.2 5324.2 6268.0 6312.7 6319.9 6319.9 6324.7 1600.3 1606.3 1608.0 1608.5 1609.8 1122.2 1131.6 1135.3 1145.9 1168.2 5927.2 5928.3 5933.1 5936.6 5942.0 6407.0 6432.4 6466.8 6469.6 6470.5 5923.6 5927.3 5930.2 5941.9 5944.1 3363.1 3485.0 3495.8 3510.9 3517.3 6781.0 6786.9 6794.6 6798.5 6801.3 6687.8 6715.0 6729.0 6734.7 6735.9 6549.5 6764.2 6772.0 6776.3 6778.7 6233.0 6370.6 6505.5 6515.4 6516.8 6271.8 6301.9 6318.8 6320.5 6342.4 6749.2 6759.4 6760.5 6839.1 6841.8 4352.0 4384.8 4445.6 4450.0 4453.6 6513.9 6517.0 6522.7 6525.0 6526.2 6327.4 6341.3 6345.3 6352.2 6356.4 6161.3 6318.4 6339.7 6341.9 6345.9 6225.5 6227.1 6227.3 6233.0 6235.8 6367.9 6370.7 6370.9 6384.8 6386.1 6055.3 6202.5 6214.7 6215.6 6220.7 23:06:02 INFO - PROCESS | 3463 | 23:06:02 INFO - PROCESS | 3463 | [#5] yui.html Cycles:180 Average:13513.90 Median:48207.14 stddev:15421.07 (32.0%) stddev-sans-first:15434.08 23:06:02 INFO - PROCESS | 3463 | Values: 651.8 714.5 718.9 727.4 730.6 12416.8 12492.1 12676.2 13359.9 13844.4 14686.7 14880.5 14923.8 14926.8 14935.3 684.3 691.2 809.5 817.1 826.2 821.1 827.1 833.1 833.1 833.4 860.6 860.9 863.0 863.1 865.2 697.9 845.8 861.2 863.1 864.3 629.8 631.3 632.0 632.7 633.4 12937.8 12948.7 12969.0 12971.5 12986.8 12265.1 12558.6 12971.6 13034.3 13112.5 9019.2 9064.4 9126.5 9182.6 9195.2 3517.1 3534.1 3565.5 3567.1 3568.4 48137.5 48392.0 48597.5 48598.5 48638.5 9769.5 9779.2 9992.9 10209.2 10292.3 17700.5 17862.2 17887.0 17892.5 17959.0 7459.7 7669.4 7731.8 7874.4 7884.5 4122.4 4228.5 4247.3 4288.9 4300.8 3028.7 3060.4 3063.8 3066.2 3073.1 617.5 627.8 628.2 646.0 648.1 496.1 501.0 535.3 555.1 577.3 7911.2 8005.8 8057.6 8182.8 8259.5 480.8 500.8 558.3 587.0 605.1 3819.4 3860.0 3880.7 3913.4 4011.6 54328.2 54793.7 54919.5 55097.0 56029.4 48276.8 48978.0 49150.8 49168.8 49236.5 43371.3 44442.3 44567.3 44607.8 44933.6 7833.8 7881.6 7916.5 8029.3 8107.4 33017.3 33787.0 34193.8 35925.0 36818.6 41322.6 41748.6 42881.4 43043.0 43481.8 11149.9 11166.4 11459.8 11479.3 11739.5 11437.4 11574.8 11577.8 11744.6 12615.2 11158.9 11439.9 11507.6 11521.1 11547.4 11611.4 11977.3 12016.1 12128.0 12395.9 8242.0 10645.6 11238.0 11976.5 12011.9 9910.5 9996.2 10012.9 10017.6 10096.9 9468.8 9470.6 9474.9 9569.5 9596.3 23:06:02 INFO - PROCESS | 3463 | -------- Summary: end -------- 23:06:02 INFO - PROCESS | 3463 | 23:06:02 INFO - TEST-INFO | 3463: exit 0 23:06:02 INFO - TEST-OK | dromaeo_css | took 1116403ms 23:06:02 INFO - TEST-START | kraken 23:06:02 INFO - operating with platform_type : linux_ 23:06:02 INFO - Initialising browser for kraken test... 23:06:02 INFO - TEST-INFO | started process 3643 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2hGe6h/profile http://localhost:51746/getInfo.html) 23:06:07 INFO - PROCESS | 3643 | __metrics Screen width/height:1600/1200 23:06:07 INFO - PROCESS | 3643 | colorDepth:24 23:06:07 INFO - PROCESS | 3643 | Browser inner width/height: 1024/697 23:06:07 INFO - PROCESS | 3643 | __metrics 23:06:07 INFO - PROCESS | 3643 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:06:08 INFO - TEST-INFO | 3643: exit 0 23:06:08 INFO - Browser initialized. 23:06:08 INFO - Running cycle 1/1 for kraken test... 23:06:08 INFO - TEST-INFO | started process 3727 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2hGe6h/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:06:20 INFO - PROCESS | 3727 | RSS: Main: 152596480 23:06:20 INFO - PROCESS | 3727 | 23:06:23 INFO - PROCESS | 3727 | Cycle 1(1): loaded http://localhost:51746/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51746/tests/kraken/driver.html?testName=audio-beat-detection) 23:06:23 INFO - PROCESS | 3727 | RSS: Main: 192147456 23:06:23 INFO - PROCESS | 3727 | 23:06:26 INFO - PROCESS | 3727 | Cycle 1(1): loaded http://localhost:51746/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51746/tests/kraken/driver.html?testName=audio-dft) 23:06:26 INFO - PROCESS | 3727 | RSS: Main: 180834304 23:06:26 INFO - PROCESS | 3727 | 23:06:29 INFO - PROCESS | 3727 | Cycle 1(1): loaded http://localhost:51746/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51746/tests/kraken/driver.html?testName=audio-fft) 23:06:30 INFO - PROCESS | 3727 | RSS: Main: 167936000 23:06:30 INFO - PROCESS | 3727 | 23:06:32 INFO - PROCESS | 3727 | Cycle 1(1): loaded http://localhost:51746/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51746/tests/kraken/driver.html?testName=audio-oscillator) 23:06:33 INFO - PROCESS | 3727 | RSS: Main: 168124416 23:06:33 INFO - PROCESS | 3727 | 23:06:35 INFO - PROCESS | 3727 | Cycle 1(1): loaded http://localhost:51746/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51746/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:06:35 INFO - PROCESS | 3727 | RSS: Main: 169861120 23:06:35 INFO - PROCESS | 3727 | 23:06:38 INFO - PROCESS | 3727 | Cycle 1(1): loaded http://localhost:51746/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51746/tests/kraken/driver.html?testName=imaging-darkroom) 23:06:39 INFO - PROCESS | 3727 | RSS: Main: 169209856 23:06:39 INFO - PROCESS | 3727 | 23:06:42 INFO - PROCESS | 3727 | Cycle 1(1): loaded http://localhost:51746/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51746/tests/kraken/driver.html?testName=imaging-desaturate) 23:06:43 INFO - PROCESS | 3727 | RSS: Main: 171888640 23:06:43 INFO - PROCESS | 3727 | 23:06:46 INFO - PROCESS | 3727 | Cycle 1(1): loaded http://localhost:51746/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51746/tests/kraken/driver.html?testName=json-parse-financial) 23:06:46 INFO - PROCESS | 3727 | RSS: Main: 171048960 23:06:46 INFO - PROCESS | 3727 | 23:06:48 INFO - PROCESS | 3727 | Cycle 1(1): loaded http://localhost:51746/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51746/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:06:48 INFO - PROCESS | 3727 | RSS: Main: 181714944 23:06:48 INFO - PROCESS | 3727 | 23:06:50 INFO - PROCESS | 3727 | Cycle 1(1): loaded http://localhost:51746/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51746/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:06:51 INFO - PROCESS | 3727 | RSS: Main: 178745344 23:06:51 INFO - PROCESS | 3727 | 23:06:53 INFO - PROCESS | 3727 | Cycle 1(1): loaded http://localhost:51746/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51746/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:06:53 INFO - PROCESS | 3727 | RSS: Main: 187641856 23:06:53 INFO - PROCESS | 3727 | 23:06:56 INFO - PROCESS | 3727 | Cycle 1(1): loaded http://localhost:51746/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51746/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:06:57 INFO - PROCESS | 3727 | RSS: Main: 194510848 23:06:58 INFO - PROCESS | 3727 | 23:06:59 INFO - PROCESS | 3727 | Cycle 1(1): loaded http://localhost:51746/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51746/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:07:00 INFO - PROCESS | 3727 | RSS: Main: 193372160 23:07:00 INFO - PROCESS | 3727 | 23:07:01 INFO - PROCESS | 3727 | Cycle 1(1): loaded http://localhost:51746/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51746/tests/kraken/driver.html?testName=ai-astar) 23:07:02 INFO - PROCESS | 3727 | RSS: Main: 254754816 23:07:02 INFO - PROCESS | 3727 | 23:07:02 INFO - PROCESS | 3727 | __start_tp_report 23:07:02 INFO - PROCESS | 3727 | _x_x_mozilla_page_load 23:07:02 INFO - PROCESS | 3727 | _x_x_mozilla_page_load_details 23:07:02 INFO - PROCESS | 3727 | |i|pagename|runs| 23:07:02 INFO - PROCESS | 3727 | |0;ai-astar;109;114;108;112;112;111;107;111;110;111 23:07:02 INFO - PROCESS | 3727 | |1;audio-beat-detection;153;127;158;168;129;159;155;130;168;127 23:07:02 INFO - PROCESS | 3727 | |2;audio-dft;162;161;161;161;162;161;158;160;161;161 23:07:02 INFO - PROCESS | 3727 | |3;audio-fft;75;73;101;95;76;73;73;111;92;74 23:07:02 INFO - PROCESS | 3727 | |4;audio-oscillator;96;96;155;96;95;95;140;95;96;146 23:07:02 INFO - PROCESS | 3727 | |5;imaging-gaussian-blur;120;115;114;114;115;115;115;115;114;116 23:07:02 INFO - PROCESS | 3727 | |6;imaging-darkroom;145;145;146;145;145;147;145;146;145;146 23:07:02 INFO - PROCESS | 3727 | |7;imaging-desaturate;96;96;96;96;96;96;96;97;96;96 23:07:02 INFO - PROCESS | 3727 | |8;json-parse-financial;55;56;57;55;55;56;55;66;53;54 23:07:02 INFO - PROCESS | 3727 | |9;json-stringify-tinderbox;67;67;67;67;67;67;67;68;68;67 23:07:02 INFO - PROCESS | 3727 | |10;stanford-crypto-aes;84;88;86;86;84;87;85;85;86;85 23:07:02 INFO - PROCESS | 3727 | |11;stanford-crypto-ccm;118;124;117;123;115;121;115;114;115;116 23:07:02 INFO - PROCESS | 3727 | |12;stanford-crypto-pbkdf2;155;142;154;151;155;143;165;152;151;152 23:07:02 INFO - PROCESS | 3727 | |13;stanford-crypto-sha256-iterative;70;69;69;72;70;69;69;69;67;68 23:07:02 INFO - PROCESS | 3727 | __end_tp_report 23:07:02 INFO - PROCESS | 3727 | __start_cc_report 23:07:02 INFO - PROCESS | 3727 | _x_x_mozilla_cycle_collect,1021 23:07:02 INFO - PROCESS | 3727 | __end_cc_report 23:07:02 INFO - PROCESS | 3727 | __startTimestamp1455088022073__endTimestamp 23:07:02 INFO - PROCESS | 3727 | 23:07:02 INFO - PROCESS | 3727 | ------- Summary: start ------- 23:07:02 INFO - PROCESS | 3727 | Number of tests: 14 23:07:02 INFO - PROCESS | 3727 | 23:07:02 INFO - PROCESS | 3727 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:2.07 (1.9%) stddev-sans-first:2.12 23:07:02 INFO - PROCESS | 3727 | Values: 109.0 114.0 108.0 112.0 112.0 111.0 107.0 111.0 110.0 111.0 23:07:02 INFO - PROCESS | 3727 | 23:07:02 INFO - PROCESS | 3727 | [#1] audio-beat-detection Cycles:10 Average:147.40 Median:156.50 stddev:17.19 (11.0%) stddev-sans-first:18.11 23:07:02 INFO - PROCESS | 3727 | Values: 153.0 127.0 158.0 168.0 129.0 159.0 155.0 130.0 168.0 127.0 23:07:02 INFO - PROCESS | 3727 | 23:07:02 INFO - PROCESS | 3727 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.14 (0.7%) stddev-sans-first:1.12 23:07:02 INFO - PROCESS | 3727 | Values: 162.0 161.0 161.0 161.0 162.0 161.0 158.0 160.0 161.0 161.0 23:07:02 INFO - PROCESS | 3727 | 23:07:02 INFO - PROCESS | 3727 | [#3] audio-fft Cycles:10 Average:84.30 Median:74.50 stddev:14.18 (19.0%) stddev-sans-first:14.64 23:07:02 INFO - PROCESS | 3727 | Values: 75.0 73.0 101.0 95.0 76.0 73.0 73.0 111.0 92.0 74.0 23:07:02 INFO - PROCESS | 3727 | 23:07:02 INFO - PROCESS | 3727 | [#4] audio-oscillator Cycles:10 Average:111.00 Median:95.50 stddev:25.10 (26.3%) stddev-sans-first:26.03 23:07:02 INFO - PROCESS | 3727 | Values: 96.0 96.0 155.0 96.0 95.0 95.0 140.0 95.0 96.0 146.0 23:07:02 INFO - PROCESS | 3727 | 23:07:02 INFO - PROCESS | 3727 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:115.00 stddev:1.77 (1.5%) stddev-sans-first:0.67 23:07:02 INFO - PROCESS | 3727 | Values: 120.0 115.0 114.0 114.0 115.0 115.0 115.0 115.0 114.0 116.0 23:07:02 INFO - PROCESS | 3727 | 23:07:02 INFO - PROCESS | 3727 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 23:07:02 INFO - PROCESS | 3727 | Values: 145.0 145.0 146.0 145.0 145.0 147.0 145.0 146.0 145.0 146.0 23:07:02 INFO - PROCESS | 3727 | 23:07:02 INFO - PROCESS | 3727 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 23:07:02 INFO - PROCESS | 3727 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 23:07:02 INFO - PROCESS | 3727 | 23:07:02 INFO - PROCESS | 3727 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:55.50 stddev:3.61 (6.5%) stddev-sans-first:3.81 23:07:02 INFO - PROCESS | 3727 | Values: 55.0 56.0 57.0 55.0 55.0 56.0 55.0 66.0 53.0 54.0 23:07:02 INFO - PROCESS | 3727 | 23:07:02 INFO - PROCESS | 3727 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 23:07:02 INFO - PROCESS | 3727 | Values: 67.0 67.0 67.0 67.0 67.0 67.0 67.0 68.0 68.0 67.0 23:07:02 INFO - PROCESS | 3727 | 23:07:02 INFO - PROCESS | 3727 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:86.00 stddev:1.26 (1.5%) stddev-sans-first:1.20 23:07:02 INFO - PROCESS | 3727 | Values: 84.0 88.0 86.0 86.0 84.0 87.0 85.0 85.0 86.0 85.0 23:07:02 INFO - PROCESS | 3727 | 23:07:02 INFO - PROCESS | 3727 | [#11] stanford-crypto-ccm Cycles:10 Average:117.80 Median:117.50 stddev:3.61 (3.1%) stddev-sans-first:3.83 23:07:02 INFO - PROCESS | 3727 | Values: 118.0 124.0 117.0 123.0 115.0 121.0 115.0 114.0 115.0 116.0 23:07:02 INFO - PROCESS | 3727 | 23:07:02 INFO - PROCESS | 3727 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.00 Median:153.00 stddev:6.45 (4.2%) stddev-sans-first:6.75 23:07:02 INFO - PROCESS | 3727 | Values: 155.0 142.0 154.0 151.0 155.0 143.0 165.0 152.0 151.0 152.0 23:07:02 INFO - PROCESS | 3727 | 23:07:02 INFO - PROCESS | 3727 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.00 stddev:1.32 (1.9%) stddev-sans-first:1.36 23:07:02 INFO - PROCESS | 3727 | Values: 70.0 69.0 69.0 72.0 70.0 69.0 69.0 69.0 67.0 68.0 23:07:02 INFO - PROCESS | 3727 | -------- Summary: end -------- 23:07:02 INFO - PROCESS | 3727 | 23:07:06 INFO - TEST-INFO | 3727: exit 0 23:07:06 INFO - TEST-OK | kraken | took 63616ms 23:07:06 INFO - SUITE-END | took 1180s 23:07:06 INFO - Completed test suite (00:19:40) 23:07:06 INFO - Working with test: dromaeo_css 23:07:06 INFO - Generating results file: dromaeo_css 23:07:06 INFO - Working with test: kraken 23:07:06 INFO - Generating results file: kraken 23:07:06 INFO - javascript benchmark 23:07:06 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:07:06 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 23:07:06 INFO - process_Request line: dromaeo_css 6854.71 graph.html#tests=[[72,64,35]] 23:07:06 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:07:06 INFO - process_Request line: kraken 1518.90 graph.html#tests=[[232,64,35]] 23:07:06 INFO - RETURN: dromaeo_css: 6854.71 23:07:06 INFO - RETURN: kraken: 1518.90 23:07:06 INFO - javascript benchmark 23:07:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3160.715535601796, 3181.17289504729, 3205.5512228288044, 3222.4038552867723, 3255.8209298488587, 5085.694858308504, 5155.4586768389345, 5188.533032027117, 5196.0647083525, 5226.24219488174, 5251.396089449714, 5260.894782104356, 5262.736863156846, 5269.420363759983, 5288.92066619001, 4740.36005139307, 4759.976200119003, 4783.736894470802, 4826.927596086061, 4956.157453232941, 4761.190597598416, 4868.318435419026, 4873.366462359888, 4901.509849015088, 4946.282788995593, 4755.120302744003, 4755.286706993944, 4766.428028636568, 4808.158572249842, 4854.757262136896, 4676.929846052312, 4687.601553867926, 4714.740689262124, 4715.43414790224, 4759.928601070987, 4698.647601429906, 4711.199096153628, 4745.383100196987, 4783.904321913542, 4784.186688263004, 4992.575631071363, 5056.0, 5111.105556527593, 5177.896442071175, 5216.426193118754, 5654.943450565524, 5669.801556945528, 5670.716464176775, 5670.943290567083, 5671.319441666985, 5554.166874968747, 5681.204631351614, 5697.6866272355, 5699.0, 5707.828765137053, 5202.0116177926075, 5209.505097015777, 5209.661372010807, 5227.372715274191, 5356.0, 5699.430056994267, 5717.914876303662, 5722.656640601577, 5726.942730572724, 5775.249217601769, 5482.013237617188, 5491.560675146058, 5501.092319767274, 5502.257195278667, 5517.751701173457, 5507.834764957058, 5566.888662226814, 5583.0787919992745, 5610.13042978339, 5670.461306175906, 5562.360328562268, 5569.693666848281, 5573.442655734475, 5589.80435684749, 5619.494245517923, 5572.972135139298, 5573.247611572467, 5581.553475721932, 5588.804391846347, 5590.580706446952, 4255.893602659897, 4341.9131617367475, 4358.934615980763, 4403.9779801100785, 4433.379326894237, 3884.1454879926373, 3886.6502014818802, 3888.1640447303967, 3889.5138107736534, 3945.388464787905, 5263.605229607795, 5270.393904701008, 5271.393789714232, 5280.9207861882105, 5282.81510147143, 5522.447755224445, 5616.663000219918, 5621.915671264935, 5634.4365563443325, 5715.48560629537, 5317.893642127213, 5325.760340784674, 5326.0, 5336.91994620081, 5362.195670649356, 4816.133096042676, 4822.421309442819, 4830.9275360869615, 4834.444038935568, 4876.512348765095, 5644.689542075225, 5747.281589801275, 5859.2382990211, 5905.202797622352, 5906.8818623627285, 5598.384177740527, 5640.943590564206, 5656.264685591012, 5676.489115979582, 5722.456366645162, 5817.0, 5841.065429531254, 5860.062390017577, 5869.73586188614, 5871.4715675589405, 5443.673379597237, 5517.117261238182, 5559.6664200148125, 5571.192177134212, 5592.916106258328, 5544.140658197985, 5565.749541270571, 5574.665520068809, 5625.409332020243, 5683.175939488834, 5446.836594902159, 5449.64577302474, 5460.044492213926, 5464.415558543689, 5473.2063850742215, 5424.321959755031, 5456.427075157051, 5501.972490137524, 5508.807191748269, 5515.61390702647, 5338.492843179892, 5401.243825864461, 5442.428545002717, 5444.3194600674915, 5447.428020057837, 5531.834044978657, 5547.472990065938, 5564.721763911707, 5572.387037425961, 5576.163575463713, 5350.973245133905, 5428.70142142186, 5436.700981446058, 5440.075187218104, 5447.645903016291], "unit": "score", "name": "dojo.html", "value": 5187.083199084722}, {"lowerIsBetter": false, "replicates": [506.50109642002644, 539.8569379114538, 556.374079160944, 570.5948776368776, 589.3634874335718, 35611.0, 36451.27097458049, 36474.81762591183, 36492.45261321079, 36501.269974600524, 38618.80690596543, 39150.0, 39208.41187382192, 39256.21487570247, 39336.409953850714, 8542.572871356439, 8745.081766414498, 8746.475211487299, 8747.0, 8748.168923952215, 8535.231829135377, 8663.176998185163, 8664.913350866505, 8821.073787252342, 8883.378163528556, 8892.0, 8985.595648195847, 8991.730248092535, 8995.775105622346, 8995.865062024075, 8828.558572071403, 8893.555322233895, 8896.199342059246, 8901.866472002925, 8913.55432228386, 8760.824783504358, 8869.866951995726, 8890.244329232022, 8898.688545900863, 8899.421537600036, 39180.60819391798, 39581.60418395837, 39624.60375396238, 39633.40549891754, 39647.80176099101, 2107.8208352290076, 3229.3541291741512, 3303.702666760003, 3361.983190084034, 3382.695557399821, 26274.21177364682, 26979.190624281302, 27055.45889082227, 27197.592036119473, 27686.0, 3645.398509245971, 3724.4599533067826, 3741.5323084614424, 3874.2832575973534, 3905.2775236581324, 166327.99999999878, 166436.16781916012, 166705.16647416807, 167276.0, 167314.0, 51809.0, 56149.43850561524, 56484.71757641186, 56527.71736141293, 59770.402295976484, 54049.72975135099, 54307.45692543024, 54443.45556544463, 54507.72746136244, 54521.45478545243, 15839.445619403496, 16046.277917493508, 16052.27764750589, 16072.0, 16073.598160046093, 12368.257904525757, 12427.627171184879, 12457.501699931901, 12459.750804983849, 12477.251364917953, 19040.61918761617, 19982.70025949612, 19988.90005549963, 20079.598408031758, 20107.698384524243, 7436.256374362629, 7552.962235188898, 7569.962150189213, 7670.501417407851, 7714.3442807362, 945.1304799584399, 1095.8246680531236, 1102.1127991966384, 1136.596508239563, 1140.9731241882373, 30032.84983575068, 30173.0, 31906.361872762416, 32289.838550807097, 32739.345213095603, 1008.5763979128784, 1052.1582733813073, 1057.3655806516028, 1059.6079450603172, 1082.8213344798178, 15322.770158447633, 15465.0, 15555.45555905538, 15727.921360393353, 16182.75725864113, 340077.0, 352221.0, 352435.0, 352797.0, 352842.0, 53835.0, 53883.461165387846, 53939.730301349024, 54381.45618543764, 54417.45582544203, 1332.0, 1339.7052648417528, 1365.7746471832236, 1368.9931550342383, 1370.5751217122724, 23622.52754944926, 28929.855350723952, 31722.841385792923, 34387.312253755284, 35129.0, 49629.50370496249, 50577.74711126421, 50579.747101264256, 50586.0, 50713.0, 252396.0, 275888.0, 278384.0, 279062.0, 279632.0, 31364.686353136178, 31503.0, 31602.841985789924, 31833.840830795696, 31847.68152318447, 40762.59237407588, 41302.586974129874, 41324.38013429861, 41656.791716041225, 42285.788571056946, 33409.83295083509, 35368.11579710528, 35521.64478355287, 35561.0, 36100.638993609726, 34598.65401345954, 34962.47556286708, 35257.118572035906, 35388.82305588455, 35664.0, 33439.66560334463, 33764.32471350608, 40471.0, 41264.58735412607, 41307.7934610325, 30074.69925300719, 33329.83335083309, 33770.0, 33814.0, 34035.65964340325, 25080.60732503495, 25369.492610148063, 25654.102106426184, 25661.486770264863, 26056.34859128461], "unit": "score", "name": "ext.html", "value": 18251.091197977847}, {"lowerIsBetter": false, "replicates": [344.42652982783665, 351.6465951718523, 355.4561520873064, 358.53390592230113, 359.8308794866412, 13670.384832682528, 14137.717245655107, 16323.183840807957, 16886.72029276049, 18286.074228123503, 15633.452829150981, 15886.0, 17006.914965425185, 17057.488275351727, 17061.061641609736, 4784.497627749097, 4995.925061124086, 4996.150654388763, 4997.700137991714, 5000.67495612784, 3694.907627309312, 3755.4179102239195, 3890.396988466778, 5379.058664733676, 5572.4706152915405, 5543.168524721284, 5577.553795696354, 5589.7205139743055, 5593.188987596816, 5877.265341832271, 5963.9403605964035, 5999.730012149442, 6146.692665366714, 6151.200343955279, 6155.261368635747, 5040.521150490697, 5309.734513274359, 5314.893702125974, 5319.148936170232, 5342.091844386464, 19602.215911363528, 19661.410157695293, 20082.497937551532, 20332.08505617251, 20344.491387715276, 2156.148321413049, 2228.19784877444, 2284.3946354216146, 2366.1008816649737, 2777.5833624956217, 9622.37454565451, 11969.042476601851, 12746.872531274754, 12875.004993408704, 13464.730705385837, 1865.253898440621, 1879.8966056866866, 1896.924123035077, 1919.7984211657715, 1936.7579052618423, 57468.42531574715, 57597.7120114401, 57666.42333576652, 57807.42192578105, 57924.0, 10057.497125143713, 10067.0, 10083.445410502492, 10088.546015429176, 10176.643817466353, 13183.340832958314, 13348.0, 13380.19718816874, 13381.197128172145, 13400.262985535888, 7637.732679356196, 7759.068911730628, 7820.491668041559, 7900.841983160304, 7903.0, 7642.617869106522, 7658.2724641159, 7718.884216736754, 7736.497127686683, 7766.92233077662, 4074.4499492568716, 4141.130362623822, 4211.578842115825, 4447.533009034069, 4535.455745310518, 1800.5318617159633, 1815.9092045397676, 1827.0, 1859.739636450898, 1870.6165236126562, 948.1608776232946, 966.0050148347214, 1010.3887148275335, 1016.5082940100777, 1034.1881622925966, 16087.517374478784, 16789.832101679072, 16976.660466790596, 17042.573935651708, 17111.914440427718, 940.5250348574064, 942.6983365323168, 966.1594412860716, 1033.8242498775076, 1039.7660526381655, 9603.0, 9697.369670971506, 10220.642277520252, 10238.18094552434, 10589.417582032907, 340359.0, 388315.0, 553796.0, 562035.0, 568506.0, 43823.12353752971, 44444.0, 46021.76989115033, 53175.0, 71339.64330178316, 1124.4377811094453, 1157.2709193208393, 1163.7381589142544, 1176.5940750441084, 1183.9995204052561, 12544.24734515932, 14899.553013409615, 15103.093814371174, 15137.07918751001, 15287.159206243763, 24986.0, 33298.5005224917, 33544.32911341711, 33797.986060418225, 34655.48016779801, 41528.0, 42499.36250956176, 43491.130177395644, 44969.32546011747, 45013.549864500936, 7322.3775979042375, 7495.250474952461, 7534.623268836646, 7593.810154745955, 7604.42966777505, 3925.43081253211, 11344.0, 11609.83901609866, 11788.115891308014, 11929.403529823649, 10353.171746260432, 10515.631952881613, 10618.575256989634, 10693.88323812179, 10841.18691098155, 10471.895281047093, 10474.0, 10499.005189014062, 10647.254692171473, 10733.195010374096, 10174.01606686689, 10231.641892534024, 10464.424456654653, 10837.67486975392, 11020.614278500214, 7489.176190619137, 7559.924400756142, 7648.120466146464, 7688.654010569426, 7699.88450173259, 9540.33217674756, 10257.74355641115, 10573.312734672221, 10607.840882386925, 10799.892001079888], "unit": "score", "name": "jquery.html", "value": 8261.168462269437}, {"lowerIsBetter": false, "replicates": [1338.0366136381801, 1449.0436312034058, 1457.5044484875143, 1632.2573229180716, 1810.6921823290031, 6826.0, 7408.259174082596, 7618.7714368568895, 7628.771136865896, 7632.771016869503, 7308.196098429168, 7542.69829206831, 7542.962285188566, 7554.169041405441, 7641.0, 1975.338261682338, 2025.3721346382595, 2223.3330000999717, 2225.5771403433296, 2255.9210427635035, 2287.553926984239, 2291.7249930008425, 2295.265515035181, 2306.6078766609717, 2307.0195167054017, 2214.6124428225075, 2285.394370491821, 2285.5086156476355, 2287.3595393289906, 2289.267434420986, 2238.3844442778286, 2250.5723912456583, 2302.3438320078862, 2319.5592837360846, 2325.755795641467, 2255.57144142614, 2259.9209027684115, 2266.5693518231483, 2271.9772802272096, 2315.525317309964, 7953.5227886327, 7992.760217193435, 8009.51942883423, 8014.438989270753, 8016.35869130474, 4717.834875779366, 4830.613550915953, 4837.685550439211, 4837.7097374157665, 4841.370621819141, 3080.3993221321853, 3083.075077476748, 3101.61814880585, 3120.6723294054023, 3156.6369867465305, 964.8890377606594, 970.4565443351675, 989.945552994585, 1006.6074231049823, 1011.2466212671533, 11083.50124244411, 11090.445477726162, 11111.0, 11112.333260004425, 11123.944380278046, 4246.745195288231, 4249.426327445817, 4351.8476853309985, 4367.061081867414, 4376.868693939187, 9493.572789224501, 9496.572654230577, 9501.192398646193, 9506.287028472892, 9523.809523809485, 4805.807767689324, 4814.277858321209, 4816.8073277069225, 4825.10735513931, 4825.806967721252, 4415.249407600716, 4420.646348292129, 4422.027154026109, 4423.093265880487, 4426.822927082945, 3435.0725304167736, 3539.7168226541817, 3651.707863370924, 3693.7968411737074, 3700.796456194881, 1173.2901594535183, 1176.4176732517458, 1207.0464333176867, 1218.469965564982, 1236.2397125767768, 1043.3687618990552, 1062.792755412687, 1064.520965565483, 1201.5614300780153, 1333.3466601365456, 7019.3682568569075, 7097.503174777819, 7132.893006604905, 7138.571685698771, 7144.392726618192, 1084.4794498640697, 1103.3600511703194, 1104.2049724198564, 1137.294877176156, 1152.3777160333493, 5566.2207290979295, 5660.886782264414, 5662.490375866109, 5666.065099258576, 5666.829995100154, 9566.856497152548, 9595.520223988773, 9878.506074696237, 9986.700398988041, 9988.0, 9575.329726919048, 9681.709548713408, 9684.661036863676, 9761.121499064977, 9837.360571562825, 7167.677454514559, 7300.941363502262, 7332.486725929134, 7355.705771769176, 7420.332170104716, 7059.894101588377, 7094.396976257076, 7177.3899218567, 7232.963835180791, 7238.457115716447, 8251.2986396157, 8568.957155214184, 8839.911600884167, 8844.823103537765, 8900.821983560163, 8496.235338819535, 8582.0988796178, 8682.218600326001, 8716.38985271025, 8734.868976965477, 6901.89647155283, 6937.202221744362, 6990.405815505739, 6992.930070699228, 7006.544574602634, 6625.469962403093, 7128.180259270251, 7275.126984761862, 7322.853542929218, 7344.081989751281, 6811.863762724817, 6898.206706228848, 6962.268961759145, 6997.755078572225, 7021.824454388477, 6947.44420446353, 6963.860722785617, 6968.477364197807, 6987.5108742389575, 6988.126484189476, 7008.544444611084, 7033.542819716702, 7043.718251269892, 7060.364567188978, 7069.469789765685, 6375.936240637534, 6512.6743662815725, 6574.408303252731, 6584.8353791155605, 6585.967070164618, 6607.405333520006, 6631.701573429111, 6637.2699003108655, 6644.867102658017, 6650.73397064112], "unit": "score", "name": "mootools.html", "value": 4507.813794096486}, {"lowerIsBetter": false, "replicates": [334.64193313154937, 341.57473944938545, 343.48477284073897, 348.3120836348214, 351.07316683954366, 5686.943130568693, 5873.236479257701, 5879.559033072521, 5938.554608404365, 5950.642961422318, 5729.656220626765, 5771.047777116782, 5796.217510636063, 5800.100984347422, 5809.796657117002, 4534.732633683167, 4546.568076032771, 4581.1753884300815, 4587.816487340502, 4589.5410458954175, 4336.284513055342, 4402.713823601472, 4545.36364908913, 4550.340200670901, 4588.403507544014, 4524.751138687371, 4524.773761311922, 4530.841420550281, 4539.72761634303, 4543.704659197141, 4543.931841022388, 4545.886352841172, 4547.226971414867, 4550.112728018038, 4561.6806823522365, 4027.8993025174314, 4030.556638769733, 4032.0927791246736, 4032.74984754727, 4035.273650742865, 5460.26286451328, 5602.915956260659, 5623.718814059322, 5647.43525647436, 5654.9151762723595, 5313.681179129265, 5315.335583052119, 5321.946780532184, 5324.254604355355, 5333.946660533384, 5941.168236446901, 6306.527010474233, 6309.116723658692, 6310.558260921737, 6322.0516922462, 4379.080393117417, 4496.2805951048, 4528.230200865861, 4534.841280555164, 4535.229011068126, 6477.967610161919, 6535.15043044406, 6606.570572912745, 6612.43794277487, 6618.338166183391, 4494.07871386365, 4496.415465989466, 4500.594946454835, 4506.909861802746, 4507.81968721254, 4476.328550717419, 4553.271476563734, 4566.70316429431, 4628.97685511577, 4637.652176086807, 5309.840704778863, 5314.946850531445, 5315.113134837077, 5317.229001794795, 5324.1747529133045, 6267.968660156761, 6312.705895291454, 6319.905201421982, 6319.905201421982, 6324.747010119636, 1600.3198640577707, 1606.2771752711326, 1607.9919600401922, 1608.5254849819332, 1609.7826793382978, 1122.186414849244, 1131.5926266544038, 1135.3131355529952, 1145.931244125355, 1168.1881092640704, 5927.229460170151, 5928.318243402064, 5933.139694744238, 5936.614120082181, 5941.970290148522, 6407.0, 6432.356764323624, 6466.773662921775, 6469.5794773339585, 6470.4823614110755, 5923.585349025613, 5927.288725352985, 5930.169776231331, 5941.910871336933, 5944.078667806497, 3363.1423986883187, 3485.0, 3495.8252087395526, 3510.8946731598094, 3517.278957813642, 6781.0, 6786.898196527056, 6794.626295553693, 6798.490113241527, 6801.319868013159, 6687.799366019027, 6715.0, 6728.966355168192, 6734.696938637773, 6735.8989615155815, 6549.476041916635, 6764.222114456802, 6772.0, 6776.322367763283, 6778.661066946534, 6232.968835155976, 6370.58591191571, 6505.51208659343, 6515.381038801306, 6516.771912983023, 6271.811845644638, 6301.936980630135, 6318.810435686937, 6320.5259605528845, 6342.429181373698, 6749.156355455568, 6759.391654751096, 6760.459163267025, 6839.110915580943, 6841.760538381332, 4351.97824010878, 4384.846530371422, 4445.644348452181, 4449.955500444954, 4453.576910193527, 6513.869722605426, 6517.0, 6522.739090436329, 6525.0, 6526.216853977553, 6327.3988971047675, 6341.334159913143, 6345.302016778059, 6352.174217351715, 6356.364363563606, 6161.322254552086, 6318.4313411793155, 6339.651319177489, 6341.936580634319, 6345.904811427925, 6225.501959843292, 6227.0970709246, 6227.283862355705, 6232.968835155795, 6235.781747638811, 6367.936320636734, 6370.713317900798, 6370.936290637034, 6384.808455746335, 6386.105945167587, 6055.303640081447, 6202.511397264714, 6214.725981173758, 6215.564910456405, 6220.688965551795], "unit": "score", "name": "prototype.html", "value": 4766.9167170678775}, {"lowerIsBetter": false, "replicates": [651.791426743442, 714.4820005496013, 718.9317014883587, 727.428968259916, 730.6200775596689, 12416.81374779378, 12492.06309526787, 12676.239425634469, 13359.864411525032, 13844.446222151102, 14686.706265874676, 14880.47918322859, 14923.776143357858, 14926.776098358507, 14935.327910244037, 684.274668851017, 691.2258270736781, 809.522381794741, 817.0848649512525, 826.1696994520498, 821.0639870547581, 827.1108558299821, 833.0752864320599, 833.0960907415462, 833.4374297349295, 860.6213266162899, 860.9139086091373, 862.995685021574, 863.0592654007131, 865.1953683074738, 697.8848489999144, 845.8350621628784, 861.2033868671485, 863.1454859688926, 864.321507616518, 629.7921685843706, 631.3339426904614, 632.0424556796457, 632.7121159872293, 633.3634697129402, 12937.805932911015, 12948.741025179537, 12969.027322950722, 12971.481140754453, 12986.805197921944, 12265.141440099196, 12558.623241302776, 12971.573126956027, 13034.283114428703, 13112.541061062913, 9019.188273055457, 9064.410813297114, 9126.543672816333, 9182.63269469227, 9195.172434480863, 3517.0855577549764, 3534.0988048047584, 3565.5186549815962, 3567.108222944264, 3568.411212150018, 48137.51862481365, 48392.0, 48597.51402485965, 48598.514014860106, 48638.513614863754, 9769.462679552693, 9779.168770654574, 9992.850107248398, 10209.234307426972, 10292.279540432099, 17700.46898593044, 17862.19620117098, 17887.0, 17892.46322610324, 17959.0, 7459.738909138263, 7669.424793140425, 7731.7680469586, 7874.448788584744, 7884.526928384315, 4122.381642753551, 4228.467018456431, 4247.341662042389, 4288.914439774841, 4300.78496075195, 3028.712272334125, 3060.4491191585284, 3063.831489268067, 3066.23344163959, 3073.0627158716807, 617.5059952038351, 627.802242293676, 628.1739512540994, 646.0470805561758, 648.1120864415781, 496.1169118968242, 500.989980200394, 535.2934126952385, 555.1229058088211, 577.2985822226016, 7911.208879112043, 8005.839883202303, 8057.566827513248, 8182.795430114175, 8259.545724985184, 480.8485327121945, 500.7871654546803, 558.2798190334423, 586.9530437564985, 605.1014243847883, 3819.3698039823676, 3860.0, 3880.689544836406, 3913.3542965410957, 4011.6389524942897, 54328.185077223876, 54793.72603137039, 54919.45080549143, 55097.0, 56029.43970560324, 48276.758616206695, 48978.0, 49150.75424622854, 49168.75415622899, 49236.50763492391, 43371.34942975858, 44442.33336499955, 44567.331490027675, 44607.776961114985, 44933.55066449359, 7833.764987050397, 7881.5665138417935, 7916.485428447363, 8029.317508011651, 8107.351411887153, 33017.33965320632, 33787.0, 34193.829030854686, 35925.0, 36818.63181368152, 41322.58677413187, 41748.58251417447, 42881.35677964771, 43043.0, 43481.78259108684, 11149.888501114885, 11166.385848778395, 11459.828102578635, 11479.25384849982, 11739.530418783153, 11437.428128593703, 11574.826377604511, 11577.826332605186, 11744.647660570197, 12615.243085414904, 11158.888411115784, 11439.942800285946, 11507.597234096766, 11521.078313734713, 11547.364894930859, 11611.419429028683, 11977.281363118242, 12016.098792590416, 12128.0, 12395.876041239471, 8242.041249161259, 10645.627403040857, 11238.0, 11976.520939162685, 12011.879881201427, 9910.454924978907, 9996.200303975518, 10012.949935250277, 10017.649382271586, 10096.94951525267, 9468.810623787347, 9470.621175153192, 9474.905250947402, 9569.473678947446, 9596.280278978966], "unit": "score", "name": "yui.html", "value": 6172.179102392245}], "name": "dromaeo_css", "value": 6854.706884022794}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 114.0, 108.0, 112.0, 112.0, 111.0, 107.0, 111.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.5}, {"lowerIsBetter": true, "replicates": [153.0, 127.0, 158.0, 168.0, 129.0, 159.0, 155.0, 130.0, 168.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 147.4}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 161.0, 161.0, 162.0, 161.0, 158.0, 160.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 101.0, 95.0, 76.0, 73.0, 73.0, 111.0, 92.0, 74.0], "unit": "score", "name": "audio-fft", "value": 84.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 155.0, 96.0, 95.0, 95.0, 140.0, 95.0, 96.0, 146.0], "unit": "score", "name": "audio-oscillator", "value": 111.0}, {"lowerIsBetter": true, "replicates": [120.0, 115.0, 114.0, 114.0, 115.0, 115.0, 115.0, 115.0, 114.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.3}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 147.0, 145.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 57.0, 55.0, 55.0, 56.0, 55.0, 66.0, 53.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.2}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 68.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [84.0, 88.0, 86.0, 86.0, 84.0, 87.0, 85.0, 85.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.6}, {"lowerIsBetter": true, "replicates": [118.0, 124.0, 117.0, 123.0, 115.0, 121.0, 115.0, 114.0, 115.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.8}, {"lowerIsBetter": true, "replicates": [155.0, 142.0, 154.0, 151.0, 155.0, 143.0, 165.0, 152.0, 151.0, 152.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.0}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 69.0, 72.0, 70.0, 69.0, 69.0, 69.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.2}], "name": "kraken", "value": 1518.8999999999999}]} 23:07:06 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1518.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6854.71"}}} 23:07:06 INFO - Return code: 0 23:07:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:07:06 INFO - # TBPL SUCCESS # 23:07:06 INFO - Running post-action listener: _resource_record_post_action 23:07:06 INFO - Running post-run listener: _resource_record_post_run 23:07:08 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 10207232; Write bytes: 528109568; Read time: 3960; Write time: 900976 23:07:08 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 145649664; Read time: 528; Write time: 228184 23:07:08 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 10203136; Write bytes: 347922432; Read time: 3432; Write time: 550000 23:07:08 INFO - Running post-run listener: _upload_blobber_files 23:07:08 INFO - Blob upload gear active. 23:07:08 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:07:08 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:07:08 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:07:08 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:07:08 INFO - (blobuploader) - INFO - Open directory for files ... 23:07:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 23:07:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:07:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:07:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:07:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:07:09 INFO - (blobuploader) - INFO - Done attempting. 23:07:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:07:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:07:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:07:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:07:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:07:10 INFO - (blobuploader) - INFO - Done attempting. 23:07:10 INFO - (blobuploader) - INFO - Iteration through files over. 23:07:10 INFO - Return code: 0 23:07:10 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:07:10 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:07:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6111cf7dfa22431f72ded0f15ef1eddb18caeb6996df173a03e5c1b0fc3088fa90daeae96f0d2176b572ca6f20e903e571ffb520bc96dabbdd2be536dbd77a9d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a572ada30ae8fd50d5908dd20ecb1e05601af56eec727787c2b000ad2fbe86bcb360923c1d60c06ff90eb61d6f096cfca101c6bbe872c377f9f3ccc853684f6c"} 23:07:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:07:10 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:07:10 INFO - Contents: 23:07:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6111cf7dfa22431f72ded0f15ef1eddb18caeb6996df173a03e5c1b0fc3088fa90daeae96f0d2176b572ca6f20e903e571ffb520bc96dabbdd2be536dbd77a9d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a572ada30ae8fd50d5908dd20ecb1e05601af56eec727787c2b000ad2fbe86bcb360923c1d60c06ff90eb61d6f096cfca101c6bbe872c377f9f3ccc853684f6c"} 23:07:10 INFO - Running post-run listener: copy_logs_to_upload_dir 23:07:10 INFO - Copying logs to upload dir... 23:07:10 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 23:07:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.390842 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-02-09 23:07:10.179096) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-09 23:07:10.182812) ========= 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=df17445c3590ff7897617a0e00000225-1455077768.147086-1596626838 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/6111cf7dfa22431f72ded0f15ef1eddb18caeb6996df173a03e5c1b0fc3088fa90daeae96f0d2176b572ca6f20e903e571ffb520bc96dabbdd2be536dbd77a9d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a572ada30ae8fd50d5908dd20ecb1e05601af56eec727787c2b000ad2fbe86bcb360923c1d60c06ff90eb61d6f096cfca101c6bbe872c377f9f3ccc853684f6c"} build_url:https://queue.taskcluster.net/v1/task/POXjeZiRQQiDmeZXKPwxQg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011215 build_url: 'https://queue.taskcluster.net/v1/task/POXjeZiRQQiDmeZXKPwxQg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6111cf7dfa22431f72ded0f15ef1eddb18caeb6996df173a03e5c1b0fc3088fa90daeae96f0d2176b572ca6f20e903e571ffb520bc96dabbdd2be536dbd77a9d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a572ada30ae8fd50d5908dd20ecb1e05601af56eec727787c2b000ad2fbe86bcb360923c1d60c06ff90eb61d6f096cfca101c6bbe872c377f9f3ccc853684f6c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-09 23:07:10.208143) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 23:07:10.208510) ========= 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=df17445c3590ff7897617a0e00000225-1455077768.147086-1596626838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 23:07:10.289949) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-09 23:07:10.290258) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-09 23:07:10.290921) ========= ========= Total master_lag: 0.74 =========