builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-053 starttime: 1455823800.72 results: success (0) buildid: 20160218083504 builduid: 283f900c0cfb428b82471f41a130cd69 revision: 5ea830f5a8c358bffa34cc1934fedcaf09a870b9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-18 11:30:00.718904) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-18 11:30:00.719370) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-18 11:30:00.719684) ========= 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=920470bf432669ad7e3a5387000001ca-1455821219.133220-1870499538 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006347 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-18 11:30:00.743520) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-18 11:30:00.743846) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-18 11:30:00.757031) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 11:30:00.757365) ========= 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=920470bf432669ad7e3a5387000001ca-1455821219.133220-1870499538 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004597 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 11:30:00.808128) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-18 11:30:00.808413) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-18 11:30:00.808764) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 11:30:00.809048) ========= 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=920470bf432669ad7e3a5387000001ca-1455821219.133220-1870499538 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-18 11:30:01-- 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% 45.5K=0.3s 2016-02-18 11:30:01 (45.5 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.351984 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 11:30:01.173429) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 11:30:01.173759) ========= 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=920470bf432669ad7e3a5387000001ca-1455821219.133220-1870499538 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017845 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 11:30:01.223203) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 11:30:01.223608) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5ea830f5a8c358bffa34cc1934fedcaf09a870b9 --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 5ea830f5a8c358bffa34cc1934fedcaf09a870b9 --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=920470bf432669ad7e3a5387000001ca-1455821219.133220-1870499538 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-18 11:30:01,718 truncating revision to first 12 chars 2016-02-18 11:30:01,718 Setting DEBUG logging. 2016-02-18 11:30:01,718 attempt 1/10 2016-02-18 11:30:01,718 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5ea830f5a8c3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-18 11:30:01,980 unpacking tar archive at: fx-team-5ea830f5a8c3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.563891 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 11:30:01.815617) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-18 11:30:01.815943) ========= echo 5ea830f5a8c358bffa34cc1934fedcaf09a870b9 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5ea830f5a8c358bffa34cc1934fedcaf09a870b9'] 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=920470bf432669ad7e3a5387000001ca-1455821219.133220-1870499538 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 5ea830f5a8c358bffa34cc1934fedcaf09a870b9 program finished with exit code 0 elapsedTime=0.004853 script_repo_revision: '5ea830f5a8c358bffa34cc1934fedcaf09a870b9' ========= master_lag: 0.06 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-18 11:30:01.883702) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-18 11:30:01.884030) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-18 11:30:01.906780) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-02-18 11:30:01.907173) ========= /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=920470bf432669ad7e3a5387000001ca-1455821219.133220-1870499538 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:30:02 INFO - MultiFileLogger online at 20160218 11:30:02 in /builds/slave/test-pgo 11:30:02 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 11:30:02 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:30:02 INFO - {'append_to_log': False, 11:30:02 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:30:02 INFO - 'blob_upload_branch': 'Fx-Team', 11:30:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:30:02 INFO - 'branch': 'Fx-Team', 11:30:02 INFO - 'buildbot_json_path': 'buildprops.json', 11:30:02 INFO - 'config_files': ('talos/linux_config.py',), 11:30:02 INFO - 'default_actions': ('clobber', 11:30:02 INFO - 'read-buildbot-config', 11:30:02 INFO - 'download-and-extract', 11:30:02 INFO - 'populate-webroot', 11:30:02 INFO - 'create-virtualenv', 11:30:02 INFO - 'install', 11:30:02 INFO - 'run-tests'), 11:30:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:30:02 INFO - 'download_minidump_stackwalk': True, 11:30:02 INFO - 'download_symbols': 'ondemand', 11:30:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:30:02 INFO - 'tooltool.py': '/tools/tooltool.py', 11:30:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:30:02 INFO - '/tools/misc-python/virtualenv.py')}, 11:30:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:30:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:30:02 INFO - 'installer_path': 'installer.exe', 11:30:02 INFO - 'log_level': 'info', 11:30:02 INFO - 'log_name': 'talos', 11:30:02 INFO - 'log_to_console': True, 11:30:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:30:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:30:02 INFO - 'opt_config_files': (), 11:30:02 INFO - 'pip_index': False, 11:30:02 INFO - 'sps_profile': False, 11:30:02 INFO - 'sps_profile_interval': 0, 11:30:02 INFO - 'suite': 'dromaeojs', 11:30:02 INFO - 'system_bits': '32', 11:30:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:30:02 INFO - 'title': 'talos-linux64-ix-053', 11:30:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:30:02 INFO - 'use_talos_json': True, 11:30:02 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:30:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:30:02 INFO - 'work_dir': 'build'} 11:30:02 INFO - ##### 11:30:02 INFO - ##### Running clobber step. 11:30:02 INFO - ##### 11:30:02 INFO - Running pre-action listener: _resource_record_pre_action 11:30:02 INFO - Running main action method: clobber 11:30:02 INFO - rmtree: /builds/slave/test-pgo/build 11:30:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:30:03 INFO - Running post-action listener: _resource_record_post_action 11:30:03 INFO - ##### 11:30:03 INFO - ##### Running read-buildbot-config step. 11:30:03 INFO - ##### 11:30:03 INFO - Running pre-action listener: _resource_record_pre_action 11:30:03 INFO - Running main action method: read_buildbot_config 11:30:03 INFO - Using buildbot properties: 11:30:03 INFO - { 11:30:03 INFO - "project": "", 11:30:03 INFO - "product": "firefox", 11:30:03 INFO - "script_repo_revision": "production", 11:30:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:30:03 INFO - "repository": "", 11:30:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:30:03 INFO - "buildid": "20160218083504", 11:30:03 INFO - "pgo_build": "True", 11:30:03 INFO - "basedir": "/builds/slave/test-pgo", 11:30:03 INFO - "buildnumber": 649, 11:30:03 INFO - "slavename": "talos-linux64-ix-053", 11:30:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:30:03 INFO - "platform": "ubuntu64_hw", 11:30:03 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:30:03 INFO - "branch": "fx-team", 11:30:03 INFO - "repo_path": "integration/fx-team", 11:30:03 INFO - "revision": "5ea830f5a8c358bffa34cc1934fedcaf09a870b9", 11:30:03 INFO - "stage_platform": "linux64-pgo", 11:30:03 INFO - "builduid": "283f900c0cfb428b82471f41a130cd69", 11:30:03 INFO - "slavebuilddir": "test" 11:30:03 INFO - } 11:30:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/Iu5urIbJTciIZcCGE1q6ug/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 11:30:03 INFO - Running post-action listener: _resource_record_post_action 11:30:03 INFO - ##### 11:30:03 INFO - ##### Running download-and-extract step. 11:30:03 INFO - ##### 11:30:03 INFO - Running pre-action listener: _resource_record_pre_action 11:30:03 INFO - Running main action method: download_and_extract 11:30:03 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:30:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:03 INFO - https://queue.taskcluster.net/v1/task/Iu5urIbJTciIZcCGE1q6ug/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:30:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Iu5urIbJTciIZcCGE1q6ug/artifacts/public/build/test_packages.json 11:30:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Iu5urIbJTciIZcCGE1q6ug/artifacts/public/build/test_packages.json 11:30:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Iu5urIbJTciIZcCGE1q6ug/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 11:30:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Iu5urIbJTciIZcCGE1q6ug/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 11:30:07 INFO - Downloaded 1448 bytes. 11:30:07 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 11:30:07 INFO - Using the following test package requirements: 11:30:07 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 11:30:07 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:30:07 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:30:07 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:30:07 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:30:07 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:30:07 INFO - u'jsshell-linux-x86_64.zip'], 11:30:07 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:30:07 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:30:07 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 11:30:07 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:30:07 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:30:07 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:30:07 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:30:07 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:30:07 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:30:07 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 11:30:07 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:30:07 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:30:07 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:30:07 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')]} 11:30:07 INFO - https://queue.taskcluster.net/v1/task/Iu5urIbJTciIZcCGE1q6ug/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:30:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Iu5urIbJTciIZcCGE1q6ug/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 11:30:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Iu5urIbJTciIZcCGE1q6ug/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 11:30:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Iu5urIbJTciIZcCGE1q6ug/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 11:30:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Iu5urIbJTciIZcCGE1q6ug/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 11:30:14 INFO - Downloaded 23348042 bytes. 11:30:14 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'] 11:30:14 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 11:30:15 INFO - Return code: 0 11:30:15 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 11:30:15 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')]} 11:30:15 INFO - https://queue.taskcluster.net/v1/task/Iu5urIbJTciIZcCGE1q6ug/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:30:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Iu5urIbJTciIZcCGE1q6ug/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 11:30:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Iu5urIbJTciIZcCGE1q6ug/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 11:30:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Iu5urIbJTciIZcCGE1q6ug/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 11:30:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Iu5urIbJTciIZcCGE1q6ug/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 11:30:17 INFO - Downloaded 23348042 bytes. 11:30:17 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'] 11:30:17 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 11:30:18 INFO - Return code: 0 11:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:18 INFO - https://queue.taskcluster.net/v1/task/Iu5urIbJTciIZcCGE1q6ug/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:30:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Iu5urIbJTciIZcCGE1q6ug/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 11:30:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Iu5urIbJTciIZcCGE1q6ug/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 11:30:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Iu5urIbJTciIZcCGE1q6ug/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 11:30:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Iu5urIbJTciIZcCGE1q6ug/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 11:30:20 INFO - Downloaded 10707071 bytes. 11:30:20 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'] 11:30:20 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 11:30:20 INFO - Return code: 0 11:30:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:20 INFO - https://queue.taskcluster.net/v1/task/Iu5urIbJTciIZcCGE1q6ug/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:30:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Iu5urIbJTciIZcCGE1q6ug/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 11:30:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Iu5urIbJTciIZcCGE1q6ug/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 11:30:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Iu5urIbJTciIZcCGE1q6ug/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 11:30:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Iu5urIbJTciIZcCGE1q6ug/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 11:30:21 INFO - Downloaded 56602623 bytes. 11:30:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Iu5urIbJTciIZcCGE1q6ug/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 11:30:21 INFO - mkdir: /builds/slave/test-pgo/properties 11:30:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:30:21 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:30:21 INFO - Contents: 11:30:21 INFO - build_url:https://queue.taskcluster.net/v1/task/Iu5urIbJTciIZcCGE1q6ug/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 11:30:22 INFO - Running post-action listener: _resource_record_post_action 11:30:22 INFO - Running post-action listener: set_extra_try_arguments 11:30:22 INFO - ##### 11:30:22 INFO - ##### Running populate-webroot step. 11:30:22 INFO - ##### 11:30:22 INFO - Running pre-action listener: _resource_record_pre_action 11:30:22 INFO - Running main action method: populate_webroot 11:30:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:30:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:30:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:30:22 INFO - '--tppagecycles', 11:30:22 INFO - '7'], 11:30:22 INFO - 'tests': ['tsvgm']}}, 11:30:22 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:30:22 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:30:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:30:22 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:30:22 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:30:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:30:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:30:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:22 INFO - 'talos_options': ['--e10s'], 11:30:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:30:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:22 INFO - 'tests': ['damp', 'tps']}, 11:30:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:22 INFO - 'talos_options': ['--e10s'], 11:30:22 INFO - 'tests': ['damp', 'tps']}, 11:30:22 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:30:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:30:22 INFO - 'other': {'tests': ['a11yr', 11:30:22 INFO - 'ts_paint', 11:30:22 INFO - 'tpaint', 11:30:22 INFO - 'sessionrestore', 11:30:22 INFO - 'sessionrestore_no_auto_restore']}, 11:30:22 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:30:22 INFO - 'tests': ['a11yr', 11:30:22 INFO - 'ts_paint', 11:30:22 INFO - 'tpaint', 11:30:22 INFO - 'sessionrestore', 11:30:22 INFO - 'sessionrestore_no_auto_restore']}, 11:30:22 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:30:22 INFO - 'tests': ['a11yr', 11:30:22 INFO - 'ts_paint', 11:30:22 INFO - 'tpaint', 11:30:22 INFO - 'sessionrestore', 11:30:22 INFO - 'sessionrestore_no_auto_restore']}, 11:30:22 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:30:22 INFO - 'tests': ['a11yr', 11:30:22 INFO - 'ts_paint', 11:30:22 INFO - 'tpaint', 11:30:22 INFO - 'sessionrestore', 11:30:22 INFO - 'sessionrestore_no_auto_restore']}, 11:30:22 INFO - 'other_l64': {'tests': ['a11yr', 11:30:22 INFO - 'ts_paint', 11:30:22 INFO - 'tpaint', 11:30:22 INFO - 'sessionrestore', 11:30:22 INFO - 'sessionrestore_no_auto_restore']}, 11:30:22 INFO - 'other_nol64': {'tests': ['a11yr', 11:30:22 INFO - 'ts_paint', 11:30:22 INFO - 'tpaint', 11:30:22 INFO - 'sessionrestore', 11:30:22 INFO - 'sessionrestore_no_auto_restore']}, 11:30:22 INFO - 'svgr': {'tests': ['tsvgx', 11:30:22 INFO - 'tsvgr_opacity', 11:30:22 INFO - 'tart', 11:30:22 INFO - 'tscrollx', 11:30:22 INFO - 'cart']}, 11:30:22 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:30:22 INFO - 'tests': ['tsvgx', 11:30:22 INFO - 'tsvgr_opacity', 11:30:22 INFO - 'tart', 11:30:22 INFO - 'tscrollx', 11:30:22 INFO - 'cart']}, 11:30:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:22 INFO - 'tests': ['tp5o']}, 11:30:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:22 INFO - 'talos_options': ['--e10s'], 11:30:22 INFO - 'tests': ['tp5o']}, 11:30:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:22 INFO - 'talos_options': ['--xperf_path', 11:30:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:30:22 INFO - 'tests': ['tp5n']}, 11:30:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:30:22 INFO - 'talos_options': ['--e10s', 11:30:22 INFO - '--xperf_path', 11:30:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:30:22 INFO - 'tests': ['tp5n']}}, 11:30:22 INFO - 'talos.zip': {'path': '', 11:30:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:30:22 INFO - Running post-action listener: _resource_record_post_action 11:30:22 INFO - ##### 11:30:22 INFO - ##### Running create-virtualenv step. 11:30:22 INFO - ##### 11:30:22 INFO - Running pre-action listener: _resource_record_pre_action 11:30:22 INFO - Running main action method: create_virtualenv 11:30:22 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:30:22 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 11:30:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:30:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:30:22 INFO - Using real prefix '/usr' 11:30:22 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:30:23 INFO - Installing distribute.............................................................................................................................................................................................done. 11:30:25 INFO - Installing pip.................done. 11:30:25 INFO - Return code: 0 11:30:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:30:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:25 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 0x7f19fb330f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c9670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29588c0>, '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 0x29597c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2959c50>, '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': '920470bf432669ad7e3a5387000001ca-1455821219.133220-1870499538', '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 11:30:25 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 11:30:25 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 11:30:25 INFO - Using env: {'DISPLAY': ':0', 11:30:25 INFO - 'HOME': '/home/cltbld', 11:30:25 INFO - 'LANG': 'en_US.UTF-8', 11:30:25 INFO - 'LANGUAGE': 'en_US:en', 11:30:25 INFO - 'LOGNAME': 'cltbld', 11:30:25 INFO - 'MAIL': '/var/mail/cltbld', 11:30:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:25 INFO - 'MOZ_NO_REMOTE': '1', 11:30:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:25 INFO - 'NO_EM_RESTART': '1', 11:30:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:30:25 INFO - 'PWD': '/builds/slave/test-pgo', 11:30:25 INFO - 'SHELL': '/bin/bash', 11:30:25 INFO - 'SHLVL': '1', 11:30:25 INFO - 'TERM': 'linux', 11:30:25 INFO - 'TMOUT': '86400', 11:30:25 INFO - 'USER': 'cltbld', 11:30:25 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1455821219.133220-1870499538', 11:30:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:25 INFO - '_': '/tools/buildbot/bin/python'} 11:30:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:25 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 11:30:25 INFO - Cleaning up... 11:30:25 INFO - Return code: 0 11:30:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:30:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:25 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 0x7f19fb330f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c9670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29588c0>, '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 0x29597c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2959c50>, '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': '920470bf432669ad7e3a5387000001ca-1455821219.133220-1870499538', '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 11:30:25 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 11:30:25 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 11:30:25 INFO - Using env: {'DISPLAY': ':0', 11:30:25 INFO - 'HOME': '/home/cltbld', 11:30:25 INFO - 'LANG': 'en_US.UTF-8', 11:30:25 INFO - 'LANGUAGE': 'en_US:en', 11:30:25 INFO - 'LOGNAME': 'cltbld', 11:30:25 INFO - 'MAIL': '/var/mail/cltbld', 11:30:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:25 INFO - 'MOZ_NO_REMOTE': '1', 11:30:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:25 INFO - 'NO_EM_RESTART': '1', 11:30:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:30:25 INFO - 'PWD': '/builds/slave/test-pgo', 11:30:25 INFO - 'SHELL': '/bin/bash', 11:30:25 INFO - 'SHLVL': '1', 11:30:25 INFO - 'TERM': 'linux', 11:30:25 INFO - 'TMOUT': '86400', 11:30:25 INFO - 'USER': 'cltbld', 11:30:25 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1455821219.133220-1870499538', 11:30:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:25 INFO - '_': '/tools/buildbot/bin/python'} 11:30:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:25 INFO - Downloading/unpacking psutil>=0.7.1 11:30:25 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 11:30:25 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 11:30:25 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 11:30:25 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 11:30:25 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 11:30:25 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 11:30:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:30:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:30:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:30:27 INFO - Installing collected packages: psutil 11:30:27 INFO - Running setup.py install for psutil 11:30:27 INFO - building 'psutil._psutil_linux' extension 11:30:27 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 11:30:27 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 11:30:27 INFO - building 'psutil._psutil_posix' extension 11:30:27 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 11:30:27 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 11:30:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:30:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:30:27 INFO - Successfully installed psutil 11:30:27 INFO - Cleaning up... 11:30:28 INFO - Return code: 0 11:30:28 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:30:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:28 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 0x7f19fb330f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c9670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29588c0>, '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 0x29597c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2959c50>, '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': '920470bf432669ad7e3a5387000001ca-1455821219.133220-1870499538', '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 11:30:28 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 11:30:28 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 11:30:28 INFO - Using env: {'DISPLAY': ':0', 11:30:28 INFO - 'HOME': '/home/cltbld', 11:30:28 INFO - 'LANG': 'en_US.UTF-8', 11:30:28 INFO - 'LANGUAGE': 'en_US:en', 11:30:28 INFO - 'LOGNAME': 'cltbld', 11:30:28 INFO - 'MAIL': '/var/mail/cltbld', 11:30:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:28 INFO - 'MOZ_NO_REMOTE': '1', 11:30:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:28 INFO - 'NO_EM_RESTART': '1', 11:30:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:30:28 INFO - 'PWD': '/builds/slave/test-pgo', 11:30:28 INFO - 'SHELL': '/bin/bash', 11:30:28 INFO - 'SHLVL': '1', 11:30:28 INFO - 'TERM': 'linux', 11:30:28 INFO - 'TMOUT': '86400', 11:30:28 INFO - 'USER': 'cltbld', 11:30:28 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1455821219.133220-1870499538', 11:30:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:28 INFO - '_': '/tools/buildbot/bin/python'} 11:30:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:28 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:30:28 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 11:30:28 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 11:30:28 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 11:30:28 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 11:30:28 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 11:30:28 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 11:30:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:30:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:30:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:30:30 INFO - Installing collected packages: mozsystemmonitor 11:30:30 INFO - Running setup.py install for mozsystemmonitor 11:30:30 INFO - Successfully installed mozsystemmonitor 11:30:30 INFO - Cleaning up... 11:30:30 INFO - Return code: 0 11:30:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:30:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:30 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 0x7f19fb330f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c9670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29588c0>, '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 0x29597c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2959c50>, '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': '920470bf432669ad7e3a5387000001ca-1455821219.133220-1870499538', '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 11:30:30 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 11:30:30 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 11:30:30 INFO - Using env: {'DISPLAY': ':0', 11:30:30 INFO - 'HOME': '/home/cltbld', 11:30:30 INFO - 'LANG': 'en_US.UTF-8', 11:30:30 INFO - 'LANGUAGE': 'en_US:en', 11:30:30 INFO - 'LOGNAME': 'cltbld', 11:30:30 INFO - 'MAIL': '/var/mail/cltbld', 11:30:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:30 INFO - 'MOZ_NO_REMOTE': '1', 11:30:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:30 INFO - 'NO_EM_RESTART': '1', 11:30:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:30:30 INFO - 'PWD': '/builds/slave/test-pgo', 11:30:30 INFO - 'SHELL': '/bin/bash', 11:30:30 INFO - 'SHLVL': '1', 11:30:30 INFO - 'TERM': 'linux', 11:30:30 INFO - 'TMOUT': '86400', 11:30:30 INFO - 'USER': 'cltbld', 11:30:30 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1455821219.133220-1870499538', 11:30:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:30 INFO - '_': '/tools/buildbot/bin/python'} 11:30:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:30 INFO - Downloading/unpacking blobuploader==1.2.4 11:30:30 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 11:30:30 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 11:30:30 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 11:30:30 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 11:30:30 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 11:30:30 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 11:30:32 INFO - Downloading blobuploader-1.2.4.tar.gz 11:30:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:30:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:30:32 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 11:30:32 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 11:30:32 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 11:30:32 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 11:30:32 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 11:30:32 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 11:30:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:30:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:30:32 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 11:30:32 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 11:30:32 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 11:30:32 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 11:30:32 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 11:30:32 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 11:30:32 INFO - Downloading docopt-0.6.1.tar.gz 11:30:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:30:33 INFO - Installing collected packages: blobuploader, requests, docopt 11:30:33 INFO - Running setup.py install for blobuploader 11:30:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:30:33 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:30:33 INFO - Running setup.py install for requests 11:30:33 INFO - Running setup.py install for docopt 11:30:33 INFO - Successfully installed blobuploader requests docopt 11:30:33 INFO - Cleaning up... 11:30:33 INFO - Return code: 0 11:30:33 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:30:33 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')]} 11:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:33 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')]} 11:30:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:33 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 0x7f19fb330f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c9670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29588c0>, '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 0x29597c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2959c50>, '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': '920470bf432669ad7e3a5387000001ca-1455821219.133220-1870499538', '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 11:30:33 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 11:30:33 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 11:30:33 INFO - Using env: {'DISPLAY': ':0', 11:30:33 INFO - 'HOME': '/home/cltbld', 11:30:33 INFO - 'LANG': 'en_US.UTF-8', 11:30:33 INFO - 'LANGUAGE': 'en_US:en', 11:30:33 INFO - 'LOGNAME': 'cltbld', 11:30:33 INFO - 'MAIL': '/var/mail/cltbld', 11:30:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:33 INFO - 'MOZ_NO_REMOTE': '1', 11:30:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:33 INFO - 'NO_EM_RESTART': '1', 11:30:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:30:33 INFO - 'PWD': '/builds/slave/test-pgo', 11:30:33 INFO - 'SHELL': '/bin/bash', 11:30:33 INFO - 'SHLVL': '1', 11:30:33 INFO - 'TERM': 'linux', 11:30:33 INFO - 'TMOUT': '86400', 11:30:33 INFO - 'USER': 'cltbld', 11:30:33 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1455821219.133220-1870499538', 11:30:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:33 INFO - '_': '/tools/buildbot/bin/python'} 11:30:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:30:33 INFO - Running setup.py (path:/tmp/pip-nkCQkr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:30:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:30:33 INFO - Running setup.py (path:/tmp/pip-vCvydr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:30:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:30:33 INFO - Running setup.py (path:/tmp/pip-ay2pY1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:30:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:30:34 INFO - Running setup.py (path:/tmp/pip-Xe8MsE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:30:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:30:34 INFO - Running setup.py (path:/tmp/pip-RVJvmj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:30:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:30:34 INFO - Running setup.py (path:/tmp/pip-R8fCcp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:30:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:30:34 INFO - Running setup.py (path:/tmp/pip-CGl4o6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:30:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:30:34 INFO - Running setup.py (path:/tmp/pip-mb7Tbc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:30:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:30:34 INFO - Running setup.py (path:/tmp/pip-7_3dtk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:30:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:30:34 INFO - Running setup.py (path:/tmp/pip-LUEscx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:30:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:30:34 INFO - Running setup.py (path:/tmp/pip-NjoJQP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:30:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:30:34 INFO - Running setup.py (path:/tmp/pip-It9mGF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:30:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:30:34 INFO - Running setup.py (path:/tmp/pip-eHF40R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:30:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:30:34 INFO - Running setup.py (path:/tmp/pip-iD1yKz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:30:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:30:34 INFO - Running setup.py (path:/tmp/pip-cpB2Qq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:30:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:30:34 INFO - Running setup.py (path:/tmp/pip-e8nNAT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:30:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:30:34 INFO - Running setup.py (path:/tmp/pip-A4GFRs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:30:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:30:35 INFO - Running setup.py install for manifestparser 11:30:35 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:30:35 INFO - Running setup.py install for mozcrash 11:30:35 INFO - Running setup.py install for mozdebug 11:30:35 INFO - Running setup.py install for mozdevice 11:30:35 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:30:35 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:30:35 INFO - Running setup.py install for mozfile 11:30:35 INFO - Running setup.py install for mozhttpd 11:30:35 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:30:35 INFO - Running setup.py install for mozinfo 11:30:35 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:30:35 INFO - Running setup.py install for mozInstall 11:30:35 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:30:35 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:30:35 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:30:35 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:30:35 INFO - Running setup.py install for mozleak 11:30:35 INFO - Running setup.py install for mozlog 11:30:36 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:30:36 INFO - Running setup.py install for moznetwork 11:30:36 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:30:36 INFO - Running setup.py install for mozprocess 11:30:36 INFO - Running setup.py install for mozprofile 11:30:36 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:30:36 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:30:36 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:30:36 INFO - Running setup.py install for mozrunner 11:30:36 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:30:36 INFO - Running setup.py install for mozscreenshot 11:30:36 INFO - Running setup.py install for moztest 11:30:36 INFO - Running setup.py install for mozversion 11:30:36 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:30:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:30:36 INFO - Cleaning up... 11:30:36 INFO - Return code: 0 11:30:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:30:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:36 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 0x7f19fb330f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c9670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29588c0>, '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 0x29597c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2959c50>, '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': '920470bf432669ad7e3a5387000001ca-1455821219.133220-1870499538', '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 11:30:36 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 11:30:36 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 11:30:36 INFO - Using env: {'DISPLAY': ':0', 11:30:36 INFO - 'HOME': '/home/cltbld', 11:30:36 INFO - 'LANG': 'en_US.UTF-8', 11:30:36 INFO - 'LANGUAGE': 'en_US:en', 11:30:36 INFO - 'LOGNAME': 'cltbld', 11:30:36 INFO - 'MAIL': '/var/mail/cltbld', 11:30:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:36 INFO - 'MOZ_NO_REMOTE': '1', 11:30:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:36 INFO - 'NO_EM_RESTART': '1', 11:30:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:30:36 INFO - 'PWD': '/builds/slave/test-pgo', 11:30:36 INFO - 'SHELL': '/bin/bash', 11:30:36 INFO - 'SHLVL': '1', 11:30:36 INFO - 'TERM': 'linux', 11:30:36 INFO - 'TMOUT': '86400', 11:30:36 INFO - 'USER': 'cltbld', 11:30:36 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1455821219.133220-1870499538', 11:30:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:36 INFO - '_': '/tools/buildbot/bin/python'} 11:30:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:30:37 INFO - Running setup.py (path:/tmp/pip-CIweBZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:30:37 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)) 11:30:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:30:37 INFO - Running setup.py (path:/tmp/pip-svrE8i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:30:37 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)) 11:30:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:30:37 INFO - Running setup.py (path:/tmp/pip-SaZ24O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:30:37 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)) 11:30:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:30:37 INFO - Running setup.py (path:/tmp/pip-zZ_MPH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:30:37 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)) 11:30:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:30:37 INFO - Running setup.py (path:/tmp/pip-lTlBYw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:30:37 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)) 11:30:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:30:37 INFO - Running setup.py (path:/tmp/pip-Js3Zbd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:30:37 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)) 11:30:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:30:37 INFO - Running setup.py (path:/tmp/pip-RrXPYB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:30:37 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)) 11:30:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:30:37 INFO - Running setup.py (path:/tmp/pip-bf0WDz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:30:37 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)) 11:30:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:30:37 INFO - Running setup.py (path:/tmp/pip-0ioqVv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:30:37 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)) 11:30:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:30:37 INFO - Running setup.py (path:/tmp/pip-cbzsaV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:30:37 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)) 11:30:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:30:37 INFO - Running setup.py (path:/tmp/pip-0vJk3c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:30:37 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)) 11:30:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:30:37 INFO - Running setup.py (path:/tmp/pip-_Y5hXD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:30:37 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)) 11:30:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:30:37 INFO - Running setup.py (path:/tmp/pip-gPYXIL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:30:37 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)) 11:30:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:30:37 INFO - Running setup.py (path:/tmp/pip-0oVq9X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:30:38 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)) 11:30:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:30:38 INFO - Running setup.py (path:/tmp/pip-VlUNBf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:30:38 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)) 11:30:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:30:38 INFO - Running setup.py (path:/tmp/pip-GAlcFu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:30:38 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)) 11:30:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:30:38 INFO - Running setup.py (path:/tmp/pip-vIIASB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:30:38 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)) 11:30:38 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)) 11:30:38 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)) 11:30:38 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)) 11:30:38 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)) 11:30:38 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)) 11:30:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:30:38 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 11:30:38 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 11:30:38 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 11:30:38 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 11:30:38 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 11:30:38 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 11:30:40 INFO - Downloading blessings-1.6.tar.gz 11:30:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:30:40 INFO - Installing collected packages: blessings 11:30:40 INFO - Running setup.py install for blessings 11:30:40 INFO - Successfully installed blessings 11:30:40 INFO - Cleaning up... 11:30:40 INFO - Return code: 0 11:30:40 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:30:40 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:30:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:30:40 INFO - Reading from file tmpfile_stdout 11:30:40 INFO - Current package versions: 11:30:40 INFO - argparse == 1.2.1 11:30:40 INFO - blessings == 1.6 11:30:40 INFO - blobuploader == 1.2.4 11:30:40 INFO - docopt == 0.6.1 11:30:40 INFO - manifestparser == 1.1 11:30:40 INFO - mozInstall == 1.12 11:30:40 INFO - mozcrash == 0.16 11:30:40 INFO - mozdebug == 0.1 11:30:40 INFO - mozdevice == 0.48 11:30:40 INFO - mozfile == 1.2 11:30:40 INFO - mozhttpd == 0.7 11:30:40 INFO - mozinfo == 0.9 11:30:40 INFO - mozleak == 0.1 11:30:40 INFO - mozlog == 3.1 11:30:40 INFO - moznetwork == 0.27 11:30:40 INFO - mozprocess == 0.22 11:30:40 INFO - mozprofile == 0.28 11:30:40 INFO - mozrunner == 6.11 11:30:40 INFO - mozscreenshot == 0.1 11:30:40 INFO - mozsystemmonitor == 0.0 11:30:40 INFO - moztest == 0.7 11:30:40 INFO - mozversion == 1.4 11:30:40 INFO - psutil == 3.1.1 11:30:40 INFO - requests == 1.2.3 11:30:40 INFO - wsgiref == 0.1.2 11:30:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:30:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:40 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 0x7f19fb330f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c9670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29588c0>, '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 0x29597c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2959c50>, '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': '920470bf432669ad7e3a5387000001ca-1455821219.133220-1870499538', '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 11:30:40 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 11:30:40 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 11:30:40 INFO - Using env: {'DISPLAY': ':0', 11:30:40 INFO - 'HOME': '/home/cltbld', 11:30:40 INFO - 'LANG': 'en_US.UTF-8', 11:30:40 INFO - 'LANGUAGE': 'en_US:en', 11:30:40 INFO - 'LOGNAME': 'cltbld', 11:30:40 INFO - 'MAIL': '/var/mail/cltbld', 11:30:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:40 INFO - 'MOZ_NO_REMOTE': '1', 11:30:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:40 INFO - 'NO_EM_RESTART': '1', 11:30:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:30:40 INFO - 'PWD': '/builds/slave/test-pgo', 11:30:40 INFO - 'SHELL': '/bin/bash', 11:30:40 INFO - 'SHLVL': '1', 11:30:40 INFO - 'TERM': 'linux', 11:30:40 INFO - 'TMOUT': '86400', 11:30:40 INFO - 'USER': 'cltbld', 11:30:40 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1455821219.133220-1870499538', 11:30:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:40 INFO - '_': '/tools/buildbot/bin/python'} 11:30:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:40 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)) 11:30:40 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)) 11:30:40 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)) 11:30:40 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)) 11:30:40 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)) 11:30:40 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)) 11:30:40 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)) 11:30:40 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)) 11:30:40 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)) 11:30:40 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)) 11:30:40 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)) 11:30:40 INFO - Cleaning up... 11:30:40 INFO - Return code: 0 11:30:40 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:30:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:30:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f19fb330f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c9670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29588c0>, '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 0x29597c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2959c50>, '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': '920470bf432669ad7e3a5387000001ca-1455821219.133220-1870499538', '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 11:30:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 11:30:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:30:40 INFO - Using env: {'DISPLAY': ':0', 11:30:40 INFO - 'HOME': '/home/cltbld', 11:30:40 INFO - 'LANG': 'en_US.UTF-8', 11:30:40 INFO - 'LANGUAGE': 'en_US:en', 11:30:40 INFO - 'LOGNAME': 'cltbld', 11:30:40 INFO - 'MAIL': '/var/mail/cltbld', 11:30:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:40 INFO - 'MOZ_NO_REMOTE': '1', 11:30:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:40 INFO - 'NO_EM_RESTART': '1', 11:30:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:30:40 INFO - 'PWD': '/builds/slave/test-pgo', 11:30:40 INFO - 'SHELL': '/bin/bash', 11:30:40 INFO - 'SHLVL': '1', 11:30:40 INFO - 'TERM': 'linux', 11:30:40 INFO - 'TMOUT': '86400', 11:30:40 INFO - 'USER': 'cltbld', 11:30:40 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1455821219.133220-1870499538', 11:30:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:40 INFO - '_': '/tools/buildbot/bin/python'} 11:30:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:40 INFO - Downloading/unpacking jsonschema 11:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:30:42 INFO - Downloading/unpacking functools32 (from jsonschema) 11:30:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:42 INFO - Downloading functools32-3.2.3-2.tar.gz 11:30:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:30:43 INFO - warning: no files found matching '*.txt' 11:30:43 INFO - no previously-included directories found matching 'build' 11:30:43 INFO - no previously-included directories found matching 'dist' 11:30:43 INFO - no previously-included directories found matching '.git*' 11:30:43 INFO - Installing collected packages: jsonschema, functools32 11:30:43 INFO - Running setup.py install for functools32 11:30:43 INFO - warning: no files found matching '*.txt' 11:30:43 INFO - no previously-included directories found matching 'build' 11:30:43 INFO - no previously-included directories found matching 'dist' 11:30:43 INFO - no previously-included directories found matching '.git*' 11:30:43 INFO - Successfully installed jsonschema functools32 11:30:43 INFO - Cleaning up... 11:30:43 INFO - Return code: 0 11:30:43 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:30: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')]} 11:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:30:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30: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')]} 11:30:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:30:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:30: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f19fb330f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c9670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29588c0>, '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 0x29597c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2959c50>, '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': '920470bf432669ad7e3a5387000001ca-1455821219.133220-1870499538', '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 11:30: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', 'flake8'] in /builds/slave/test-pgo/build 11:30: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 flake8 11:30:43 INFO - Using env: {'DISPLAY': ':0', 11:30:43 INFO - 'HOME': '/home/cltbld', 11:30:43 INFO - 'LANG': 'en_US.UTF-8', 11:30:43 INFO - 'LANGUAGE': 'en_US:en', 11:30:43 INFO - 'LOGNAME': 'cltbld', 11:30:43 INFO - 'MAIL': '/var/mail/cltbld', 11:30:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:43 INFO - 'MOZ_NO_REMOTE': '1', 11:30:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:43 INFO - 'NO_EM_RESTART': '1', 11:30:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:30:43 INFO - 'PWD': '/builds/slave/test-pgo', 11:30:43 INFO - 'SHELL': '/bin/bash', 11:30:43 INFO - 'SHLVL': '1', 11:30:43 INFO - 'TERM': 'linux', 11:30:43 INFO - 'TMOUT': '86400', 11:30:43 INFO - 'USER': 'cltbld', 11:30:43 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1455821219.133220-1870499538', 11:30:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:43 INFO - '_': '/tools/buildbot/bin/python'} 11:30:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:30:43 INFO - Downloading/unpacking flake8 11:30:43 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 11:30:43 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 11:30:43 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 11:30:43 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 11:30:43 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 11:30:43 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 11:30:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:30:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:30:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:30:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:30:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:30:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:30:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:30:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:30:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:30:45 INFO - no previously-included directories found matching 'docs/_build' 11:30:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:30:46 INFO - Running setup.py install for pep8 11:30:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:30:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:30:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:30:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:30:46 INFO - no previously-included directories found matching 'docs/_build' 11:30:46 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:30:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:30:46 INFO - Cleaning up... 11:30:46 INFO - Return code: 0 11:30:46 INFO - Running post-action listener: _resource_record_post_action 11:30:46 INFO - Running post-action listener: _start_resource_monitoring 11:30:46 INFO - Starting resource monitoring. 11:30:46 INFO - ##### 11:30:46 INFO - ##### Running install step. 11:30:46 INFO - ##### 11:30:46 INFO - Running pre-action listener: _resource_record_pre_action 11:30:46 INFO - Running main action method: install 11:30:46 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:30:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:30:46 INFO - Reading from file tmpfile_stdout 11:30:46 INFO - Detecting whether we're running mozinstall >=1.0... 11:30:46 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:30:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:30:46 INFO - Reading from file tmpfile_stdout 11:30:46 INFO - Output received: 11:30:46 INFO - Usage: mozinstall [options] installer 11:30:46 INFO - Options: 11:30:46 INFO - -h, --help show this help message and exit 11:30:46 INFO - -d DEST, --destination=DEST 11:30:46 INFO - Directory to install application into. [default: 11:30:46 INFO - "/builds/slave/test-pgo"] 11:30:46 INFO - --app=APP Application being installed. [default: firefox] 11:30:46 INFO - mkdir: /builds/slave/test-pgo/build/application 11:30:46 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'] 11:30:46 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 11:31:02 INFO - Reading from file tmpfile_stdout 11:31:02 INFO - Output received: 11:31:02 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:31:02 INFO - Running post-action listener: _resource_record_post_action 11:31:02 INFO - ##### 11:31:02 INFO - ##### Running run-tests step. 11:31:02 INFO - ##### 11:31:02 INFO - Running pre-action listener: _resource_record_pre_action 11:31:02 INFO - Running main action method: run_tests 11:31:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:31:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:31:02 INFO - Python 2.7.3 11:31:02 INFO - Return code: 0 11:31:02 INFO - grabbing minidump binary from tooltool 11:31: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')]} 11:31:02 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 0x29588c0>, '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 0x29597c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2959c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:31:02 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 11:31:02 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 11:31:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:31:02 INFO - Return code: 0 11:31:02 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:31:02 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:31:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:31:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:31:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:31:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:31:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:31:03 INFO - Return code: 0 11:31:03 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/Iu5urIbJTciIZcCGE1q6ug/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 11:31:03 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/Iu5urIbJTciIZcCGE1q6ug/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 11:31:03 INFO - Using env: {'DISPLAY': ':0', 11:31:03 INFO - 'HOME': '/home/cltbld', 11:31:03 INFO - 'LANG': 'en_US.UTF-8', 11:31:03 INFO - 'LANGUAGE': 'en_US:en', 11:31:03 INFO - 'LOGNAME': 'cltbld', 11:31:03 INFO - 'MAIL': '/var/mail/cltbld', 11:31:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:31:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:03 INFO - 'MOZ_NO_REMOTE': '1', 11:31:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:31:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:03 INFO - 'NO_EM_RESTART': '1', 11:31:03 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:31:03 INFO - 'PWD': '/builds/slave/test-pgo', 11:31:03 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:31:03 INFO - 'SHELL': '/bin/bash', 11:31:03 INFO - 'SHLVL': '1', 11:31:03 INFO - 'TERM': 'linux', 11:31:03 INFO - 'TMOUT': '86400', 11:31:03 INFO - 'USER': 'cltbld', 11:31:03 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1455821219.133220-1870499538', 11:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:03 INFO - '_': '/tools/buildbot/bin/python'} 11:31:03 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/Iu5urIbJTciIZcCGE1q6ug/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 11:31:04 INFO - mozversion application_buildid: 20160218083504 11:31:04 INFO - mozversion application_changeset: 5ea830f5a8c358bffa34cc1934fedcaf09a870b9 11:31:04 INFO - mozversion application_display_name: Nightly 11:31:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:31:04 INFO - mozversion application_name: Firefox 11:31:04 INFO - mozversion application_remotingname: firefox 11:31:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:31:04 INFO - mozversion application_vendor: Mozilla 11:31:04 INFO - mozversion application_version: 47.0a1 11:31:04 INFO - mozversion platform_buildid: 20160218083504 11:31:04 INFO - mozversion platform_changeset: 5ea830f5a8c358bffa34cc1934fedcaf09a870b9 11:31:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:31:04 INFO - mozversion platform_version: 47.0a1 11:31:04 INFO - using testdate: 1455823864 11:31:04 INFO - actual date: 1455823864 11:31:04 INFO - starting webserver on 'localhost:34918' 11:31:04 INFO - SUITE-START | Running 2 tests 11:31:04 INFO - TEST-START | dromaeo_css 11:31:04 INFO - operating with platform_type : linux_ 11:31:04 INFO - Initialising browser for dromaeo_css test... 11:31:04 INFO - TEST-INFO | started process 24024 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBvg9xZ/profile http://localhost:34918/getInfo.html) 11:31:08 INFO - PROCESS | 24024 | __metrics Screen width/height:1600/1200 11:31:08 INFO - PROCESS | 24024 | colorDepth:24 11:31:08 INFO - PROCESS | 24024 | Browser inner width/height: 1024/697 11:31:08 INFO - PROCESS | 24024 | __metrics 11:31:09 INFO - PROCESS | 24024 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:31:10 INFO - TEST-INFO | 24024: exit 0 11:31:10 INFO - Browser initialized. 11:31:10 INFO - Running cycle 1/1 for dromaeo_css test... 11:31:10 INFO - TEST-INFO | started process 24118 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBvg9xZ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:31:22 INFO - PROCESS | 24118 | RSS: Main: 147271680 11:31:22 INFO - PROCESS | 24118 | 11:32:13 INFO - PROCESS | 24118 | 1455823933370 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] 11:34:21 INFO - PROCESS | 24118 | Cycle 1(1): loaded http://localhost:34918/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34918/tests/dromaeo/cssquery-ext.html) 11:34:22 INFO - PROCESS | 24118 | RSS: Main: 258371584 11:34:22 INFO - PROCESS | 24118 | 11:37:24 INFO - PROCESS | 24118 | Cycle 1(1): loaded http://localhost:34918/tests/dromaeo/cssquery-ext.html (next: http://localhost:34918/tests/dromaeo/cssquery-jquery.html) 11:37:25 INFO - PROCESS | 24118 | RSS: Main: 239304704 11:37:25 INFO - PROCESS | 24118 | 11:40:27 INFO - PROCESS | 24118 | Cycle 1(1): loaded http://localhost:34918/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34918/tests/dromaeo/cssquery-mootools.html) 11:40:27 INFO - PROCESS | 24118 | RSS: Main: 237793280 11:40:27 INFO - PROCESS | 24118 | 11:43:29 INFO - PROCESS | 24118 | Cycle 1(1): loaded http://localhost:34918/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34918/tests/dromaeo/cssquery-prototype.html) 11:43:30 INFO - PROCESS | 24118 | RSS: Main: 215191552 11:43:30 INFO - PROCESS | 24118 | 11:46:32 INFO - PROCESS | 24118 | Cycle 1(1): loaded http://localhost:34918/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34918/tests/dromaeo/cssquery-yui.html) 11:46:33 INFO - PROCESS | 24118 | RSS: Main: 220221440 11:46:33 INFO - PROCESS | 24118 | 11:49:36 INFO - PROCESS | 24118 | Cycle 1(1): loaded http://localhost:34918/tests/dromaeo/cssquery-yui.html (next: http://localhost:34918/tests/dromaeo/cssquery-dojo.html) 11:49:36 INFO - PROCESS | 24118 | RSS: Main: 236359680 11:49:36 INFO - PROCESS | 24118 | 11:49:36 INFO - PROCESS | 24118 | __start_tp_report 11:49:36 INFO - PROCESS | 24118 | _x_x_mozilla_page_load 11:49:36 INFO - PROCESS | 24118 | _x_x_mozilla_page_load_details 11:49:36 INFO - PROCESS | 24118 | |i|pagename|runs| 11:49:36 INFO - PROCESS | 24118 | |0;dojo.html;3134.05978206538;3140.183552276407;3182.2362632968093;3184.79298845575;3223.693749093836;4962.305277261186;5047.318611987381;5094.439611642716;5108.565771909392;5130.9230361544605;5130.538251557359;5168.586513078954;5185.222216667502;5200.817971371002;5216.504432078956;4610.608098311631;4675.135100006492;4730.976345118287;4788.209945359029;4804.942912559231;4601.033782905593;4666.603338716213;4760.857174284777;4800.927986080212;4831.879203019917;4698.130845793505;4729.739864307462;4739.502352252998;4741.454732705749;4778.450478195;4701.858944231679;4710.26990816424;4722.976385118087;4731.313959475857;4748.145333839908;4500.257457519506;4666.2767271073035;4713.293006049086;4725.740084295362;4728.810847566127;4965.925511117336;4971.130052240844;4996.600271978233;4998.175301075318;5013.824516141954;5384.246205531229;5515.117581187031;5531.225628412026;5531.3362396512275;5544.667319960775;5491.395946445888;5542.362628297717;5571.4150014248735;5629.746661400247;5658.122990936411;5154.639175257696;5164.870878228036;5167.069927413102;5173.3533308336455;5180.4042535108565;5511.614187006951;5610.214569960209;5612.102063669793;5616.354119276336;5621.80323688669;5402.648827826179;5423.810166644227;5429.511343979061;5441.809536666197;5490.3411590609385;5436.266104075899;5459.808906688247;5466.91799622998;5467.917981230285;5489.533389661923;5333.439988801198;5408.432114627986;5457.372402173722;5467.644603100865;5514.338279406497;5507.7246137692955;5510.779568817283;5515.503604675599;5519.917201241985;5556.555475561945;4302.22559939214;4306.935395969063;4310.956890431055;4334.848280310174;4342.457192850894;3794.8102594870147;3809.8476060957805;3858.884233473;3868.903277418031;3881.049142959993;5107.284980102789;5133.383993920679;5138;5139.254808052811;5191.636585439059;5456.781728730885;5488.835334939959;5492.1212605982855;5499.890002199933;5511.834644960658;4943.184374578154;5026.346574945307;5119.078565858107;5170.689758614495;5206.817761378334;4677.22825733757;4703.129920964632;4707.929381059287;4710.24636058229;4735.455422626442;5697.202391665171;5711.942880571224;5716.971415142981;5745.770169193185;5748.770049198069;5413.269208656781;5521.475459831309;5521.806736764194;5533.253010843485;5589.916151257653;5685.346185188756;5717.771289148387;5718.714064296685;5719.456651618089;5721.1990321354215;5344.038073146871;5395.487428694268;5415.182241710027;5415.48552887475;5429.239906413026;5554.91667624994;5558.499735023867;5560.082586373203;5561.749721262472;5587.189857470563;5385.649932754515;5409.675419474844;5412.864678383072;5418.756155972912;5478.04134276508;5263.368395792376;5284;5318.840434786963;5364;5437.265969094122;5279.973600131974;5285.63000589955;5293.9205911910585;5298.496642818926;5303.814366497154;5293.2589437479555;5391.865203369947;5426.782928682808;5438.075527160471;5469.3983661797965;5216.452272511332;5223.895522089461;5233.869153271199;5243.265942767939;5277.234800953764 11:49:36 INFO - PROCESS | 24118 | |1;ext.html;526.3657292961981;548.1749966300716;567.9432056794318;588.6144575303176;595.1875689683582;35410;36114.09714757126;36257.46197766157;36288.81855590725;36309.273814523694;38958.415623765664;39638;39669.80165099178;39696.801515992454;39728.602713972854;8378.162183781618;8571.442856214357;8586.141385861427;8595.742127736146;8601.526916019617;8717.171868672465;8886.600102995348;8887.644494220256;8889.111088891124;8892.244159246471;8849.292056635486;8966.775830604221;8976.326775491832;8976.640934362618;8984.46093234408;8798.736037918841;8880.555972201364;8880.8667869982;8882.15619516145;8893.199612034949;8745.737627871174;8814.779630509225;8822.779430514225;8841.248493878029;8888.511131887744;39716.20567588661;40119;40220.798896005625;40303.59696403057;40331.59668403308;3319.8008119512906;3833.21419109082;4005.459262999487;4017.879463616096;4025.215083058805;29445.70554294451;29953.400931981458;30063;30160.54759178614;30964.22589435282;3958.524977002778;3980.601939805996;4025.2352053109817;4056.4320995060716;4061.3095773718537;259450;259808.80382392247;260020;260636;261466;60238.39761602328;60478.395216047276;60487.39512604818;60611;60714.392856071754;63225.683871580346;63472.68263658652;63587.364126358145;63627.6818615904;63692;16332.918335408247;16393;16544.255508502145;16549.089800061112;16558;12134.514619415124;12159.696007599881;12185.817212741817;12191.573294934813;12198.268103913793;18705.113773220426;20215.696764548542;20387.796122038886;20447.182112715323;20477.180912763324;6605.636689982097;7834.7257845976255;7979.241972012649;8011.359091272684;8029.156938521488;894.9060348663296;917.3440989692402;941.5904081724472;992;1072.3565860483802;28195.71804281931;29190.270243243664;29248.707512924597;29370.55944160839;29570.260743481584;1039.443897514826;1074.5916551710457;1094.2832444748703;1099.483242875847;1152.913531485142;12008.819867701992;14684.41262349494;14838.554843354717;15553.30010149546;15799.68400632004;324489;324558;325101;325850;325987;53954;54235.45764542383;54243.72878135663;54316.72841635766;54397;1240.6154092231436;1349.419749507721;1378.5244090788663;1381.675306303018;1394.7140836128367;27617.723822761516;28648.85675571609;28811.5678264822;28946.7105328944;28993.56509652399;40348.394774077824;40359;40389.1922161561;41078.38382424326;41543.792281038404;181291;199559;200760;200832;201194;27973.300667483476;30660;31674.524882126327;31700.5244921331;31900.6809931907;38219.2356152881;38595.68425894455;41960.58039419567;42824;43351.566484334755;32839.671603284616;33043.33913321672;33169.50245746267;33266.501002484496;33478.4978225322;32129.67870321267;32861.83569082139;32992.67007329896;33069;33168.83415582906;32310;32433.351332972736;32505.34989300248;32517.512237316932;32519.18702032468;30536;31223.687763122987;32578.83710581432;32704.345913081128;32731.509027364133;24422.26733198007;24594.385140371633;24776.132835350676;25163.74836251614;25175.49649007046 11:49:36 INFO - PROCESS | 24118 | |2;jquery.html;353.92567560812245;359.93521166190084;364.51883513761834;364.67726062434735;365.9085228692827;13382.933085334584;13607.795883061763;16275.267612957416;16585.66828663426;17764.200610972523;15439.150846703427;16262.593435164126;16576.58558536037;16591.41930032449;17114.914425427854;5298.258243845855;5510.752016159262;5514.6691198528015;5525.281713377275;5526.143447765603;3992.7803970781597;5475.6440831346035;5530.917036244459;5771.451712087345;6178.289496707869;5977.820665380045;6005.039193729004;6049.48579370754;6055.666938318391;6060.606060606046;5836.941630583682;5997.010493268605;6003.249593800775;6004.039353703386;6015.969920150393;5256.553192978601;5272.393674727378;5280.20796880471;5349.251104845324;5430.511253987121;20674.379768606967;20747.377578672666;20998.580028399498;21503.247386341558;21534;2167.5014746608213;2207.5033117548583;2811.4096039831456;2816.2114607909816;3014.4724673182104;12499.75000499994;13043.282619455926;13067.346632668328;13416.597502074856;13502.797458038138;1854.7681539807525;1904.3239649924355;1919.577692907558;1926.7109933509946;1954.198778500822;56532.43467565313;58566;60048.69975650094;60460.69769651168;60502.092468612565;9755.609775609038;9973.60105595768;10244.641437549799;10257.846132308021;10284.485775711184;13475.528356507475;13572.524961626295;13572.592822215349;13586;13600.183988960694;7530.058742657168;7588;7589.772306830804;7899.368050555941;7952.443328967032;7365.594892280976;7913.604319783988;7920.643571039317;7932.762017139495;7954;5539.196816461671;6018.8194354169445;6099.481544068715;6198.349173336825;6292.874142517216;1679.22755532454;1690.6111594333127;1744.633626938357;1808.954776130581;1810.7193385025341;819.2301413369861;882.2412725056446;884.1335491218513;912.7124955638952;964.609333220047;13656;14571.781423278659;16990;17005.744913826304;17518.912405438146;890.2121622364255;914.3188324698142;926.416357694648;964.216200029953;982.1553464020936;9484.905150948402;9848.113669769755;9855.31012829095;9864.556094975744;9913.553890074963;297231;298401;301043;302869;409342;66468.33531664718;67995.66002169957;69707.30292697008;70769.64615176892;73216.63391683008;1003.8745156855393;1044.3629386074338;1052.1057101463848;1054.857594224785;1072.7157303314627;14206.644833879236;14924;15147.772783408038;15208.771868421762;15282.159481228638;31489.370212596077;33829.154271143416;34693.82653086718;34846.47730284098;35344;45135.32297015613;45926.54073459356;46169.76915115403;49341.50658493513;51230.74384628053;10148.847767283349;10710.058583065578;10844.132469402271;10885.292455990651;11050.889491105308;10174.949125254623;12332.568360107352;12450.75098498043;12670.556530521388;12806.615801525597;10362.326448780805;10492.265541412027;10636.41499717492;10739.785204295715;10771.51528181218;10742.516586753458;10776.407297598707;10949.781004379709;11093.778124437305;11211.71970700739;7737;9374.625014999323;10633.840492392466;10811.35131892089;11202.94398528002;10904.182186335898;10999.395033273247;11018.338899666045;11052.281601695864;11172.994430501294;9931.751706207402;10090.09189172978;10160.949195253976;10290.279680422298;10340.12108970746 11:49:36 INFO - PROCESS | 24118 | |3;mootools.html;1314.38880920372;1455.3669153918045;1464.729025130351;1629.6659184867103;1762.814904435035;6701.832454188648;7158.248383919691;7315.4879158458925;7324.267573242673;7349.669264883079;7161.570305781656;7335.8532829343385;7351.66917488713;7359.926400735991;7377.59423231722;1933.69060950248;2217.5786600545925;2233.519793244452;2263.7396699379533;2265.546890621874;2244.674522194281;2287.7712228777073;2290.1526435218907;2292.701948746669;2294.128231272114;2218.5341078373563;2299.31020693792;2304.8617082974993;2304.9654255186188;2305.7117860267467;2255.4248666589997;2273.0339605667527;2288.370698058039;2297.6438652008965;2300.1259521381935;2246.4383904023994;2266.8073213776847;2298.367948814073;2306.919257825968;2313.9305820825234;7258.274172582753;7313.926860731378;7317.085364329459;7330.743423980189;7333.743318983863;4570.9314360284625;4665.650076244261;4672.439307283148;4676.134915040729;4679.344891715163;2897.884084636612;2926.8682909268923;2928.1947464447235;2943.7792165587666;3039.6352437707615;888.7422647432302;899.3704406915185;907.4600612635471;911.762941635173;924.306769922558;9526.523673816351;9532.332736708433;9606.711798646053;9662.56518456671;9672.22622190223;4162.354835000579;4172.186423647359;4189.392538081961;4235.618794308527;4255.446791917031;8485.787855303666;8488.915110848937;8498.66005359791;8513.872291915626;8530.317574594017;4577.22187228172;4602.7698615069785;4603.240465323184;4605.148047611203;4615.861524154214;4162.917641413254;4169.854055108057;4171.0615111599645;4210;4214.789260536961;3207.7273431758563;3364.444866597033;3468.2023134679166;3524.418470952264;3551.2009797795804;1149.747055647756;1150.0454622663337;1167.4279602994472;1168.1005625668358;1173.3253379306761;1270.6442196185083;1295.1322613848745;1303.1008604063165;1345.1458323964353;1347.211881049597;6847.520673552903;6898.1377327834025;6901.240863505011;6925.58446493202;6934.341237582422;1112.2992514715677;1114.912577327783;1130.1862658885589;1132.3375825142384;1137.5165554639245;5531.806386776443;5632.887342253132;5637.267155269788;5638.915416268759;5650.0959846424375;8620.741377758677;8652.3510736695;8721.520316382659;8839.779005524784;8875.778105547413;8697.21725044749;8767.167119123673;8767.605457754416;8781.165789250012;8787.516686582172;6806.183258008971;6988.895166572505;6994;7050.964745176241;7070.71717131309;6544.5418820684;6585.209774827052;6595.703193356215;6612.107365505787;6673.466122710269;7572.507786993828;7791.104023037423;7810;7836.647350869339;7906.248906353887;7986.161453047346;7989.360851131779;8023.799405014921;8105.716299929474;8174.468659537111;6311.368863113652;6730.764423245163;7011.228764835762;7096.396806271525;7100.183478899992;7026.156861176692;7134.750283740044;7195.244499327495;7200.099987501562;7201.207867134715;6418.775342862978;6456.451201647913;6524.804255872332;6641.402273795382;6661.300563440769;6404.935950640434;6434.903476447951;6479.643619600779;6573.868522629617;6608.471322294301;6541.96729016371;6566.737330506726;6582.144321238208;6586.077949087035;6620.2386725527185;6142.324344322032;6235.314115447207;6240.5319601031015;6297.496200304056;6302.243730752339;6147.969260153671;6164.260288765377;6187.969060154671;6204.13142160089;6205.22434695663 11:49:36 INFO - PROCESS | 24118 | |4;prototype.html;322.68215807429675;333.7663635455182;338.12931700870257;338.7459405445916;344.97930124192544;5839.036558967776;5859.853503662411;5874.236349274599;5882.970585147079;5890.087036509342;5575.944240557593;5699.287589051369;5756.194132821408;5767.221425107609;5821.650700957945;4500.819967201308;4502.5047244803045;4506.571875671822;4514.277715565502;4514.435695538058;4367.45406824147;4491.034427598066;4497.572730590588;4497.7526236057;4503.707259028152;4395.824167033315;4510.751908645039;4520.480144783342;4525.004499010229;4539.046800171968;4502.212112880249;4531.3429552715;4532.161550113223;4532.4787649420405;4535.070310586322;4002.939955900664;4007.6593489553425;4012.4382586437923;4014.7189696721243;4021.2359651666384;5476.397596264408;5585.441455854423;5602.411746766612;5607.523360514361;5608.327000759935;5280.524752772269;5285.286486324336;5286.418493965661;5289.947100528984;5293.073712100367;6188.721507532172;6189.783357582463;6193.473554747852;6198.380161983766;6206.131141640174;4451.376807246956;4453.287474004176;4453.487848897385;4464.910701785979;4473.373727678128;6305.0542418637115;6461.3538646135485;6463.74145034198;6480.351964803529;6481.74073037078;4561.110583436264;4561.817527298937;4569.474510431343;4573.222552166139;4577.7482238477205;4620.676552641283;4625.976870115695;4627.1439783640135;4629.865682907709;4630.6758526902795;5276.34045744282;5277.258504693519;5281.656692314988;5287.814926477555;5288.338957630296;5999.970000149971;6207.317195108534;6210.285817130997;6236.937630623635;6240.254288113216;1562.7812106305125;1584.3345794765996;1589.8648614867634;1590.0698091616302;1592.6496170842397;1047.073340094007;1050.947452627381;1064.8455973883742;1067.0343339277965;1074.382230217628;6071.301800292935;6077.20996270482;6084.726187321581;6086.330503644595;6087.4521293083835;6574.901376479356;6591.143151390289;6595.274519802818;6613.272540020594;6613.437857782143;5762.394948530427;5863.794767183128;5942.70286485674;5969.611975221596;5976.133460648269;3509.298140371885;3555.1112221944513;3556.1820781220463;3560.359135355609;3562.71498280137;6519.348065193538;6651.534392592472;6965.5124141309625;6966.756163534252;6981.197162326296;6664.966675166593;6673.833154171185;6685.899711504331;6696.59820410777;6705.161854768154;6769.898451523231;6801.693923773442;6811.182658080963;6813.250542440328;6814.761483348059;6321.715522801393;6473.482121430368;6475.352464753487;6484.578502397329;6515.0553169791065;6433.839154021;6441.967790161019;6444.194475690539;6445;6456.515761317826;6741.359570840762;6755.831104222434;6759.628220447923;6762.289959554176;6818.488613353919;4463.821447142208;4540.477845047862;4579.06129243511;4579.519150489151;4585.266357382803;6379.170707807955;6392.968035159794;6395.456386207225;6407.135036769976;6408.743650254124;6205.751769929152;6213.937860621336;6220.440160385406;6220.626762394271;6220.720067596879;6021.066734656135;6218.875622487615;6223.37766223374;6224.035274532454;6238.282597501164;6085.300190478151;6087.086936959491;6092.055731361646;6096.5732398733435;6097.420745029215;6278.46633036197;6282.403171698681;6283.71723272463;6284.088807123033;6287.245530536365;5954.896231362888;6104.11490333908;6106.084087386927;6121.816345509642;6122.816315510542 11:49:36 INFO - PROCESS | 24118 | |5;yui.html;709.8189961559802;724.6304384763769;744.8696478116328;768.5849641193755;801.7033697531914;13438.798418023738;13481.191128532282;13948.02363834532;13959.790603140935;13968.161910285377;12812.359382030907;12862.03534734894;12873.806892896591;12884.42020109095;12896.41966111525;674.197704731368;784.7567254151231;807.6688557691348;828.0849661124461;835.5404527509876;774.7636970723927;781.562325097947;783.5847001089431;786.1862971824163;788.9644965976545;861.1173547114226;862.4394143806513;862.5945805471418;862.9266512346427;866;707.9858402831941;845.9873101903477;852.9147085291484;859.9742007739778;861.5562985062635;637.101686621861;642.8328634555003;646.9902951455732;647.4626060369882;647.7247169952798;13550.186988780606;13572.389242484112;13580.660483487893;13581.456741730319;13615.18308901469;12794.104412691115;13046.41291141901;13063.085584009123;13071.281079540622;13249.933750331284;9738.853917191247;9930.106290433823;9958.80082398348;10049.39703617778;10073.69778906634;3509.210427653783;3553.1650062235353;3556.608773034964;3578.4990101385565;3701.68535674468;49147.50852491501;49235.2614710776;49262.7536862317;49270.75364623154;49310.26034609484;9341.34610577253;9362.672306469241;9548;9564.473953932462;9735.318527702993;18362.08189590542;18404.907975460035;18430.17064232113;18527.166277517543;18579.628407432047;7359.742409015659;7527;7542.358899493604;7556.093268807778;7644.655990480442;3956.663683586927;4015.678745700337;4037.1723796621623;4047.392891066305;4099.077707515785;3069.3247485553143;3084.7686423518326;3095.9380812383624;3103.6896310369234;3103.953440698391;564.2495481010246;566.4222493057141;566.5694072504926;573.3549756523911;583.8306891001647;493.7457209537091;595.0895130450418;641.7400952614199;642.392938672959;658.8682263547214;8362.958185209034;8541.487510749375;8563.95718021406;8581.914180858237;8732.126787321216;535.8660334916271;551.2365373957098;554.4012466536132;561.3151954615363;602.7769725201616;3840.327942610088;3853.556840963325;3880;3942.72400931932;3944.1717239379477;52505.47494525006;52584.47415525796;52966.47033529692;53082;53164.20253696197;44892.10215795666;47520;47973.280400794014;48233.75883120562;49646.50353496491;41720.1655966879;41809.79095104505;42028;42275.77242275809;42629.78685106493;8067.112617611941;8084.110747817853;8447.577621119042;8589.312854971713;8616;33127.66872331246;33571.664283356855;33991.830040849636;35441.64558354383;35728.28543429169;41326.79336603298;41371.793141034104;43566.56433435625;43754;45788;10606.416647084485;10660.25378223517;11190.552377904793;11203.383813889988;11273.267237629529;11427.885721142682;11648.592299269485;12052;12087.377194115446;12272.81590776157;11093.944530277297;11113.055390291916;11558.07535397183;12050.156489046034;12196.51213951432;11495.252808567417;11688.415579221175;11765.705857353634;12147.514099435924;12157;8264.438680920817;10355.119814815826;10865.348079115278;10887.891121088687;11085.22403431752;9435.198008169382;9583;9685.9366314619;9922.751931201778;10233.283670143019;9730.22158227326;9787.461689606855;9932.801343973224;10016.849747253942;10152.39085654863 11:49:36 INFO - PROCESS | 24118 | __end_tp_report 11:49:36 INFO - PROCESS | 24118 | __start_cc_report 11:49:36 INFO - PROCESS | 24118 | _x_x_mozilla_cycle_collect,856 11:49:36 INFO - PROCESS | 24118 | __end_cc_report 11:49:36 INFO - PROCESS | 24118 | __startTimestamp1455824976597__endTimestamp 11:49:36 INFO - PROCESS | 24118 | 11:49:36 INFO - PROCESS | 24118 | ------- Summary: start ------- 11:49:36 INFO - PROCESS | 24118 | Number of tests: 6 11:49:36 INFO - PROCESS | 24118 | 11:49:36 INFO - PROCESS | 24118 | [#0] dojo.html Cycles:165 Average:5118.05 Median:5284.00 stddev:545.32 (10.3%) stddev-sans-first:524.31 11:49:36 INFO - PROCESS | 24118 | Values: 3134.1 3140.2 3182.2 3184.8 3223.7 4962.3 5047.3 5094.4 5108.6 5130.9 5130.5 5168.6 5185.2 5200.8 5216.5 4610.6 4675.1 4731.0 4788.2 4804.9 4601.0 4666.6 4760.9 4800.9 4831.9 4698.1 4729.7 4739.5 4741.5 4778.5 4701.9 4710.3 4723.0 4731.3 4748.1 4500.3 4666.3 4713.3 4725.7 4728.8 4965.9 4971.1 4996.6 4998.2 5013.8 5384.2 5515.1 5531.2 5531.3 5544.7 5491.4 5542.4 5571.4 5629.7 5658.1 5154.6 5164.9 5167.1 5173.4 5180.4 5511.6 5610.2 5612.1 5616.4 5621.8 5402.6 5423.8 5429.5 5441.8 5490.3 5436.3 5459.8 5466.9 5467.9 5489.5 5333.4 5408.4 5457.4 5467.6 5514.3 5507.7 5510.8 5515.5 5519.9 5556.6 4302.2 4306.9 4311.0 4334.8 4342.5 3794.8 3809.8 3858.9 3868.9 3881.0 5107.3 5133.4 5138.0 5139.3 5191.6 5456.8 5488.8 5492.1 5499.9 5511.8 4943.2 5026.3 5119.1 5170.7 5206.8 4677.2 4703.1 4707.9 4710.2 4735.5 5697.2 5711.9 5717.0 5745.8 5748.8 5413.3 5521.5 5521.8 5533.3 5589.9 5685.3 5717.8 5718.7 5719.5 5721.2 5344.0 5395.5 5415.2 5415.5 5429.2 5554.9 5558.5 5560.1 5561.7 5587.2 5385.6 5409.7 5412.9 5418.8 5478.0 5263.4 5284.0 5318.8 5364.0 5437.3 5280.0 5285.6 5293.9 5298.5 5303.8 5293.3 5391.9 5426.8 5438.1 5469.4 5216.5 5223.9 5233.9 5243.3 5277.2 11:49:36 INFO - PROCESS | 24118 | 11:49:36 INFO - PROCESS | 24118 | [#1] ext.html Cycles:180 Average:43295.47 Median:33372.50 stddev:69545.20 (208.4%) stddev-sans-first:69666.15 11:49:36 INFO - PROCESS | 24118 | Values: 526.4 548.2 567.9 588.6 595.2 35410.0 36114.1 36257.5 36288.8 36309.3 38958.4 39638.0 39669.8 39696.8 39728.6 8378.2 8571.4 8586.1 8595.7 8601.5 8717.2 8886.6 8887.6 8889.1 8892.2 8849.3 8966.8 8976.3 8976.6 8984.5 8798.7 8880.6 8880.9 8882.2 8893.2 8745.7 8814.8 8822.8 8841.2 8888.5 39716.2 40119.0 40220.8 40303.6 40331.6 3319.8 3833.2 4005.5 4017.9 4025.2 29445.7 29953.4 30063.0 30160.5 30964.2 3958.5 3980.6 4025.2 4056.4 4061.3 259450.0 259808.8 260020.0 260636.0 261466.0 60238.4 60478.4 60487.4 60611.0 60714.4 63225.7 63472.7 63587.4 63627.7 63692.0 16332.9 16393.0 16544.3 16549.1 16558.0 12134.5 12159.7 12185.8 12191.6 12198.3 18705.1 20215.7 20387.8 20447.2 20477.2 6605.6 7834.7 7979.2 8011.4 8029.2 894.9 917.3 941.6 992.0 1072.4 28195.7 29190.3 29248.7 29370.6 29570.3 1039.4 1074.6 1094.3 1099.5 1152.9 12008.8 14684.4 14838.6 15553.3 15799.7 324489.0 324558.0 325101.0 325850.0 325987.0 53954.0 54235.5 54243.7 54316.7 54397.0 1240.6 1349.4 1378.5 1381.7 1394.7 27617.7 28648.9 28811.6 28946.7 28993.6 40348.4 40359.0 40389.2 41078.4 41543.8 181291.0 199559.0 200760.0 200832.0 201194.0 27973.3 30660.0 31674.5 31700.5 31900.7 38219.2 38595.7 41960.6 42824.0 43351.6 32839.7 33043.3 33169.5 33266.5 33478.5 32129.7 32861.8 32992.7 33069.0 33168.8 32310.0 32433.4 32505.3 32517.5 32519.2 30536.0 31223.7 32578.8 32704.3 32731.5 24422.3 24594.4 24776.1 25163.7 25175.5 11:49:36 INFO - PROCESS | 24118 | 11:49:36 INFO - PROCESS | 24118 | [#2] jquery.html Cycles:180 Average:22151.79 Median:299722.00 stddev:53569.21 (17.9%) stddev-sans-first:53694.49 11:49:36 INFO - PROCESS | 24118 | Values: 353.9 359.9 364.5 364.7 365.9 13382.9 13607.8 16275.3 16585.7 17764.2 15439.2 16262.6 16576.6 16591.4 17114.9 5298.3 5510.8 5514.7 5525.3 5526.1 3992.8 5475.6 5530.9 5771.5 6178.3 5977.8 6005.0 6049.5 6055.7 6060.6 5836.9 5997.0 6003.2 6004.0 6016.0 5256.6 5272.4 5280.2 5349.3 5430.5 20674.4 20747.4 20998.6 21503.2 21534.0 2167.5 2207.5 2811.4 2816.2 3014.5 12499.8 13043.3 13067.3 13416.6 13502.8 1854.8 1904.3 1919.6 1926.7 1954.2 56532.4 58566.0 60048.7 60460.7 60502.1 9755.6 9973.6 10244.6 10257.8 10284.5 13475.5 13572.5 13572.6 13586.0 13600.2 7530.1 7588.0 7589.8 7899.4 7952.4 7365.6 7913.6 7920.6 7932.8 7954.0 5539.2 6018.8 6099.5 6198.3 6292.9 1679.2 1690.6 1744.6 1809.0 1810.7 819.2 882.2 884.1 912.7 964.6 13656.0 14571.8 16990.0 17005.7 17518.9 890.2 914.3 926.4 964.2 982.2 9484.9 9848.1 9855.3 9864.6 9913.6 297231.0 298401.0 301043.0 302869.0 409342.0 66468.3 67995.7 69707.3 70769.6 73216.6 1003.9 1044.4 1052.1 1054.9 1072.7 14206.6 14924.0 15147.8 15208.8 15282.2 31489.4 33829.2 34693.8 34846.5 35344.0 45135.3 45926.5 46169.8 49341.5 51230.7 10148.8 10710.1 10844.1 10885.3 11050.9 10174.9 12332.6 12450.8 12670.6 12806.6 10362.3 10492.3 10636.4 10739.8 10771.5 10742.5 10776.4 10949.8 11093.8 11211.7 7737.0 9374.6 10633.8 10811.4 11202.9 10904.2 10999.4 11018.3 11052.3 11173.0 9931.8 10090.1 10160.9 10290.3 10340.1 11:49:36 INFO - PROCESS | 24118 | 11:49:36 INFO - PROCESS | 24118 | [#3] mootools.html Cycles:180 Average:5187.75 Median:6358.15 stddev:2587.02 (40.7%) stddev-sans-first:2577.89 11:49:36 INFO - PROCESS | 24118 | Values: 1314.4 1455.4 1464.7 1629.7 1762.8 6701.8 7158.2 7315.5 7324.3 7349.7 7161.6 7335.9 7351.7 7359.9 7377.6 1933.7 2217.6 2233.5 2263.7 2265.5 2244.7 2287.8 2290.2 2292.7 2294.1 2218.5 2299.3 2304.9 2305.0 2305.7 2255.4 2273.0 2288.4 2297.6 2300.1 2246.4 2266.8 2298.4 2306.9 2313.9 7258.3 7313.9 7317.1 7330.7 7333.7 4570.9 4665.7 4672.4 4676.1 4679.3 2897.9 2926.9 2928.2 2943.8 3039.6 888.7 899.4 907.5 911.8 924.3 9526.5 9532.3 9606.7 9662.6 9672.2 4162.4 4172.2 4189.4 4235.6 4255.4 8485.8 8488.9 8498.7 8513.9 8530.3 4577.2 4602.8 4603.2 4605.1 4615.9 4162.9 4169.9 4171.1 4210.0 4214.8 3207.7 3364.4 3468.2 3524.4 3551.2 1149.7 1150.0 1167.4 1168.1 1173.3 1270.6 1295.1 1303.1 1345.1 1347.2 6847.5 6898.1 6901.2 6925.6 6934.3 1112.3 1114.9 1130.2 1132.3 1137.5 5531.8 5632.9 5637.3 5638.9 5650.1 8620.7 8652.4 8721.5 8839.8 8875.8 8697.2 8767.2 8767.6 8781.2 8787.5 6806.2 6988.9 6994.0 7051.0 7070.7 6544.5 6585.2 6595.7 6612.1 6673.5 7572.5 7791.1 7810.0 7836.6 7906.2 7986.2 7989.4 8023.8 8105.7 8174.5 6311.4 6730.8 7011.2 7096.4 7100.2 7026.2 7134.8 7195.2 7200.1 7201.2 6418.8 6456.5 6524.8 6641.4 6661.3 6404.9 6434.9 6479.6 6573.9 6608.5 6542.0 6566.7 6582.1 6586.1 6620.2 6142.3 6235.3 6240.5 6297.5 6302.2 6148.0 6164.3 6188.0 6204.1 6205.2 11:49:36 INFO - PROCESS | 24118 | 11:49:36 INFO - PROCESS | 24118 | [#4] prototype.html Cycles:180 Average:5253.00 Median:5886.53 stddev:1571.27 (26.7%) stddev-sans-first:1531.49 11:49:36 INFO - PROCESS | 24118 | Values: 322.7 333.8 338.1 338.7 345.0 5839.0 5859.9 5874.2 5883.0 5890.1 5575.9 5699.3 5756.2 5767.2 5821.7 4500.8 4502.5 4506.6 4514.3 4514.4 4367.5 4491.0 4497.6 4497.8 4503.7 4395.8 4510.8 4520.5 4525.0 4539.0 4502.2 4531.3 4532.2 4532.5 4535.1 4002.9 4007.7 4012.4 4014.7 4021.2 5476.4 5585.4 5602.4 5607.5 5608.3 5280.5 5285.3 5286.4 5289.9 5293.1 6188.7 6189.8 6193.5 6198.4 6206.1 4451.4 4453.3 4453.5 4464.9 4473.4 6305.1 6461.4 6463.7 6480.4 6481.7 4561.1 4561.8 4569.5 4573.2 4577.7 4620.7 4626.0 4627.1 4629.9 4630.7 5276.3 5277.3 5281.7 5287.8 5288.3 6000.0 6207.3 6210.3 6236.9 6240.3 1562.8 1584.3 1589.9 1590.1 1592.6 1047.1 1050.9 1064.8 1067.0 1074.4 6071.3 6077.2 6084.7 6086.3 6087.5 6574.9 6591.1 6595.3 6613.3 6613.4 5762.4 5863.8 5942.7 5969.6 5976.1 3509.3 3555.1 3556.2 3560.4 3562.7 6519.3 6651.5 6965.5 6966.8 6981.2 6665.0 6673.8 6685.9 6696.6 6705.2 6769.9 6801.7 6811.2 6813.3 6814.8 6321.7 6473.5 6475.4 6484.6 6515.1 6433.8 6442.0 6444.2 6445.0 6456.5 6741.4 6755.8 6759.6 6762.3 6818.5 4463.8 4540.5 4579.1 4579.5 4585.3 6379.2 6393.0 6395.5 6407.1 6408.7 6205.8 6213.9 6220.4 6220.6 6220.7 6021.1 6218.9 6223.4 6224.0 6238.3 6085.3 6087.1 6092.1 6096.6 6097.4 6278.5 6282.4 6283.7 6284.1 6287.2 5954.9 6104.1 6106.1 6121.8 6122.8 11:49:36 INFO - PROCESS | 24118 | 11:49:36 INFO - PROCESS | 24118 | [#5] yui.html Cycles:180 Average:13397.51 Median:47746.64 stddev:15123.29 (31.7%) stddev-sans-first:15135.70 11:49:36 INFO - PROCESS | 24118 | Values: 709.8 724.6 744.9 768.6 801.7 13438.8 13481.2 13948.0 13959.8 13968.2 12812.4 12862.0 12873.8 12884.4 12896.4 674.2 784.8 807.7 828.1 835.5 774.8 781.6 783.6 786.2 789.0 861.1 862.4 862.6 862.9 866.0 708.0 846.0 852.9 860.0 861.6 637.1 642.8 647.0 647.5 647.7 13550.2 13572.4 13580.7 13581.5 13615.2 12794.1 13046.4 13063.1 13071.3 13249.9 9738.9 9930.1 9958.8 10049.4 10073.7 3509.2 3553.2 3556.6 3578.5 3701.7 49147.5 49235.3 49262.8 49270.8 49310.3 9341.3 9362.7 9548.0 9564.5 9735.3 18362.1 18404.9 18430.2 18527.2 18579.6 7359.7 7527.0 7542.4 7556.1 7644.7 3956.7 4015.7 4037.2 4047.4 4099.1 3069.3 3084.8 3095.9 3103.7 3104.0 564.2 566.4 566.6 573.4 583.8 493.7 595.1 641.7 642.4 658.9 8363.0 8541.5 8564.0 8581.9 8732.1 535.9 551.2 554.4 561.3 602.8 3840.3 3853.6 3880.0 3942.7 3944.2 52505.5 52584.5 52966.5 53082.0 53164.2 44892.1 47520.0 47973.3 48233.8 49646.5 41720.2 41809.8 42028.0 42275.8 42629.8 8067.1 8084.1 8447.6 8589.3 8616.0 33127.7 33571.7 33991.8 35441.6 35728.3 41326.8 41371.8 43566.6 43754.0 45788.0 10606.4 10660.3 11190.6 11203.4 11273.3 11427.9 11648.6 12052.0 12087.4 12272.8 11093.9 11113.1 11558.1 12050.2 12196.5 11495.3 11688.4 11765.7 12147.5 12157.0 8264.4 10355.1 10865.3 10887.9 11085.2 9435.2 9583.0 9685.9 9922.8 10233.3 9730.2 9787.5 9932.8 10016.8 10152.4 11:49:36 INFO - PROCESS | 24118 | -------- Summary: end -------- 11:49:36 INFO - PROCESS | 24118 | 11:49:37 INFO - TEST-INFO | 24118: exit 0 11:49:37 INFO - TEST-OK | dromaeo_css | took 1113180ms 11:49:37 INFO - TEST-START | kraken 11:49:37 INFO - operating with platform_type : linux_ 11:49:37 INFO - Initialising browser for kraken test... 11:49:37 INFO - TEST-INFO | started process 24304 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpu52E5D/profile http://localhost:34918/getInfo.html) 11:49:41 INFO - PROCESS | 24304 | __metrics Screen width/height:1600/1200 11:49:41 INFO - PROCESS | 24304 | colorDepth:24 11:49:41 INFO - PROCESS | 24304 | Browser inner width/height: 1024/697 11:49:41 INFO - PROCESS | 24304 | __metrics 11:49:42 INFO - PROCESS | 24304 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:49:43 INFO - TEST-INFO | 24304: exit 0 11:49:43 INFO - Browser initialized. 11:49:43 INFO - Running cycle 1/1 for kraken test... 11:49:43 INFO - TEST-INFO | started process 24387 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpu52E5D/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:49:55 INFO - PROCESS | 24387 | RSS: Main: 147595264 11:49:55 INFO - PROCESS | 24387 | 11:49:57 INFO - PROCESS | 24387 | Cycle 1(1): loaded http://localhost:34918/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34918/tests/kraken/driver.html?testName=audio-beat-detection) 11:49:58 INFO - PROCESS | 24387 | RSS: Main: 192483328 11:49:58 INFO - PROCESS | 24387 | 11:50:00 INFO - PROCESS | 24387 | Cycle 1(1): loaded http://localhost:34918/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34918/tests/kraken/driver.html?testName=audio-dft) 11:50:01 INFO - PROCESS | 24387 | RSS: Main: 180183040 11:50:01 INFO - PROCESS | 24387 | 11:50:04 INFO - PROCESS | 24387 | Cycle 1(1): loaded http://localhost:34918/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34918/tests/kraken/driver.html?testName=audio-fft) 11:50:04 INFO - PROCESS | 24387 | RSS: Main: 164823040 11:50:04 INFO - PROCESS | 24387 | 11:50:07 INFO - PROCESS | 24387 | Cycle 1(1): loaded http://localhost:34918/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34918/tests/kraken/driver.html?testName=audio-oscillator) 11:50:07 INFO - PROCESS | 24387 | RSS: Main: 168394752 11:50:07 INFO - PROCESS | 24387 | 11:50:09 INFO - PROCESS | 24387 | Cycle 1(1): loaded http://localhost:34918/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34918/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:50:10 INFO - PROCESS | 24387 | RSS: Main: 169750528 11:50:10 INFO - PROCESS | 24387 | 11:50:13 INFO - PROCESS | 24387 | Cycle 1(1): loaded http://localhost:34918/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34918/tests/kraken/driver.html?testName=imaging-darkroom) 11:50:13 INFO - PROCESS | 24387 | RSS: Main: 168890368 11:50:13 INFO - PROCESS | 24387 | 11:50:17 INFO - PROCESS | 24387 | Cycle 1(1): loaded http://localhost:34918/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34918/tests/kraken/driver.html?testName=imaging-desaturate) 11:50:17 INFO - PROCESS | 24387 | RSS: Main: 169639936 11:50:17 INFO - PROCESS | 24387 | 11:50:20 INFO - PROCESS | 24387 | Cycle 1(1): loaded http://localhost:34918/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34918/tests/kraken/driver.html?testName=json-parse-financial) 11:50:21 INFO - PROCESS | 24387 | RSS: Main: 169721856 11:50:21 INFO - PROCESS | 24387 | 11:50:22 INFO - PROCESS | 24387 | Cycle 1(1): loaded http://localhost:34918/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34918/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:50:23 INFO - PROCESS | 24387 | RSS: Main: 181874688 11:50:23 INFO - PROCESS | 24387 | 11:50:25 INFO - PROCESS | 24387 | Cycle 1(1): loaded http://localhost:34918/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34918/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:50:25 INFO - PROCESS | 24387 | RSS: Main: 179781632 11:50:25 INFO - PROCESS | 24387 | 11:50:27 INFO - PROCESS | 24387 | Cycle 1(1): loaded http://localhost:34918/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34918/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:50:28 INFO - PROCESS | 24387 | RSS: Main: 189603840 11:50:28 INFO - PROCESS | 24387 | 11:50:30 INFO - PROCESS | 24387 | Cycle 1(1): loaded http://localhost:34918/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34918/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:50:31 INFO - PROCESS | 24387 | RSS: Main: 195305472 11:50:31 INFO - PROCESS | 24387 | 11:50:34 INFO - PROCESS | 24387 | Cycle 1(1): loaded http://localhost:34918/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34918/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:50:34 INFO - PROCESS | 24387 | RSS: Main: 194293760 11:50:34 INFO - PROCESS | 24387 | 11:50:36 INFO - PROCESS | 24387 | Cycle 1(1): loaded http://localhost:34918/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34918/tests/kraken/driver.html?testName=ai-astar) 11:50:36 INFO - PROCESS | 24387 | RSS: Main: 256393216 11:50:36 INFO - PROCESS | 24387 | 11:50:36 INFO - PROCESS | 24387 | __start_tp_report 11:50:36 INFO - PROCESS | 24387 | _x_x_mozilla_page_load 11:50:36 INFO - PROCESS | 24387 | _x_x_mozilla_page_load_details 11:50:36 INFO - PROCESS | 24387 | |i|pagename|runs| 11:50:36 INFO - PROCESS | 24387 | |0;ai-astar;110;112;109;113;116;113;102;111;111;112 11:50:36 INFO - PROCESS | 24387 | |1;audio-beat-detection;150;124;150;162;127;157;161;127;164;128 11:50:36 INFO - PROCESS | 24387 | |2;audio-dft;163;162;163;160;162;162;162;162;162;162 11:50:36 INFO - PROCESS | 24387 | |3;audio-fft;73;73;99;112;71;74;75;132;94;74 11:50:36 INFO - PROCESS | 24387 | |4;audio-oscillator;96;97;148;97;96;96;152;95;96;149 11:50:36 INFO - PROCESS | 24387 | |5;imaging-gaussian-blur;119;115;115;115;115;115;114;115;115;115 11:50:36 INFO - PROCESS | 24387 | |6;imaging-darkroom;145;145;145;145;145;146;146;145;145;146 11:50:36 INFO - PROCESS | 24387 | |7;imaging-desaturate;96;95;97;96;96;96;96;96;96;96 11:50:36 INFO - PROCESS | 24387 | |8;json-parse-financial;58;63;59;59;57;59;59;68;55;56 11:50:36 INFO - PROCESS | 24387 | |9;json-stringify-tinderbox;67;67;67;68;67;68;68;67;67;67 11:50:36 INFO - PROCESS | 24387 | |10;stanford-crypto-aes;83;83;83;90;86;83;82;83;82;84 11:50:36 INFO - PROCESS | 24387 | |11;stanford-crypto-ccm;124;120;122;124;119;118;118;119;117;123 11:50:36 INFO - PROCESS | 24387 | |12;stanford-crypto-pbkdf2;152;140;150;148;152;140;150;156;147;149 11:50:36 INFO - PROCESS | 24387 | |13;stanford-crypto-sha256-iterative;69;67;69;68;69;69;67;67;69;69 11:50:36 INFO - PROCESS | 24387 | __end_tp_report 11:50:36 INFO - PROCESS | 24387 | __start_cc_report 11:50:36 INFO - PROCESS | 24387 | _x_x_mozilla_cycle_collect,940 11:50:36 INFO - PROCESS | 24387 | __end_cc_report 11:50:36 INFO - PROCESS | 24387 | __startTimestamp1455825036579__endTimestamp 11:50:36 INFO - PROCESS | 24387 | 11:50:36 INFO - PROCESS | 24387 | ------- Summary: start ------- 11:50:36 INFO - PROCESS | 24387 | Number of tests: 14 11:50:36 INFO - PROCESS | 24387 | 11:50:36 INFO - PROCESS | 24387 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.00 stddev:3.67 (3.3%) stddev-sans-first:3.87 11:50:36 INFO - PROCESS | 24387 | Values: 110.0 112.0 109.0 113.0 116.0 113.0 102.0 111.0 111.0 112.0 11:50:36 INFO - PROCESS | 24387 | 11:50:36 INFO - PROCESS | 24387 | [#1] audio-beat-detection Cycles:10 Average:145.00 Median:153.50 stddev:16.59 (10.8%) stddev-sans-first:17.50 11:50:36 INFO - PROCESS | 24387 | Values: 150.0 124.0 150.0 162.0 127.0 157.0 161.0 127.0 164.0 128.0 11:50:36 INFO - PROCESS | 24387 | 11:50:36 INFO - PROCESS | 24387 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 11:50:36 INFO - PROCESS | 24387 | Values: 163.0 162.0 163.0 160.0 162.0 162.0 162.0 162.0 162.0 162.0 11:50:36 INFO - PROCESS | 24387 | 11:50:36 INFO - PROCESS | 24387 | [#3] audio-fft Cycles:10 Average:87.70 Median:74.00 stddev:21.00 (28.4%) stddev-sans-first:21.59 11:50:36 INFO - PROCESS | 24387 | Values: 73.0 73.0 99.0 112.0 71.0 74.0 75.0 132.0 94.0 74.0 11:50:36 INFO - PROCESS | 24387 | 11:50:36 INFO - PROCESS | 24387 | [#4] audio-oscillator Cycles:10 Average:112.20 Median:96.00 stddev:25.88 (27.0%) stddev-sans-first:26.78 11:50:36 INFO - PROCESS | 24387 | Values: 96.0 97.0 148.0 97.0 96.0 96.0 152.0 95.0 96.0 149.0 11:50:36 INFO - PROCESS | 24387 | 11:50:36 INFO - PROCESS | 24387 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:115.00 stddev:1.34 (1.2%) stddev-sans-first:0.33 11:50:36 INFO - PROCESS | 24387 | Values: 119.0 115.0 115.0 115.0 115.0 115.0 114.0 115.0 115.0 115.0 11:50:36 INFO - PROCESS | 24387 | 11:50:36 INFO - PROCESS | 24387 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 11:50:36 INFO - PROCESS | 24387 | Values: 145.0 145.0 145.0 145.0 145.0 146.0 146.0 145.0 145.0 146.0 11:50:36 INFO - PROCESS | 24387 | 11:50:36 INFO - PROCESS | 24387 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 11:50:36 INFO - PROCESS | 24387 | Values: 96.0 95.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 11:50:36 INFO - PROCESS | 24387 | 11:50:36 INFO - PROCESS | 24387 | [#8] json-parse-financial Cycles:10 Average:59.30 Median:59.00 stddev:3.74 (6.3%) stddev-sans-first:3.94 11:50:36 INFO - PROCESS | 24387 | Values: 58.0 63.0 59.0 59.0 57.0 59.0 59.0 68.0 55.0 56.0 11:50:36 INFO - PROCESS | 24387 | 11:50:36 INFO - PROCESS | 24387 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 11:50:36 INFO - PROCESS | 24387 | Values: 67.0 67.0 67.0 68.0 67.0 68.0 68.0 67.0 67.0 67.0 11:50:36 INFO - PROCESS | 24387 | 11:50:36 INFO - PROCESS | 24387 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:83.00 stddev:2.42 (2.9%) stddev-sans-first:2.55 11:50:36 INFO - PROCESS | 24387 | Values: 83.0 83.0 83.0 90.0 86.0 83.0 82.0 83.0 82.0 84.0 11:50:36 INFO - PROCESS | 24387 | 11:50:36 INFO - PROCESS | 24387 | [#11] stanford-crypto-ccm Cycles:10 Average:120.40 Median:121.00 stddev:2.63 (2.2%) stddev-sans-first:2.45 11:50:36 INFO - PROCESS | 24387 | Values: 124.0 120.0 122.0 124.0 119.0 118.0 118.0 119.0 117.0 123.0 11:50:36 INFO - PROCESS | 24387 | 11:50:36 INFO - PROCESS | 24387 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.40 Median:150.00 stddev:5.08 (3.4%) stddev-sans-first:5.22 11:50:36 INFO - PROCESS | 24387 | Values: 152.0 140.0 150.0 148.0 152.0 140.0 150.0 156.0 147.0 149.0 11:50:36 INFO - PROCESS | 24387 | 11:50:36 INFO - PROCESS | 24387 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:69.00 stddev:0.95 (1.4%) stddev-sans-first:0.97 11:50:36 INFO - PROCESS | 24387 | Values: 69.0 67.0 69.0 68.0 69.0 69.0 67.0 67.0 69.0 69.0 11:50:36 INFO - PROCESS | 24387 | -------- Summary: end -------- 11:50:36 INFO - PROCESS | 24387 | 11:50:37 INFO - TEST-INFO | 24387: exit 0 11:50:37 INFO - TEST-OK | kraken | took 60220ms 11:50:37 INFO - SUITE-END | took 1173s 11:50:37 INFO - Completed test suite (00:19:33) 11:50:37 INFO - Working with test: dromaeo_css 11:50:37 INFO - Generating results file: dromaeo_css 11:50:37 INFO - Working with test: kraken 11:50:37 INFO - Generating results file: kraken 11:50:37 INFO - javascript benchmark 11:50:37 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:50:37 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 11:50:37 INFO - process_Request line: dromaeo_css 6820.80 graph.html#tests=[[72,64,35]] 11:50:37 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:50:37 INFO - process_Request line: kraken 1522.00 graph.html#tests=[[232,64,35]] 11:50:37 INFO - RETURN: dromaeo_css: 6820.80 11:50:37 INFO - RETURN: kraken: 1522.00 11:50:37 INFO - javascript benchmark 11:50:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3134.05978206538, 3140.183552276407, 3182.2362632968093, 3184.79298845575, 3223.693749093836, 4962.305277261186, 5047.318611987381, 5094.439611642716, 5108.565771909392, 5130.9230361544605, 5130.538251557359, 5168.586513078954, 5185.222216667502, 5200.817971371002, 5216.504432078956, 4610.608098311631, 4675.135100006492, 4730.976345118287, 4788.209945359029, 4804.942912559231, 4601.033782905593, 4666.603338716213, 4760.857174284777, 4800.927986080212, 4831.879203019917, 4698.130845793505, 4729.739864307462, 4739.502352252998, 4741.454732705749, 4778.450478195, 4701.858944231679, 4710.26990816424, 4722.976385118087, 4731.313959475857, 4748.145333839908, 4500.257457519506, 4666.2767271073035, 4713.293006049086, 4725.740084295362, 4728.810847566127, 4965.925511117336, 4971.130052240844, 4996.600271978233, 4998.175301075318, 5013.824516141954, 5384.246205531229, 5515.117581187031, 5531.225628412026, 5531.3362396512275, 5544.667319960775, 5491.395946445888, 5542.362628297717, 5571.4150014248735, 5629.746661400247, 5658.122990936411, 5154.639175257696, 5164.870878228036, 5167.069927413102, 5173.3533308336455, 5180.4042535108565, 5511.614187006951, 5610.214569960209, 5612.102063669793, 5616.354119276336, 5621.80323688669, 5402.648827826179, 5423.810166644227, 5429.511343979061, 5441.809536666197, 5490.3411590609385, 5436.266104075899, 5459.808906688247, 5466.91799622998, 5467.917981230285, 5489.533389661923, 5333.439988801198, 5408.432114627986, 5457.372402173722, 5467.644603100865, 5514.338279406497, 5507.7246137692955, 5510.779568817283, 5515.503604675599, 5519.917201241985, 5556.555475561945, 4302.22559939214, 4306.935395969063, 4310.956890431055, 4334.848280310174, 4342.457192850894, 3794.8102594870147, 3809.8476060957805, 3858.884233473, 3868.903277418031, 3881.049142959993, 5107.284980102789, 5133.383993920679, 5138.0, 5139.254808052811, 5191.636585439059, 5456.781728730885, 5488.835334939959, 5492.1212605982855, 5499.890002199933, 5511.834644960658, 4943.184374578154, 5026.346574945307, 5119.078565858107, 5170.689758614495, 5206.817761378334, 4677.22825733757, 4703.129920964632, 4707.929381059287, 4710.24636058229, 4735.455422626442, 5697.202391665171, 5711.942880571224, 5716.971415142981, 5745.770169193185, 5748.770049198069, 5413.269208656781, 5521.475459831309, 5521.806736764194, 5533.253010843485, 5589.916151257653, 5685.346185188756, 5717.771289148387, 5718.714064296685, 5719.456651618089, 5721.1990321354215, 5344.038073146871, 5395.487428694268, 5415.182241710027, 5415.48552887475, 5429.239906413026, 5554.91667624994, 5558.499735023867, 5560.082586373203, 5561.749721262472, 5587.189857470563, 5385.649932754515, 5409.675419474844, 5412.864678383072, 5418.756155972912, 5478.04134276508, 5263.368395792376, 5284.0, 5318.840434786963, 5364.0, 5437.265969094122, 5279.973600131974, 5285.63000589955, 5293.9205911910585, 5298.496642818926, 5303.814366497154, 5293.2589437479555, 5391.865203369947, 5426.782928682808, 5438.075527160471, 5469.3983661797965, 5216.452272511332, 5223.895522089461, 5233.869153271199, 5243.265942767939, 5277.234800953764], "unit": "score", "name": "dojo.html", "value": 5084.531566605157}, {"lowerIsBetter": false, "replicates": [526.3657292961981, 548.1749966300716, 567.9432056794318, 588.6144575303176, 595.1875689683582, 35410.0, 36114.09714757126, 36257.46197766157, 36288.81855590725, 36309.273814523694, 38958.415623765664, 39638.0, 39669.80165099178, 39696.801515992454, 39728.602713972854, 8378.162183781618, 8571.442856214357, 8586.141385861427, 8595.742127736146, 8601.526916019617, 8717.171868672465, 8886.600102995348, 8887.644494220256, 8889.111088891124, 8892.244159246471, 8849.292056635486, 8966.775830604221, 8976.326775491832, 8976.640934362618, 8984.46093234408, 8798.736037918841, 8880.555972201364, 8880.8667869982, 8882.15619516145, 8893.199612034949, 8745.737627871174, 8814.779630509225, 8822.779430514225, 8841.248493878029, 8888.511131887744, 39716.20567588661, 40119.0, 40220.798896005625, 40303.59696403057, 40331.59668403308, 3319.8008119512906, 3833.21419109082, 4005.459262999487, 4017.879463616096, 4025.215083058805, 29445.70554294451, 29953.400931981458, 30063.0, 30160.54759178614, 30964.22589435282, 3958.524977002778, 3980.601939805996, 4025.2352053109817, 4056.4320995060716, 4061.3095773718537, 259450.0, 259808.80382392247, 260020.0, 260636.0, 261466.0, 60238.39761602328, 60478.395216047276, 60487.39512604818, 60611.0, 60714.392856071754, 63225.683871580346, 63472.68263658652, 63587.364126358145, 63627.6818615904, 63692.0, 16332.918335408247, 16393.0, 16544.255508502145, 16549.089800061112, 16558.0, 12134.514619415124, 12159.696007599881, 12185.817212741817, 12191.573294934813, 12198.268103913793, 18705.113773220426, 20215.696764548542, 20387.796122038886, 20447.182112715323, 20477.180912763324, 6605.636689982097, 7834.7257845976255, 7979.241972012649, 8011.359091272684, 8029.156938521488, 894.9060348663296, 917.3440989692402, 941.5904081724472, 992.0, 1072.3565860483802, 28195.71804281931, 29190.270243243664, 29248.707512924597, 29370.55944160839, 29570.260743481584, 1039.443897514826, 1074.5916551710457, 1094.2832444748703, 1099.483242875847, 1152.913531485142, 12008.819867701992, 14684.41262349494, 14838.554843354717, 15553.30010149546, 15799.68400632004, 324489.0, 324558.0, 325101.0, 325850.0, 325987.0, 53954.0, 54235.45764542383, 54243.72878135663, 54316.72841635766, 54397.0, 1240.6154092231436, 1349.419749507721, 1378.5244090788663, 1381.675306303018, 1394.7140836128367, 27617.723822761516, 28648.85675571609, 28811.5678264822, 28946.7105328944, 28993.56509652399, 40348.394774077824, 40359.0, 40389.1922161561, 41078.38382424326, 41543.792281038404, 181291.0, 199559.0, 200760.0, 200832.0, 201194.0, 27973.300667483476, 30660.0, 31674.524882126327, 31700.5244921331, 31900.6809931907, 38219.2356152881, 38595.68425894455, 41960.58039419567, 42824.0, 43351.566484334755, 32839.671603284616, 33043.33913321672, 33169.50245746267, 33266.501002484496, 33478.4978225322, 32129.67870321267, 32861.83569082139, 32992.67007329896, 33069.0, 33168.83415582906, 32310.0, 32433.351332972736, 32505.34989300248, 32517.512237316932, 32519.18702032468, 30536.0, 31223.687763122987, 32578.83710581432, 32704.345913081128, 32731.509027364133, 24422.26733198007, 24594.385140371633, 24776.132835350676, 25163.74836251614, 25175.49649007046], "unit": "score", "name": "ext.html", "value": 18161.204116681125}, {"lowerIsBetter": false, "replicates": [353.92567560812245, 359.93521166190084, 364.51883513761834, 364.67726062434735, 365.9085228692827, 13382.933085334584, 13607.795883061763, 16275.267612957416, 16585.66828663426, 17764.200610972523, 15439.150846703427, 16262.593435164126, 16576.58558536037, 16591.41930032449, 17114.914425427854, 5298.258243845855, 5510.752016159262, 5514.6691198528015, 5525.281713377275, 5526.143447765603, 3992.7803970781597, 5475.6440831346035, 5530.917036244459, 5771.451712087345, 6178.289496707869, 5977.820665380045, 6005.039193729004, 6049.48579370754, 6055.666938318391, 6060.606060606046, 5836.941630583682, 5997.010493268605, 6003.249593800775, 6004.039353703386, 6015.969920150393, 5256.553192978601, 5272.393674727378, 5280.20796880471, 5349.251104845324, 5430.511253987121, 20674.379768606967, 20747.377578672666, 20998.580028399498, 21503.247386341558, 21534.0, 2167.5014746608213, 2207.5033117548583, 2811.4096039831456, 2816.2114607909816, 3014.4724673182104, 12499.75000499994, 13043.282619455926, 13067.346632668328, 13416.597502074856, 13502.797458038138, 1854.7681539807525, 1904.3239649924355, 1919.577692907558, 1926.7109933509946, 1954.198778500822, 56532.43467565313, 58566.0, 60048.69975650094, 60460.69769651168, 60502.092468612565, 9755.609775609038, 9973.60105595768, 10244.641437549799, 10257.846132308021, 10284.485775711184, 13475.528356507475, 13572.524961626295, 13572.592822215349, 13586.0, 13600.183988960694, 7530.058742657168, 7588.0, 7589.772306830804, 7899.368050555941, 7952.443328967032, 7365.594892280976, 7913.604319783988, 7920.643571039317, 7932.762017139495, 7954.0, 5539.196816461671, 6018.8194354169445, 6099.481544068715, 6198.349173336825, 6292.874142517216, 1679.22755532454, 1690.6111594333127, 1744.633626938357, 1808.954776130581, 1810.7193385025341, 819.2301413369861, 882.2412725056446, 884.1335491218513, 912.7124955638952, 964.609333220047, 13656.0, 14571.781423278659, 16990.0, 17005.744913826304, 17518.912405438146, 890.2121622364255, 914.3188324698142, 926.416357694648, 964.216200029953, 982.1553464020936, 9484.905150948402, 9848.113669769755, 9855.31012829095, 9864.556094975744, 9913.553890074963, 297231.0, 298401.0, 301043.0, 302869.0, 409342.0, 66468.33531664718, 67995.66002169957, 69707.30292697008, 70769.64615176892, 73216.63391683008, 1003.8745156855393, 1044.3629386074338, 1052.1057101463848, 1054.857594224785, 1072.7157303314627, 14206.644833879236, 14924.0, 15147.772783408038, 15208.771868421762, 15282.159481228638, 31489.370212596077, 33829.154271143416, 34693.82653086718, 34846.47730284098, 35344.0, 45135.32297015613, 45926.54073459356, 46169.76915115403, 49341.50658493513, 51230.74384628053, 10148.847767283349, 10710.058583065578, 10844.132469402271, 10885.292455990651, 11050.889491105308, 10174.949125254623, 12332.568360107352, 12450.75098498043, 12670.556530521388, 12806.615801525597, 10362.326448780805, 10492.265541412027, 10636.41499717492, 10739.785204295715, 10771.51528181218, 10742.516586753458, 10776.407297598707, 10949.781004379709, 11093.778124437305, 11211.71970700739, 7737.0, 9374.625014999323, 10633.840492392466, 10811.35131892089, 11202.94398528002, 10904.182186335898, 10999.395033273247, 11018.338899666045, 11052.281601695864, 11172.994430501294, 9931.751706207402, 10090.09189172978, 10160.949195253976, 10290.279680422298, 10340.12108970746], "unit": "score", "name": "jquery.html", "value": 8611.985768406885}, {"lowerIsBetter": false, "replicates": [1314.38880920372, 1455.3669153918045, 1464.729025130351, 1629.6659184867103, 1762.814904435035, 6701.832454188648, 7158.248383919691, 7315.4879158458925, 7324.267573242673, 7349.669264883079, 7161.570305781656, 7335.8532829343385, 7351.66917488713, 7359.926400735991, 7377.59423231722, 1933.69060950248, 2217.5786600545925, 2233.519793244452, 2263.7396699379533, 2265.546890621874, 2244.674522194281, 2287.7712228777073, 2290.1526435218907, 2292.701948746669, 2294.128231272114, 2218.5341078373563, 2299.31020693792, 2304.8617082974993, 2304.9654255186188, 2305.7117860267467, 2255.4248666589997, 2273.0339605667527, 2288.370698058039, 2297.6438652008965, 2300.1259521381935, 2246.4383904023994, 2266.8073213776847, 2298.367948814073, 2306.919257825968, 2313.9305820825234, 7258.274172582753, 7313.926860731378, 7317.085364329459, 7330.743423980189, 7333.743318983863, 4570.9314360284625, 4665.650076244261, 4672.439307283148, 4676.134915040729, 4679.344891715163, 2897.884084636612, 2926.8682909268923, 2928.1947464447235, 2943.7792165587666, 3039.6352437707615, 888.7422647432302, 899.3704406915185, 907.4600612635471, 911.762941635173, 924.306769922558, 9526.523673816351, 9532.332736708433, 9606.711798646053, 9662.56518456671, 9672.22622190223, 4162.354835000579, 4172.186423647359, 4189.392538081961, 4235.618794308527, 4255.446791917031, 8485.787855303666, 8488.915110848937, 8498.66005359791, 8513.872291915626, 8530.317574594017, 4577.22187228172, 4602.7698615069785, 4603.240465323184, 4605.148047611203, 4615.861524154214, 4162.917641413254, 4169.854055108057, 4171.0615111599645, 4210.0, 4214.789260536961, 3207.7273431758563, 3364.444866597033, 3468.2023134679166, 3524.418470952264, 3551.2009797795804, 1149.747055647756, 1150.0454622663337, 1167.4279602994472, 1168.1005625668358, 1173.3253379306761, 1270.6442196185083, 1295.1322613848745, 1303.1008604063165, 1345.1458323964353, 1347.211881049597, 6847.520673552903, 6898.1377327834025, 6901.240863505011, 6925.58446493202, 6934.341237582422, 1112.2992514715677, 1114.912577327783, 1130.1862658885589, 1132.3375825142384, 1137.5165554639245, 5531.806386776443, 5632.887342253132, 5637.267155269788, 5638.915416268759, 5650.0959846424375, 8620.741377758677, 8652.3510736695, 8721.520316382659, 8839.779005524784, 8875.778105547413, 8697.21725044749, 8767.167119123673, 8767.605457754416, 8781.165789250012, 8787.516686582172, 6806.183258008971, 6988.895166572505, 6994.0, 7050.964745176241, 7070.71717131309, 6544.5418820684, 6585.209774827052, 6595.703193356215, 6612.107365505787, 6673.466122710269, 7572.507786993828, 7791.104023037423, 7810.0, 7836.647350869339, 7906.248906353887, 7986.161453047346, 7989.360851131779, 8023.799405014921, 8105.716299929474, 8174.468659537111, 6311.368863113652, 6730.764423245163, 7011.228764835762, 7096.396806271525, 7100.183478899992, 7026.156861176692, 7134.750283740044, 7195.244499327495, 7200.099987501562, 7201.207867134715, 6418.775342862978, 6456.451201647913, 6524.804255872332, 6641.402273795382, 6661.300563440769, 6404.935950640434, 6434.903476447951, 6479.643619600779, 6573.868522629617, 6608.471322294301, 6541.96729016371, 6566.737330506726, 6582.144321238208, 6586.077949087035, 6620.2386725527185, 6142.324344322032, 6235.314115447207, 6240.5319601031015, 6297.496200304056, 6302.243730752339, 6147.969260153671, 6164.260288765377, 6187.969060154671, 6204.13142160089, 6205.22434695663], "unit": "score", "name": "mootools.html", "value": 4321.490917464972}, {"lowerIsBetter": false, "replicates": [322.68215807429675, 333.7663635455182, 338.12931700870257, 338.7459405445916, 344.97930124192544, 5839.036558967776, 5859.853503662411, 5874.236349274599, 5882.970585147079, 5890.087036509342, 5575.944240557593, 5699.287589051369, 5756.194132821408, 5767.221425107609, 5821.650700957945, 4500.819967201308, 4502.5047244803045, 4506.571875671822, 4514.277715565502, 4514.435695538058, 4367.45406824147, 4491.034427598066, 4497.572730590588, 4497.7526236057, 4503.707259028152, 4395.824167033315, 4510.751908645039, 4520.480144783342, 4525.004499010229, 4539.046800171968, 4502.212112880249, 4531.3429552715, 4532.161550113223, 4532.4787649420405, 4535.070310586322, 4002.939955900664, 4007.6593489553425, 4012.4382586437923, 4014.7189696721243, 4021.2359651666384, 5476.397596264408, 5585.441455854423, 5602.411746766612, 5607.523360514361, 5608.327000759935, 5280.524752772269, 5285.286486324336, 5286.418493965661, 5289.947100528984, 5293.073712100367, 6188.721507532172, 6189.783357582463, 6193.473554747852, 6198.380161983766, 6206.131141640174, 4451.376807246956, 4453.287474004176, 4453.487848897385, 4464.910701785979, 4473.373727678128, 6305.0542418637115, 6461.3538646135485, 6463.74145034198, 6480.351964803529, 6481.74073037078, 4561.110583436264, 4561.817527298937, 4569.474510431343, 4573.222552166139, 4577.7482238477205, 4620.676552641283, 4625.976870115695, 4627.1439783640135, 4629.865682907709, 4630.6758526902795, 5276.34045744282, 5277.258504693519, 5281.656692314988, 5287.814926477555, 5288.338957630296, 5999.970000149971, 6207.317195108534, 6210.285817130997, 6236.937630623635, 6240.254288113216, 1562.7812106305125, 1584.3345794765996, 1589.8648614867634, 1590.0698091616302, 1592.6496170842397, 1047.073340094007, 1050.947452627381, 1064.8455973883742, 1067.0343339277965, 1074.382230217628, 6071.301800292935, 6077.20996270482, 6084.726187321581, 6086.330503644595, 6087.4521293083835, 6574.901376479356, 6591.143151390289, 6595.274519802818, 6613.272540020594, 6613.437857782143, 5762.394948530427, 5863.794767183128, 5942.70286485674, 5969.611975221596, 5976.133460648269, 3509.298140371885, 3555.1112221944513, 3556.1820781220463, 3560.359135355609, 3562.71498280137, 6519.348065193538, 6651.534392592472, 6965.5124141309625, 6966.756163534252, 6981.197162326296, 6664.966675166593, 6673.833154171185, 6685.899711504331, 6696.59820410777, 6705.161854768154, 6769.898451523231, 6801.693923773442, 6811.182658080963, 6813.250542440328, 6814.761483348059, 6321.715522801393, 6473.482121430368, 6475.352464753487, 6484.578502397329, 6515.0553169791065, 6433.839154021, 6441.967790161019, 6444.194475690539, 6445.0, 6456.515761317826, 6741.359570840762, 6755.831104222434, 6759.628220447923, 6762.289959554176, 6818.488613353919, 4463.821447142208, 4540.477845047862, 4579.06129243511, 4579.519150489151, 4585.266357382803, 6379.170707807955, 6392.968035159794, 6395.456386207225, 6407.135036769976, 6408.743650254124, 6205.751769929152, 6213.937860621336, 6220.440160385406, 6220.626762394271, 6220.720067596879, 6021.066734656135, 6218.875622487615, 6223.37766223374, 6224.035274532454, 6238.282597501164, 6085.300190478151, 6087.086936959491, 6092.055731361646, 6096.5732398733435, 6097.420745029215, 6278.46633036197, 6282.403171698681, 6283.71723272463, 6284.088807123033, 6287.245530536365, 5954.896231362888, 6104.11490333908, 6106.084087386927, 6121.816345509642, 6122.816315510542], "unit": "score", "name": "prototype.html", "value": 4742.116672457704}, {"lowerIsBetter": false, "replicates": [709.8189961559802, 724.6304384763769, 744.8696478116328, 768.5849641193755, 801.7033697531914, 13438.798418023738, 13481.191128532282, 13948.02363834532, 13959.790603140935, 13968.161910285377, 12812.359382030907, 12862.03534734894, 12873.806892896591, 12884.42020109095, 12896.41966111525, 674.197704731368, 784.7567254151231, 807.6688557691348, 828.0849661124461, 835.5404527509876, 774.7636970723927, 781.562325097947, 783.5847001089431, 786.1862971824163, 788.9644965976545, 861.1173547114226, 862.4394143806513, 862.5945805471418, 862.9266512346427, 866.0, 707.9858402831941, 845.9873101903477, 852.9147085291484, 859.9742007739778, 861.5562985062635, 637.101686621861, 642.8328634555003, 646.9902951455732, 647.4626060369882, 647.7247169952798, 13550.186988780606, 13572.389242484112, 13580.660483487893, 13581.456741730319, 13615.18308901469, 12794.104412691115, 13046.41291141901, 13063.085584009123, 13071.281079540622, 13249.933750331284, 9738.853917191247, 9930.106290433823, 9958.80082398348, 10049.39703617778, 10073.69778906634, 3509.210427653783, 3553.1650062235353, 3556.608773034964, 3578.4990101385565, 3701.68535674468, 49147.50852491501, 49235.2614710776, 49262.7536862317, 49270.75364623154, 49310.26034609484, 9341.34610577253, 9362.672306469241, 9548.0, 9564.473953932462, 9735.318527702993, 18362.08189590542, 18404.907975460035, 18430.17064232113, 18527.166277517543, 18579.628407432047, 7359.742409015659, 7527.0, 7542.358899493604, 7556.093268807778, 7644.655990480442, 3956.663683586927, 4015.678745700337, 4037.1723796621623, 4047.392891066305, 4099.077707515785, 3069.3247485553143, 3084.7686423518326, 3095.9380812383624, 3103.6896310369234, 3103.953440698391, 564.2495481010246, 566.4222493057141, 566.5694072504926, 573.3549756523911, 583.8306891001647, 493.7457209537091, 595.0895130450418, 641.7400952614199, 642.392938672959, 658.8682263547214, 8362.958185209034, 8541.487510749375, 8563.95718021406, 8581.914180858237, 8732.126787321216, 535.8660334916271, 551.2365373957098, 554.4012466536132, 561.3151954615363, 602.7769725201616, 3840.327942610088, 3853.556840963325, 3880.0, 3942.72400931932, 3944.1717239379477, 52505.47494525006, 52584.47415525796, 52966.47033529692, 53082.0, 53164.20253696197, 44892.10215795666, 47520.0, 47973.280400794014, 48233.75883120562, 49646.50353496491, 41720.1655966879, 41809.79095104505, 42028.0, 42275.77242275809, 42629.78685106493, 8067.112617611941, 8084.110747817853, 8447.577621119042, 8589.312854971713, 8616.0, 33127.66872331246, 33571.664283356855, 33991.830040849636, 35441.64558354383, 35728.28543429169, 41326.79336603298, 41371.793141034104, 43566.56433435625, 43754.0, 45788.0, 10606.416647084485, 10660.25378223517, 11190.552377904793, 11203.383813889988, 11273.267237629529, 11427.885721142682, 11648.592299269485, 12052.0, 12087.377194115446, 12272.81590776157, 11093.944530277297, 11113.055390291916, 11558.07535397183, 12050.156489046034, 12196.51213951432, 11495.252808567417, 11688.415579221175, 11765.705857353634, 12147.514099435924, 12157.0, 8264.438680920817, 10355.119814815826, 10865.348079115278, 10887.891121088687, 11085.22403431752, 9435.198008169382, 9583.0, 9685.9366314619, 9922.751931201778, 10233.283670143019, 9730.22158227326, 9787.461689606855, 9932.801343973224, 10016.849747253942, 10152.39085654863], "unit": "score", "name": "yui.html", "value": 6178.26823489182}], "name": "dromaeo_css", "value": 6820.799174970075}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 109.0, 113.0, 116.0, 113.0, 102.0, 111.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [150.0, 124.0, 150.0, 162.0, 127.0, 157.0, 161.0, 127.0, 164.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 145.0}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 163.0, 160.0, 162.0, 162.0, 162.0, 162.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.0}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 99.0, 112.0, 71.0, 74.0, 75.0, 132.0, 94.0, 74.0], "unit": "score", "name": "audio-fft", "value": 87.7}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 148.0, 97.0, 96.0, 96.0, 152.0, 95.0, 96.0, 149.0], "unit": "score", "name": "audio-oscillator", "value": 112.2}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 115.0, 115.0, 115.0, 115.0, 114.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.3}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [58.0, 63.0, 59.0, 59.0, 57.0, 59.0, 59.0, 68.0, 55.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 59.3}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 68.0, 67.0, 68.0, 68.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.3}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 83.0, 90.0, 86.0, 83.0, 82.0, 83.0, 82.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.9}, {"lowerIsBetter": true, "replicates": [124.0, 120.0, 122.0, 124.0, 119.0, 118.0, 118.0, 119.0, 117.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.4}, {"lowerIsBetter": true, "replicates": [152.0, 140.0, 150.0, 148.0, 152.0, 140.0, 150.0, 156.0, 147.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.4}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 69.0, 68.0, 69.0, 69.0, 67.0, 67.0, 69.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.3}], "name": "kraken", "value": 1522.0}]} 11:50:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1522.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6820.80"}}} 11:50:37 INFO - Return code: 0 11:50:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:50:37 INFO - # TBPL SUCCESS # 11:50:37 INFO - Running post-action listener: _resource_record_post_action 11:50:37 INFO - Running post-run listener: _resource_record_post_run 11:50:39 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 537276416; Read time: 0; Write time: 474044 11:50:39 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 239964160; Read time: 0; Write time: 249948 11:50:39 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 296714240; Read time: 0; Write time: 224096 11:50:39 INFO - Running post-run listener: _upload_blobber_files 11:50:39 INFO - Blob upload gear active. 11:50:39 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:50:39 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 11:50:39 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'] 11:50:39 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 11:50:39 INFO - (blobuploader) - INFO - Open directory for files ... 11:50:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:50:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:50:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:50:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:50:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:50:40 INFO - (blobuploader) - INFO - Done attempting. 11:50:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 11:50:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:50:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:50:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:50:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:50:41 INFO - (blobuploader) - INFO - Done attempting. 11:50:41 INFO - (blobuploader) - INFO - Iteration through files over. 11:50:41 INFO - Return code: 0 11:50:41 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:50:41 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:50:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/617d7f46a04f72be294ffd488b7c8bb0c1f5cf68ecaaba49adb9de92799526e07f231f8f6c9c321a3e4b5606ad3c243594466de4b2263f8b1ce51f53311681c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8502118807c314f406f62f70a5f1663d97feb2c232ee266e4312910785871f98870227f5b628c54e54c5146060bad6a618c2657f31a59ea45a40890e03ab7c6f"} 11:50:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:50:41 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:50:41 INFO - Contents: 11:50:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/617d7f46a04f72be294ffd488b7c8bb0c1f5cf68ecaaba49adb9de92799526e07f231f8f6c9c321a3e4b5606ad3c243594466de4b2263f8b1ce51f53311681c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8502118807c314f406f62f70a5f1663d97feb2c232ee266e4312910785871f98870227f5b628c54e54c5146060bad6a618c2657f31a59ea45a40890e03ab7c6f"} 11:50:41 INFO - Running post-run listener: copy_logs_to_upload_dir 11:50:41 INFO - Copying logs to upload dir... 11:50:41 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 11:50:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.811683 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-02-18 11:50:40.735882) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-18 11:50:40.739915) ========= 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=920470bf432669ad7e3a5387000001ca-1455821219.133220-1870499538 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/617d7f46a04f72be294ffd488b7c8bb0c1f5cf68ecaaba49adb9de92799526e07f231f8f6c9c321a3e4b5606ad3c243594466de4b2263f8b1ce51f53311681c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8502118807c314f406f62f70a5f1663d97feb2c232ee266e4312910785871f98870227f5b628c54e54c5146060bad6a618c2657f31a59ea45a40890e03ab7c6f"} build_url:https://queue.taskcluster.net/v1/task/Iu5urIbJTciIZcCGE1q6ug/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011237 build_url: 'https://queue.taskcluster.net/v1/task/Iu5urIbJTciIZcCGE1q6ug/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/617d7f46a04f72be294ffd488b7c8bb0c1f5cf68ecaaba49adb9de92799526e07f231f8f6c9c321a3e4b5606ad3c243594466de4b2263f8b1ce51f53311681c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8502118807c314f406f62f70a5f1663d97feb2c232ee266e4312910785871f98870227f5b628c54e54c5146060bad6a618c2657f31a59ea45a40890e03ab7c6f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-18 11:50:40.767509) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 11:50:40.767998) ========= 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=920470bf432669ad7e3a5387000001ca-1455821219.133220-1870499538 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004621 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 11:50:40.853258) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-18 11:50:40.853586) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-18 11:50:40.853898) ========= ========= Total master_lag: 0.31 =========