builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-018 starttime: 1456784200.84 results: success (0) buildid: 20160229113753 builduid: 47e1b885fdba4c11abdd2f48b8c42990 revision: 04634ec900b2fb94962733148ecdeac7ae98e0e2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 14:16:40.844678) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 14:16:40.845227) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 14:16:40.845578) ========= 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=62c568580acbfdaac3eec7be000001dc-1456784199.979327-1473393899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005988 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 14:16:40.872686) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 14:16:40.873091) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 14:16:40.898820) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 14:16:40.899546) ========= 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=62c568580acbfdaac3eec7be000001dc-1456784199.979327-1473393899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.029978 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 14:16:40.949422) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 14:16:40.949795) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 14:16:40.950267) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 14:16:40.950615) ========= 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=62c568580acbfdaac3eec7be000001dc-1456784199.979327-1473393899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-29 14:16:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.8M=0s 2016-02-29 14:16:41 (34.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164230 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 14:16:41.130868) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 14:16:41.131694) ========= 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=62c568580acbfdaac3eec7be000001dc-1456784199.979327-1473393899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.090835 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 14:16:41.236492) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 14:16:41.237469) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 04634ec900b2fb94962733148ecdeac7ae98e0e2 --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 04634ec900b2fb94962733148ecdeac7ae98e0e2 --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=62c568580acbfdaac3eec7be000001dc-1456784199.979327-1473393899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-29 14:16:41,258 truncating revision to first 12 chars 2016-02-29 14:16:41,258 Setting DEBUG logging. 2016-02-29 14:16:41,258 attempt 1/10 2016-02-29 14:16:41,258 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/04634ec900b2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-29 14:16:41,842 unpacking tar archive at: fx-team-04634ec900b2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.910824 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 14:16:42.167302) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 14:16:42.167721) ========= echo 04634ec900b2fb94962733148ecdeac7ae98e0e2 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'04634ec900b2fb94962733148ecdeac7ae98e0e2'] 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=62c568580acbfdaac3eec7be000001dc-1456784199.979327-1473393899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04634ec900b2fb94962733148ecdeac7ae98e0e2 program finished with exit code 0 elapsedTime=0.004652 script_repo_revision: '04634ec900b2fb94962733148ecdeac7ae98e0e2' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 14:16:42.221749) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 14:16:42.222111) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 14:16:42.232261) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-02-29 14:16:42.232728) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=62c568580acbfdaac3eec7be000001dc-1456784199.979327-1473393899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:16:42 INFO - MultiFileLogger online at 20160229 14:16:42 in /builds/slave/test-pgo 14:16:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:16:42 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:16:42 INFO - {'append_to_log': False, 14:16:42 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:16:42 INFO - 'blob_upload_branch': 'Fx-Team', 14:16:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:16:42 INFO - 'branch': 'Fx-Team', 14:16:42 INFO - 'buildbot_json_path': 'buildprops.json', 14:16:42 INFO - 'config_files': ('talos/linux_config.py',), 14:16:42 INFO - 'default_actions': ('clobber', 14:16:42 INFO - 'read-buildbot-config', 14:16:42 INFO - 'download-and-extract', 14:16:42 INFO - 'populate-webroot', 14:16:42 INFO - 'create-virtualenv', 14:16:42 INFO - 'install', 14:16:42 INFO - 'run-tests'), 14:16:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:16:42 INFO - 'download_minidump_stackwalk': True, 14:16:42 INFO - 'download_symbols': 'ondemand', 14:16:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:16:42 INFO - 'tooltool.py': '/tools/tooltool.py', 14:16:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:16:42 INFO - '/tools/misc-python/virtualenv.py')}, 14:16:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:16:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:16:42 INFO - 'installer_path': 'installer.exe', 14:16:42 INFO - 'log_level': 'info', 14:16:42 INFO - 'log_name': 'talos', 14:16:42 INFO - 'log_to_console': True, 14:16:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:16:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:16:42 INFO - 'opt_config_files': (), 14:16:42 INFO - 'pip_index': False, 14:16:42 INFO - 'sps_profile': False, 14:16:42 INFO - 'sps_profile_interval': 0, 14:16:42 INFO - 'suite': 'dromaeojs-e10s', 14:16:42 INFO - 'system_bits': '32', 14:16:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:16:42 INFO - 'title': 'talos-linux64-ix-018', 14:16:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:16:42 INFO - 'use_talos_json': True, 14:16:42 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:16:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:16:42 INFO - 'work_dir': 'build'} 14:16:42 INFO - ##### 14:16:42 INFO - ##### Running clobber step. 14:16:42 INFO - ##### 14:16:42 INFO - Running pre-action listener: _resource_record_pre_action 14:16:42 INFO - Running main action method: clobber 14:16:42 INFO - rmtree: /builds/slave/test-pgo/build 14:16:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:16:46 INFO - Running post-action listener: _resource_record_post_action 14:16:46 INFO - ##### 14:16:46 INFO - ##### Running read-buildbot-config step. 14:16:46 INFO - ##### 14:16:46 INFO - Running pre-action listener: _resource_record_pre_action 14:16:46 INFO - Running main action method: read_buildbot_config 14:16:46 INFO - Using buildbot properties: 14:16:46 INFO - { 14:16:46 INFO - "project": "", 14:16:46 INFO - "product": "firefox", 14:16:46 INFO - "script_repo_revision": "production", 14:16:46 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:16:46 INFO - "repository": "", 14:16:46 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 14:16:46 INFO - "buildid": "20160229113753", 14:16:46 INFO - "pgo_build": "True", 14:16:46 INFO - "basedir": "/builds/slave/test-pgo", 14:16:46 INFO - "buildnumber": 305, 14:16:46 INFO - "slavename": "talos-linux64-ix-018", 14:16:46 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:16:46 INFO - "platform": "ubuntu64_hw", 14:16:46 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:16:46 INFO - "branch": "fx-team", 14:16:46 INFO - "repo_path": "integration/fx-team", 14:16:46 INFO - "revision": "04634ec900b2fb94962733148ecdeac7ae98e0e2", 14:16:46 INFO - "stage_platform": "linux64-pgo", 14:16:46 INFO - "builduid": "47e1b885fdba4c11abdd2f48b8c42990", 14:16:46 INFO - "slavebuilddir": "test" 14:16:46 INFO - } 14:16:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ef30RNz6R1WmGSRwmhtfvQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 14:16:46 INFO - Running post-action listener: _resource_record_post_action 14:16:46 INFO - ##### 14:16:46 INFO - ##### Running download-and-extract step. 14:16:46 INFO - ##### 14:16:46 INFO - Running pre-action listener: _resource_record_pre_action 14:16:46 INFO - Running main action method: download_and_extract 14:16:46 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:46 INFO - https://queue.taskcluster.net/v1/task/Ef30RNz6R1WmGSRwmhtfvQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:16:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef30RNz6R1WmGSRwmhtfvQ/artifacts/public/build/test_packages.json 14:16:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef30RNz6R1WmGSRwmhtfvQ/artifacts/public/build/test_packages.json 14:16:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef30RNz6R1WmGSRwmhtfvQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 14:16:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef30RNz6R1WmGSRwmhtfvQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 14:16:47 INFO - Downloaded 1448 bytes. 14:16:47 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 14:16:47 INFO - Using the following test package requirements: 14:16:47 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 14:16:47 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:16:47 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:16:47 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:16:47 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:16:47 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:16:47 INFO - u'jsshell-linux-x86_64.zip'], 14:16:47 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:16:47 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:16:47 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 14:16:47 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:16:47 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:16:47 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:16:47 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:16:47 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:16:47 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:16:47 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 14:16:47 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:16:47 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:16:47 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:47 INFO - https://queue.taskcluster.net/v1/task/Ef30RNz6R1WmGSRwmhtfvQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:16:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef30RNz6R1WmGSRwmhtfvQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:16:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef30RNz6R1WmGSRwmhtfvQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:16:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef30RNz6R1WmGSRwmhtfvQ/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 14:16:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef30RNz6R1WmGSRwmhtfvQ/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 14:16:48 INFO - Downloaded 23372317 bytes. 14:16:48 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'] 14:16:48 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 14:16:49 INFO - Return code: 0 14:16:49 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 14:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:49 INFO - https://queue.taskcluster.net/v1/task/Ef30RNz6R1WmGSRwmhtfvQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:16:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef30RNz6R1WmGSRwmhtfvQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:16:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef30RNz6R1WmGSRwmhtfvQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:16:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef30RNz6R1WmGSRwmhtfvQ/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 14:16:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef30RNz6R1WmGSRwmhtfvQ/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 14:16:50 INFO - Downloaded 23372317 bytes. 14:16:50 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'] 14:16:50 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 14:16:52 INFO - Return code: 0 14:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:52 INFO - https://queue.taskcluster.net/v1/task/Ef30RNz6R1WmGSRwmhtfvQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:16:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef30RNz6R1WmGSRwmhtfvQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 14:16:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef30RNz6R1WmGSRwmhtfvQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 14:16:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef30RNz6R1WmGSRwmhtfvQ/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 14:16:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef30RNz6R1WmGSRwmhtfvQ/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 14:16:53 INFO - Downloaded 10713410 bytes. 14:16:53 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'] 14:16:53 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 14:16:53 INFO - Return code: 0 14:16:53 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')]} 14:16:53 INFO - https://queue.taskcluster.net/v1/task/Ef30RNz6R1WmGSRwmhtfvQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:16:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef30RNz6R1WmGSRwmhtfvQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:16:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef30RNz6R1WmGSRwmhtfvQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:16:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef30RNz6R1WmGSRwmhtfvQ/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 14:16:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef30RNz6R1WmGSRwmhtfvQ/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 14:16:54 INFO - Downloaded 56586186 bytes. 14:16:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ef30RNz6R1WmGSRwmhtfvQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:16:54 INFO - mkdir: /builds/slave/test-pgo/properties 14:16:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:16:54 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:16:54 INFO - Contents: 14:16:54 INFO - build_url:https://queue.taskcluster.net/v1/task/Ef30RNz6R1WmGSRwmhtfvQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:16:55 INFO - Running post-action listener: _resource_record_post_action 14:16:55 INFO - Running post-action listener: set_extra_try_arguments 14:16:55 INFO - ##### 14:16:55 INFO - ##### Running populate-webroot step. 14:16:55 INFO - ##### 14:16:55 INFO - Running pre-action listener: _resource_record_pre_action 14:16:55 INFO - Running main action method: populate_webroot 14:16:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:16:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:16:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:16:55 INFO - '--tppagecycles', 14:16:55 INFO - '7'], 14:16:55 INFO - 'tests': ['tsvgm']}}, 14:16:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:16:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:16:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:16:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:16:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:16:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:16:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:16:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:55 INFO - 'talos_options': ['--e10s'], 14:16:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:16:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:55 INFO - 'tests': ['damp', 'tps']}, 14:16:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:55 INFO - 'talos_options': ['--e10s'], 14:16:55 INFO - 'tests': ['damp', 'tps']}, 14:16:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:16:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:16:55 INFO - 'other': {'tests': ['a11yr', 14:16:55 INFO - 'ts_paint', 14:16:55 INFO - 'tpaint', 14:16:55 INFO - 'sessionrestore', 14:16:55 INFO - 'sessionrestore_no_auto_restore']}, 14:16:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:16:55 INFO - 'tests': ['a11yr', 14:16:55 INFO - 'ts_paint', 14:16:55 INFO - 'tpaint', 14:16:55 INFO - 'sessionrestore', 14:16:55 INFO - 'sessionrestore_no_auto_restore']}, 14:16:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:16:55 INFO - 'tests': ['a11yr', 14:16:55 INFO - 'ts_paint', 14:16:55 INFO - 'tpaint', 14:16:55 INFO - 'sessionrestore', 14:16:55 INFO - 'sessionrestore_no_auto_restore']}, 14:16:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:16:55 INFO - 'tests': ['a11yr', 14:16:55 INFO - 'ts_paint', 14:16:55 INFO - 'tpaint', 14:16:55 INFO - 'sessionrestore', 14:16:55 INFO - 'sessionrestore_no_auto_restore']}, 14:16:55 INFO - 'other_l64': {'tests': ['a11yr', 14:16:55 INFO - 'ts_paint', 14:16:55 INFO - 'tpaint', 14:16:55 INFO - 'sessionrestore', 14:16:55 INFO - 'sessionrestore_no_auto_restore']}, 14:16:55 INFO - 'other_nol64': {'tests': ['a11yr', 14:16:55 INFO - 'ts_paint', 14:16:55 INFO - 'tpaint', 14:16:55 INFO - 'sessionrestore', 14:16:55 INFO - 'sessionrestore_no_auto_restore']}, 14:16:55 INFO - 'svgr': {'tests': ['tsvgx', 14:16:55 INFO - 'tsvgr_opacity', 14:16:55 INFO - 'tart', 14:16:55 INFO - 'tscrollx', 14:16:55 INFO - 'cart']}, 14:16:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:16:55 INFO - 'tests': ['tsvgx', 14:16:55 INFO - 'tsvgr_opacity', 14:16:55 INFO - 'tart', 14:16:55 INFO - 'tscrollx', 14:16:55 INFO - 'cart']}, 14:16:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:55 INFO - 'tests': ['tp5o']}, 14:16:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:55 INFO - 'talos_options': ['--e10s'], 14:16:55 INFO - 'tests': ['tp5o']}, 14:16:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:55 INFO - 'talos_options': ['--xperf_path', 14:16:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:16:55 INFO - 'tests': ['tp5n']}, 14:16:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:55 INFO - 'talos_options': ['--e10s', 14:16:55 INFO - '--xperf_path', 14:16:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:16:55 INFO - 'tests': ['tp5n']}}, 14:16:55 INFO - 'talos.zip': {'path': '', 14:16:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:16:55 INFO - Running post-action listener: _resource_record_post_action 14:16:55 INFO - ##### 14:16:55 INFO - ##### Running create-virtualenv step. 14:16:55 INFO - ##### 14:16:55 INFO - Running pre-action listener: _resource_record_pre_action 14:16:55 INFO - Running main action method: create_virtualenv 14:16:55 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:16:55 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 14:16:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:16:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:16:55 INFO - Using real prefix '/usr' 14:16:55 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:16:55 INFO - Installing distribute.............................................................................................................................................................................................done. 14:16:57 INFO - Installing pip.................done. 14:16:57 INFO - Return code: 0 14:16:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:57 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 0x7fb10c198f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b44670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd38c0>, '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 0x1bd47c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd4c50>, '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': '62c568580acbfdaac3eec7be000001dc-1456784199.979327-1473393899', '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 14:16:57 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 14:16:57 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 14:16:57 INFO - Using env: {'DISPLAY': ':0', 14:16:57 INFO - 'HOME': '/home/cltbld', 14:16:57 INFO - 'LANG': 'en_US.UTF-8', 14:16:57 INFO - 'LANGUAGE': 'en_US:en', 14:16:57 INFO - 'LOGNAME': 'cltbld', 14:16:57 INFO - 'MAIL': '/var/mail/cltbld', 14:16:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:57 INFO - 'MOZ_NO_REMOTE': '1', 14:16:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:16:57 INFO - 'NO_EM_RESTART': '1', 14:16:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:16:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:16:57 INFO - 'PWD': '/builds/slave/test-pgo', 14:16:57 INFO - 'SHELL': '/bin/bash', 14:16:57 INFO - 'SHLVL': '1', 14:16:57 INFO - 'TERM': 'linux', 14:16:57 INFO - 'TMOUT': '86400', 14:16:57 INFO - 'USER': 'cltbld', 14:16:57 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1456784199.979327-1473393899', 14:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:57 INFO - '_': '/tools/buildbot/bin/python'} 14:16:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:58 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 14:16:58 INFO - Cleaning up... 14:16:58 INFO - Return code: 0 14:16:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:16:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb10c198f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b44670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd38c0>, '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 0x1bd47c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd4c50>, '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': '62c568580acbfdaac3eec7be000001dc-1456784199.979327-1473393899', '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 14:16:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 14:16:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:16:58 INFO - Using env: {'DISPLAY': ':0', 14:16:58 INFO - 'HOME': '/home/cltbld', 14:16:58 INFO - 'LANG': 'en_US.UTF-8', 14:16:58 INFO - 'LANGUAGE': 'en_US:en', 14:16:58 INFO - 'LOGNAME': 'cltbld', 14:16:58 INFO - 'MAIL': '/var/mail/cltbld', 14:16:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:58 INFO - 'MOZ_NO_REMOTE': '1', 14:16:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:16:58 INFO - 'NO_EM_RESTART': '1', 14:16:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:16:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:16:58 INFO - 'PWD': '/builds/slave/test-pgo', 14:16:58 INFO - 'SHELL': '/bin/bash', 14:16:58 INFO - 'SHLVL': '1', 14:16:58 INFO - 'TERM': 'linux', 14:16:58 INFO - 'TMOUT': '86400', 14:16:58 INFO - 'USER': 'cltbld', 14:16:58 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1456784199.979327-1473393899', 14:16:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:58 INFO - '_': '/tools/buildbot/bin/python'} 14:16:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:58 INFO - Downloading/unpacking psutil>=0.7.1 14:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:16:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:16:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:16:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:16:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:17:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:17:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:17:00 INFO - Installing collected packages: psutil 14:17:00 INFO - Running setup.py install for psutil 14:17:00 INFO - building 'psutil._psutil_linux' extension 14:17:00 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 14:17:00 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 14:17:00 INFO - building 'psutil._psutil_posix' extension 14:17:00 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 14:17:00 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 14:17:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:17:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:17:00 INFO - Successfully installed psutil 14:17:00 INFO - Cleaning up... 14:17:00 INFO - Return code: 0 14:17:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:17:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb10c198f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b44670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd38c0>, '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 0x1bd47c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd4c50>, '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': '62c568580acbfdaac3eec7be000001dc-1456784199.979327-1473393899', '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 14:17:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 14:17:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:17:00 INFO - Using env: {'DISPLAY': ':0', 14:17:00 INFO - 'HOME': '/home/cltbld', 14:17:00 INFO - 'LANG': 'en_US.UTF-8', 14:17:00 INFO - 'LANGUAGE': 'en_US:en', 14:17:00 INFO - 'LOGNAME': 'cltbld', 14:17:00 INFO - 'MAIL': '/var/mail/cltbld', 14:17:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:00 INFO - 'MOZ_NO_REMOTE': '1', 14:17:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:00 INFO - 'NO_EM_RESTART': '1', 14:17:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:17:00 INFO - 'PWD': '/builds/slave/test-pgo', 14:17:00 INFO - 'SHELL': '/bin/bash', 14:17:00 INFO - 'SHLVL': '1', 14:17:00 INFO - 'TERM': 'linux', 14:17:00 INFO - 'TMOUT': '86400', 14:17:00 INFO - 'USER': 'cltbld', 14:17:00 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1456784199.979327-1473393899', 14:17:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:00 INFO - '_': '/tools/buildbot/bin/python'} 14:17:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:17:01 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 14:17:01 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 14:17:01 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 14:17:01 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 14:17:01 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 14:17:01 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 14:17:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:17:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:17:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:17:02 INFO - Installing collected packages: mozsystemmonitor 14:17:02 INFO - Running setup.py install for mozsystemmonitor 14:17:03 INFO - Successfully installed mozsystemmonitor 14:17:03 INFO - Cleaning up... 14:17:03 INFO - Return code: 0 14:17:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:17: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')]} 14:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17: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')]} 14:17:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb10c198f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b44670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd38c0>, '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 0x1bd47c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd4c50>, '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': '62c568580acbfdaac3eec7be000001dc-1456784199.979327-1473393899', '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 14:17:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 14:17:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:17:03 INFO - Using env: {'DISPLAY': ':0', 14:17:03 INFO - 'HOME': '/home/cltbld', 14:17:03 INFO - 'LANG': 'en_US.UTF-8', 14:17:03 INFO - 'LANGUAGE': 'en_US:en', 14:17:03 INFO - 'LOGNAME': 'cltbld', 14:17:03 INFO - 'MAIL': '/var/mail/cltbld', 14:17:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:03 INFO - 'MOZ_NO_REMOTE': '1', 14:17:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:03 INFO - 'NO_EM_RESTART': '1', 14:17:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:17:03 INFO - 'PWD': '/builds/slave/test-pgo', 14:17:03 INFO - 'SHELL': '/bin/bash', 14:17:03 INFO - 'SHLVL': '1', 14:17:03 INFO - 'TERM': 'linux', 14:17:03 INFO - 'TMOUT': '86400', 14:17:03 INFO - 'USER': 'cltbld', 14:17:03 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1456784199.979327-1473393899', 14:17:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:03 INFO - '_': '/tools/buildbot/bin/python'} 14:17:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:03 INFO - Downloading/unpacking blobuploader==1.2.4 14:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:05 INFO - Downloading blobuploader-1.2.4.tar.gz 14:17:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:17:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:17:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:05 INFO - Downloading docopt-0.6.1.tar.gz 14:17:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:17:05 INFO - Installing collected packages: blobuploader, requests, docopt 14:17:05 INFO - Running setup.py install for blobuploader 14:17:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:17:05 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:17:05 INFO - Running setup.py install for requests 14:17:06 INFO - Running setup.py install for docopt 14:17:06 INFO - Successfully installed blobuploader requests docopt 14:17:06 INFO - Cleaning up... 14:17:06 INFO - Return code: 0 14:17:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:17:06 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')]} 14:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:06 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')]} 14:17:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:06 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 0x7fb10c198f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b44670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd38c0>, '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 0x1bd47c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd4c50>, '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': '62c568580acbfdaac3eec7be000001dc-1456784199.979327-1473393899', '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 14:17:06 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 14:17:06 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 14:17:06 INFO - Using env: {'DISPLAY': ':0', 14:17:06 INFO - 'HOME': '/home/cltbld', 14:17:06 INFO - 'LANG': 'en_US.UTF-8', 14:17:06 INFO - 'LANGUAGE': 'en_US:en', 14:17:06 INFO - 'LOGNAME': 'cltbld', 14:17:06 INFO - 'MAIL': '/var/mail/cltbld', 14:17:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:06 INFO - 'MOZ_NO_REMOTE': '1', 14:17:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:06 INFO - 'NO_EM_RESTART': '1', 14:17:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:17:06 INFO - 'PWD': '/builds/slave/test-pgo', 14:17:06 INFO - 'SHELL': '/bin/bash', 14:17:06 INFO - 'SHLVL': '1', 14:17:06 INFO - 'TERM': 'linux', 14:17:06 INFO - 'TMOUT': '86400', 14:17:06 INFO - 'USER': 'cltbld', 14:17:06 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1456784199.979327-1473393899', 14:17:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:06 INFO - '_': '/tools/buildbot/bin/python'} 14:17:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:17:06 INFO - Running setup.py (path:/tmp/pip-Wn3jlK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:17:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:17:06 INFO - Running setup.py (path:/tmp/pip-YblKjp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:17:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:17:06 INFO - Running setup.py (path:/tmp/pip-UgSNIL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:17:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:17:06 INFO - Running setup.py (path:/tmp/pip-_wARJu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:17:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:17:06 INFO - Running setup.py (path:/tmp/pip-qagken-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:17:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:17:07 INFO - Running setup.py (path:/tmp/pip-IdH7ud-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:17:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:17:07 INFO - Running setup.py (path:/tmp/pip-0_WITo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:17:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:17:07 INFO - Running setup.py (path:/tmp/pip-VQTfZr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:17:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:17:07 INFO - Running setup.py (path:/tmp/pip-Rzc5ZD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:17:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:17:07 INFO - Running setup.py (path:/tmp/pip-e83lpQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:17:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:17:07 INFO - Running setup.py (path:/tmp/pip-bMT9rn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:17:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:17:07 INFO - Running setup.py (path:/tmp/pip-hEwzeh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:17:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:17:07 INFO - Running setup.py (path:/tmp/pip-BTuJSu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:17:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:17:07 INFO - Running setup.py (path:/tmp/pip-nYlIYJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:17:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:17:07 INFO - Running setup.py (path:/tmp/pip-m_oN1W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:17:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:17:07 INFO - Running setup.py (path:/tmp/pip-zzOOen-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:17:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:17:07 INFO - Running setup.py (path:/tmp/pip-lUjfky-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:17:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:17:07 INFO - Running setup.py install for manifestparser 14:17:07 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:17:07 INFO - Running setup.py install for mozcrash 14:17:08 INFO - Running setup.py install for mozdebug 14:17:08 INFO - Running setup.py install for mozdevice 14:17:08 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:17:08 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:17:08 INFO - Running setup.py install for mozfile 14:17:08 INFO - Running setup.py install for mozhttpd 14:17:08 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:17:08 INFO - Running setup.py install for mozinfo 14:17:08 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:17:08 INFO - Running setup.py install for mozInstall 14:17:08 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:17:08 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:17:08 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:17:08 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:17:08 INFO - Running setup.py install for mozleak 14:17:08 INFO - Running setup.py install for mozlog 14:17:08 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:17:08 INFO - Running setup.py install for moznetwork 14:17:08 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:17:08 INFO - Running setup.py install for mozprocess 14:17:09 INFO - Running setup.py install for mozprofile 14:17:09 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:17:09 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:17:09 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:17:09 INFO - Running setup.py install for mozrunner 14:17:09 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:17:09 INFO - Running setup.py install for mozscreenshot 14:17:09 INFO - Running setup.py install for moztest 14:17:09 INFO - Running setup.py install for mozversion 14:17:09 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:17:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:17:09 INFO - Cleaning up... 14:17:09 INFO - Return code: 0 14:17:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:17:09 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')]} 14:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:09 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')]} 14:17:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:09 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 0x7fb10c198f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b44670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd38c0>, '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 0x1bd47c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd4c50>, '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': '62c568580acbfdaac3eec7be000001dc-1456784199.979327-1473393899', '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 14:17:09 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 14:17:09 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 14:17:09 INFO - Using env: {'DISPLAY': ':0', 14:17:09 INFO - 'HOME': '/home/cltbld', 14:17:09 INFO - 'LANG': 'en_US.UTF-8', 14:17:09 INFO - 'LANGUAGE': 'en_US:en', 14:17:09 INFO - 'LOGNAME': 'cltbld', 14:17:09 INFO - 'MAIL': '/var/mail/cltbld', 14:17:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:09 INFO - 'MOZ_NO_REMOTE': '1', 14:17:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:09 INFO - 'NO_EM_RESTART': '1', 14:17:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:17:09 INFO - 'PWD': '/builds/slave/test-pgo', 14:17:09 INFO - 'SHELL': '/bin/bash', 14:17:09 INFO - 'SHLVL': '1', 14:17:09 INFO - 'TERM': 'linux', 14:17:09 INFO - 'TMOUT': '86400', 14:17:09 INFO - 'USER': 'cltbld', 14:17:09 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1456784199.979327-1473393899', 14:17:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:09 INFO - '_': '/tools/buildbot/bin/python'} 14:17:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:17:09 INFO - Running setup.py (path:/tmp/pip-UZcWgk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:17:09 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)) 14:17:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:17:09 INFO - Running setup.py (path:/tmp/pip-iBYs2j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:17:10 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)) 14:17:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:17:10 INFO - Running setup.py (path:/tmp/pip-ky2BQe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:17:10 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)) 14:17:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:17:10 INFO - Running setup.py (path:/tmp/pip-9oZ74F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:17:10 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)) 14:17:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:17:10 INFO - Running setup.py (path:/tmp/pip-vDmemD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:17:10 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)) 14:17:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:17:10 INFO - Running setup.py (path:/tmp/pip-5IA08R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:17:10 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)) 14:17:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:17:10 INFO - Running setup.py (path:/tmp/pip-s7Vzu6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:17:10 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)) 14:17:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:17:10 INFO - Running setup.py (path:/tmp/pip-SOJ9jH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:17:10 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)) 14:17:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:17:10 INFO - Running setup.py (path:/tmp/pip-BCeRFf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:17:10 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)) 14:17:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:17:10 INFO - Running setup.py (path:/tmp/pip-95Q1ZH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:17:10 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)) 14:17:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:17:10 INFO - Running setup.py (path:/tmp/pip-OKenbH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:17:10 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)) 14:17:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:17:10 INFO - Running setup.py (path:/tmp/pip-XOtBY6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:17:10 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)) 14:17:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:17:10 INFO - Running setup.py (path:/tmp/pip-l_NuC_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:17:10 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)) 14:17:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:17:10 INFO - Running setup.py (path:/tmp/pip-qhpBJ9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:17:10 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)) 14:17:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:17:10 INFO - Running setup.py (path:/tmp/pip-KaVgNK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:17:10 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)) 14:17:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:17:10 INFO - Running setup.py (path:/tmp/pip-PSfRlC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:17:11 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)) 14:17:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:17:11 INFO - Running setup.py (path:/tmp/pip-TUUFk7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:17:11 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)) 14:17:11 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)) 14:17:11 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)) 14:17:11 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)) 14:17:11 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)) 14:17:11 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)) 14:17:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:17:11 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 14:17:11 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 14:17:11 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 14:17:11 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 14:17:11 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 14:17:11 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 14:17:12 INFO - Downloading blessings-1.6.tar.gz 14:17:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:17:12 INFO - Installing collected packages: blessings 14:17:12 INFO - Running setup.py install for blessings 14:17:13 INFO - Successfully installed blessings 14:17:13 INFO - Cleaning up... 14:17:13 INFO - Return code: 0 14:17:13 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:17:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:17:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:17:13 INFO - Reading from file tmpfile_stdout 14:17:13 INFO - Current package versions: 14:17:13 INFO - argparse == 1.2.1 14:17:13 INFO - blessings == 1.6 14:17:13 INFO - blobuploader == 1.2.4 14:17:13 INFO - docopt == 0.6.1 14:17:13 INFO - manifestparser == 1.1 14:17:13 INFO - mozInstall == 1.12 14:17:13 INFO - mozcrash == 0.16 14:17:13 INFO - mozdebug == 0.1 14:17:13 INFO - mozdevice == 0.48 14:17:13 INFO - mozfile == 1.2 14:17:13 INFO - mozhttpd == 0.7 14:17:13 INFO - mozinfo == 0.9 14:17:13 INFO - mozleak == 0.1 14:17:13 INFO - mozlog == 3.1 14:17:13 INFO - moznetwork == 0.27 14:17:13 INFO - mozprocess == 0.22 14:17:13 INFO - mozprofile == 0.28 14:17:13 INFO - mozrunner == 6.11 14:17:13 INFO - mozscreenshot == 0.1 14:17:13 INFO - mozsystemmonitor == 0.0 14:17:13 INFO - moztest == 0.7 14:17:13 INFO - mozversion == 1.4 14:17:13 INFO - psutil == 3.1.1 14:17:13 INFO - requests == 1.2.3 14:17:13 INFO - wsgiref == 0.1.2 14:17:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:17:13 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')]} 14:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:13 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')]} 14:17:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:13 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 0x7fb10c198f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b44670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd38c0>, '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 0x1bd47c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd4c50>, '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': '62c568580acbfdaac3eec7be000001dc-1456784199.979327-1473393899', '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 14:17:13 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 14:17:13 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 14:17:13 INFO - Using env: {'DISPLAY': ':0', 14:17:13 INFO - 'HOME': '/home/cltbld', 14:17:13 INFO - 'LANG': 'en_US.UTF-8', 14:17:13 INFO - 'LANGUAGE': 'en_US:en', 14:17:13 INFO - 'LOGNAME': 'cltbld', 14:17:13 INFO - 'MAIL': '/var/mail/cltbld', 14:17:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:13 INFO - 'MOZ_NO_REMOTE': '1', 14:17:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:13 INFO - 'NO_EM_RESTART': '1', 14:17:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:17:13 INFO - 'PWD': '/builds/slave/test-pgo', 14:17:13 INFO - 'SHELL': '/bin/bash', 14:17:13 INFO - 'SHLVL': '1', 14:17:13 INFO - 'TERM': 'linux', 14:17:13 INFO - 'TMOUT': '86400', 14:17:13 INFO - 'USER': 'cltbld', 14:17:13 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1456784199.979327-1473393899', 14:17:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:13 INFO - '_': '/tools/buildbot/bin/python'} 14:17:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:13 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)) 14:17:13 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)) 14:17:13 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)) 14:17:13 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)) 14:17:13 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)) 14:17:13 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)) 14:17:13 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)) 14:17:13 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)) 14:17:13 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)) 14:17:13 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)) 14:17:13 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)) 14:17:13 INFO - Cleaning up... 14:17:13 INFO - Return code: 0 14:17:13 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:17:13 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')]} 14:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:13 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')]} 14:17:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:13 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 0x7fb10c198f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b44670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd38c0>, '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 0x1bd47c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd4c50>, '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': '62c568580acbfdaac3eec7be000001dc-1456784199.979327-1473393899', '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 14:17:13 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 14:17:13 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 14:17:13 INFO - Using env: {'DISPLAY': ':0', 14:17:13 INFO - 'HOME': '/home/cltbld', 14:17:13 INFO - 'LANG': 'en_US.UTF-8', 14:17:13 INFO - 'LANGUAGE': 'en_US:en', 14:17:13 INFO - 'LOGNAME': 'cltbld', 14:17:13 INFO - 'MAIL': '/var/mail/cltbld', 14:17:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:13 INFO - 'MOZ_NO_REMOTE': '1', 14:17:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:13 INFO - 'NO_EM_RESTART': '1', 14:17:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:17:13 INFO - 'PWD': '/builds/slave/test-pgo', 14:17:13 INFO - 'SHELL': '/bin/bash', 14:17:13 INFO - 'SHLVL': '1', 14:17:13 INFO - 'TERM': 'linux', 14:17:13 INFO - 'TMOUT': '86400', 14:17:13 INFO - 'USER': 'cltbld', 14:17:13 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1456784199.979327-1473393899', 14:17:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:13 INFO - '_': '/tools/buildbot/bin/python'} 14:17:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:13 INFO - Downloading/unpacking jsonschema 14:17:13 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 14:17:13 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 14:17:13 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 14:17:13 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 14:17:13 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 14:17:13 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 14:17:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:17:15 INFO - Downloading/unpacking functools32 (from jsonschema) 14:17:15 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 14:17:15 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 14:17:15 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 14:17:15 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 14:17:15 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 14:17:15 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 14:17:15 INFO - Downloading functools32-3.2.3-2.tar.gz 14:17:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:17:15 INFO - warning: no files found matching '*.txt' 14:17:15 INFO - no previously-included directories found matching 'build' 14:17:15 INFO - no previously-included directories found matching 'dist' 14:17:15 INFO - no previously-included directories found matching '.git*' 14:17:15 INFO - Installing collected packages: jsonschema, functools32 14:17:15 INFO - Running setup.py install for functools32 14:17:15 INFO - warning: no files found matching '*.txt' 14:17:15 INFO - no previously-included directories found matching 'build' 14:17:15 INFO - no previously-included directories found matching 'dist' 14:17:15 INFO - no previously-included directories found matching '.git*' 14:17:16 INFO - Successfully installed jsonschema functools32 14:17:16 INFO - Cleaning up... 14:17:16 INFO - Return code: 0 14:17:16 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:17:16 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')]} 14:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:16 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')]} 14:17:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:16 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 0x7fb10c198f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b44670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd38c0>, '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 0x1bd47c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd4c50>, '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': '62c568580acbfdaac3eec7be000001dc-1456784199.979327-1473393899', '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 14:17:16 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 14:17:16 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 14:17:16 INFO - Using env: {'DISPLAY': ':0', 14:17:16 INFO - 'HOME': '/home/cltbld', 14:17:16 INFO - 'LANG': 'en_US.UTF-8', 14:17:16 INFO - 'LANGUAGE': 'en_US:en', 14:17:16 INFO - 'LOGNAME': 'cltbld', 14:17:16 INFO - 'MAIL': '/var/mail/cltbld', 14:17:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:16 INFO - 'MOZ_NO_REMOTE': '1', 14:17:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:16 INFO - 'NO_EM_RESTART': '1', 14:17:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:17:16 INFO - 'PWD': '/builds/slave/test-pgo', 14:17:16 INFO - 'SHELL': '/bin/bash', 14:17:16 INFO - 'SHLVL': '1', 14:17:16 INFO - 'TERM': 'linux', 14:17:16 INFO - 'TMOUT': '86400', 14:17:16 INFO - 'USER': 'cltbld', 14:17:16 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1456784199.979327-1473393899', 14:17:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:16 INFO - '_': '/tools/buildbot/bin/python'} 14:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:16 INFO - Downloading/unpacking flake8 14:17:16 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 14:17:16 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 14:17:16 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 14:17:16 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 14:17:16 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 14:17:16 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 14:17:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:17:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:17:18 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 14:17:18 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 14:17:18 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 14:17:18 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 14:17:18 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 14:17:18 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 14:17:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:17:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:17:18 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 14:17:18 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 14:17:18 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 14:17:18 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 14:17:18 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 14:17:18 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 14:17:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:17:18 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 14:17:18 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 14:17:18 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 14:17:18 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 14:17:18 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 14:17:18 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 14:17:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:17:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:17:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:17:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:17:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:17:18 INFO - no previously-included directories found matching 'docs/_build' 14:17:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:17:18 INFO - Running setup.py install for pep8 14:17:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:17:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:17:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:17:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:17:18 INFO - no previously-included directories found matching 'docs/_build' 14:17:18 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:17:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:17:18 INFO - Cleaning up... 14:17:19 INFO - Return code: 0 14:17:19 INFO - Running post-action listener: _resource_record_post_action 14:17:19 INFO - Running post-action listener: _start_resource_monitoring 14:17:19 INFO - Starting resource monitoring. 14:17:19 INFO - ##### 14:17:19 INFO - ##### Running install step. 14:17:19 INFO - ##### 14:17:19 INFO - Running pre-action listener: _resource_record_pre_action 14:17:19 INFO - Running main action method: install 14:17:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:17:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:17:19 INFO - Reading from file tmpfile_stdout 14:17:19 INFO - Detecting whether we're running mozinstall >=1.0... 14:17:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:17:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:17:19 INFO - Reading from file tmpfile_stdout 14:17:19 INFO - Output received: 14:17:19 INFO - Usage: mozinstall [options] installer 14:17:19 INFO - Options: 14:17:19 INFO - -h, --help show this help message and exit 14:17:19 INFO - -d DEST, --destination=DEST 14:17:19 INFO - Directory to install application into. [default: 14:17:19 INFO - "/builds/slave/test-pgo"] 14:17:19 INFO - --app=APP Application being installed. [default: firefox] 14:17:19 INFO - mkdir: /builds/slave/test-pgo/build/application 14:17:19 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'] 14:17:19 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 14:17:35 INFO - Reading from file tmpfile_stdout 14:17:35 INFO - Output received: 14:17:35 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:17:35 INFO - Running post-action listener: _resource_record_post_action 14:17:35 INFO - ##### 14:17:35 INFO - ##### Running run-tests step. 14:17:35 INFO - ##### 14:17:35 INFO - Running pre-action listener: _resource_record_pre_action 14:17:35 INFO - Running main action method: run_tests 14:17:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:17:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:17:35 INFO - Python 2.7.3 14:17:35 INFO - Return code: 0 14:17:35 INFO - grabbing minidump binary from tooltool 14:17:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:35 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 0x1bd38c0>, '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 0x1bd47c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd4c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:17:35 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 14:17:35 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 14:17:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:17:35 INFO - Return code: 0 14:17:35 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:17:35 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:17:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:17:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:17:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:17:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:17:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:17:36 INFO - Return code: 0 14:17:36 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ef30RNz6R1WmGSRwmhtfvQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 14:17:36 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ef30RNz6R1WmGSRwmhtfvQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:17:36 INFO - Using env: {'DISPLAY': ':0', 14:17:36 INFO - 'HOME': '/home/cltbld', 14:17:36 INFO - 'LANG': 'en_US.UTF-8', 14:17:36 INFO - 'LANGUAGE': 'en_US:en', 14:17:36 INFO - 'LOGNAME': 'cltbld', 14:17:36 INFO - 'MAIL': '/var/mail/cltbld', 14:17:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:17:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:17:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:36 INFO - 'MOZ_NO_REMOTE': '1', 14:17:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:17:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:36 INFO - 'NO_EM_RESTART': '1', 14:17:36 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:17:36 INFO - 'PWD': '/builds/slave/test-pgo', 14:17:36 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:17:36 INFO - 'SHELL': '/bin/bash', 14:17:36 INFO - 'SHLVL': '1', 14:17:36 INFO - 'TERM': 'linux', 14:17:36 INFO - 'TMOUT': '86400', 14:17:36 INFO - 'USER': 'cltbld', 14:17:36 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1456784199.979327-1473393899', 14:17:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:36 INFO - '_': '/tools/buildbot/bin/python'} 14:17:36 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ef30RNz6R1WmGSRwmhtfvQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:17:36 INFO - mozversion application_buildid: 20160229113753 14:17:36 INFO - mozversion application_changeset: 04634ec900b2fb94962733148ecdeac7ae98e0e2 14:17:36 INFO - mozversion application_display_name: Nightly 14:17:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:17:36 INFO - mozversion application_name: Firefox 14:17:36 INFO - mozversion application_remotingname: firefox 14:17:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:17:36 INFO - mozversion application_vendor: Mozilla 14:17:36 INFO - mozversion application_version: 47.0a1 14:17:36 INFO - mozversion platform_buildid: 20160229113753 14:17:36 INFO - mozversion platform_changeset: 04634ec900b2fb94962733148ecdeac7ae98e0e2 14:17:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:17:36 INFO - mozversion platform_version: 47.0a1 14:17:36 INFO - using testdate: 1456784256 14:17:36 INFO - actual date: 1456784256 14:17:36 INFO - starting webserver on 'localhost:43734' 14:17:36 INFO - SUITE-START | Running 2 tests 14:17:36 INFO - TEST-START | dromaeo_css 14:17:36 INFO - operating with platform_type : linux_ 14:17:36 INFO - Initialising browser for dromaeo_css test... 14:17:36 INFO - TEST-INFO | started process 16695 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkEvznR/profile http://localhost:43734/getInfo.html) 14:17:40 INFO - PROCESS | 16695 | 14:17:40 INFO - PROCESS | 16695 | (process:16777): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:17:41 INFO - PROCESS | 16695 | __metrics Screen width/height:1600/1200 14:17:41 INFO - PROCESS | 16695 | colorDepth:24 14:17:41 INFO - PROCESS | 16695 | Browser inner width/height: 1024/697 14:17:41 INFO - PROCESS | 16695 | __metrics 14:17:42 ERROR - PROCESS | 16695 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 14:17:42 INFO - PROCESS | 16695 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:17:42 INFO - PROCESS | 16695 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:17:42 INFO - PROCESS | 16695 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:17:42 INFO - PROCESS | 16695 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:17:42 INFO - PROCESS | 16695 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:17:42 INFO - PROCESS | 16695 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:17:42 INFO - PROCESS | 16695 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:17:42 INFO - PROCESS | 16695 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:17:42 INFO - PROCESS | 16695 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:17:42 INFO - TEST-INFO | 16695: exit 0 14:17:42 INFO - Browser initialized. 14:17:42 INFO - Running cycle 1/1 for dromaeo_css test... 14:17:42 INFO - TEST-INFO | started process 16828 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkEvznR/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:17:44 INFO - PROCESS | 16828 | 14:17:44 INFO - PROCESS | 16828 | (process:16887): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:17:54 INFO - PROCESS | 16828 | RSS: Main: 161300480 14:17:54 INFO - PROCESS | 16828 | 14:18:44 INFO - PROCESS | 16828 | 1456784324371 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] 14:20:52 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:43734/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43734/tests/dromaeo/cssquery-ext.html) 14:20:53 INFO - PROCESS | 16828 | RSS: Main: 168173568 14:20:53 INFO - PROCESS | 16828 | 14:23:55 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:43734/tests/dromaeo/cssquery-ext.html (next: http://localhost:43734/tests/dromaeo/cssquery-jquery.html) 14:23:55 INFO - PROCESS | 16828 | RSS: Main: 165244928 14:23:55 INFO - PROCESS | 16828 | 14:26:57 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:43734/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43734/tests/dromaeo/cssquery-mootools.html) 14:26:58 INFO - PROCESS | 16828 | RSS: Main: 166993920 14:26:58 INFO - PROCESS | 16828 | 14:29:59 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:43734/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43734/tests/dromaeo/cssquery-prototype.html) 14:30:00 INFO - PROCESS | 16828 | RSS: Main: 163717120 14:30:00 INFO - PROCESS | 16828 | 14:33:02 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:43734/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43734/tests/dromaeo/cssquery-yui.html) 14:33:03 INFO - PROCESS | 16828 | RSS: Main: 164614144 14:33:03 INFO - PROCESS | 16828 | 14:36:05 INFO - PROCESS | 16828 | Cycle 1(1): loaded http://localhost:43734/tests/dromaeo/cssquery-yui.html (next: http://localhost:43734/tests/dromaeo/cssquery-dojo.html) 14:36:06 INFO - PROCESS | 16828 | RSS: Main: 168435712 14:36:06 INFO - PROCESS | 16828 | 14:36:06 INFO - PROCESS | 16828 | __start_tp_report 14:36:06 INFO - PROCESS | 16828 | _x_x_mozilla_page_load 14:36:06 INFO - PROCESS | 16828 | _x_x_mozilla_page_load_details 14:36:06 INFO - PROCESS | 16828 | |i|pagename|runs| 14:36:06 INFO - PROCESS | 16828 | |0;dojo.html;3203.519472079188;3216.758743094267;3236.967630323699;3256.3975664502063;3265.16738231751;5144.819931302405;5205.947940520594;5215.895682086356;5231.163013917774;5253.133233016548;5081.872953176173;5162.6644268122545;5177.689338639684;5196.194589838572;5218.791248350061;4713.528647135285;4781.737004464753;4851.733154676509;4910.140725373046;4941.925871111936;483.7222693242813;4700.717956922578;4791.808327666907;4809.951900481003;4852.150873597124;4771.9761401192945;4781.211100168468;4798.4001999750035;4798.616110711152;4817.445993710716;4731.124741922756;4779.068081724065;4817.132916075105;4821.662483626147;4891.682040667345;4696.600788932945;4726.385569875929;4732.716037037789;4736.550027747358;4786.7845946932475;5098.668586541863;5108.463611320833;5121.4622464641425;5163.406208286057;5200.167973124319;5462.808801691922;5497.367802702701;5627.352854421712;5631.549476041907;5646.124850648156;5581.386047534768;5612.719364031782;5626.043572592628;5645.943540564624;5679.829605111853;5184.559312458446;5218.921716174261;5225.085610018232;5225.947740522584;5292.047431462373;5548.77804887808;5635;5656.321241451053;5679.091345384719;5681.375048744635;5382.865428364322;5398.78404863801;5420.7289635518855;5427.1045277528765;5441.075017247077;5525.613207075547;5553.111502159635;5576.219329293902;5587.552995760329;5614.6631202128;5470.972645136749;5475.315585551806;5478.643888147338;5489.58828087887;5490.505854473116;5474.781008759605;5502.064649009678;5552.666839989613;5614.69119198448;5641.943580564224;4218.34615634571;4237.978810105929;4248.638865696388;4256.233877901946;4284.843092365107;3818.4610475088402;3833.654971052563;3851.8844434667003;3874.2057878134915;3898.6101389861356;5163.535281824654;5251.711155886463;5276.472352764693;5328.706921119298;5374.650647707965;5562.97085039269;5620.690862002547;5624.072028115397;5640.097584386478;5664;5124.718140502234;5308.601854860901;5326.041312563776;5332.413434522199;5376.7042812644895;4654.25531914892;4656.41794775653;4675.485696573374;4701.271302948048;4718.2214934536105;5556.805511807067;5560.694161821058;5570.303712035996;5575.386707462176;5584.748686309044;5432.429594892479;5445.319335083114;5461.044317244546;5467.589930755209;5567;5802.071668533014;5811.128330750252;5814.796482123105;5875.559333049953;5912.083627037816;5526.47498487643;5548.583856210719;5549.139883318092;5553.500184983371;5556.916646250229;5531.197976293495;5603.243562119062;5646.689432081275;5673.319201695823;5735.655860648374;5495.395506494362;5500.1749737539685;5504.862378440411;5506.256655351476;5526.309211348582;5464.590155738256;5475;5485.945140548543;5497.3952865184;5541.362743284574;5247.475252474722;5266.07843627356;5311.336082989626;5373.731313434391;5377.650452720561;5311.41574426805;5509.779608815603;5516.889662206653;5535.3634332050715;5561.249231353715;5350.652207606493;5381.461853814587;5433.5381492572;5442.292501974718;5450.618456707993 14:36:06 INFO - PROCESS | 16828 | |1;ext.html;490.24257522128306;521.7886755863875;541.7237209023397;551.0494397164891;608.7443273824993;30587.69412305876;36890.26219475609;37386.813065934635;37512.62487375126;37748.433773493416;40479.79760101195;40782.79608601953;41013.179736405255;41066.58933410665;41310;8518.275946544536;8842.602082906253;8844.690435834747;8851.69019084329;8862.11378862115;8642.222200002;8730.388872778907;8744.737657870273;8787.25308348788;8812.1187881212;8704.782380440476;8850.114988501162;8875.95562022189;8885.067067957869;8888.022317545065;8661.13388661132;8804.119588041145;8806.295496360308;8827.558622068871;8845.734627961172;8616.913830861673;8771.561421928878;8773.561321933877;8785.165409286108;8790.077041910572;41064.58935410638;41259.381109283386;41276.587234127575;41496.585034149575;41541.37687934683;3182.2839861031084;3363.83180840957;3485.5468789057513;3716.684081853046;4085.1829634073306;26823.195304140907;27464.450710985868;27528.311792205153;27585.172444826687;27712.307192320153;3846.173072789336;3951.940720889189;3977.8607748728655;4018.9196216075807;4114.670826333886;230271;231123;231668;232928;233560;42872.57127428748;43171.78414107972;43236.567634323255;57808.71095644495;58030;39993;40408.19183616311;40516;40609.79695101506;40653;13419.664508387368;13518.526851560147;13566.186028838103;13570.321483925763;13649.385777640031;11764.411779410995;11915.52337906474;11947.103967202494;11961.401929903644;12032.39838008096;14053.78919316211;14067.226302553458;14105.435782568582;14146.929265353607;14148.151110933377;5533.446655334435;5617.83159493259;5629.802956896489;5631.915521267184;5671.829845104653;956.9665061722807;972.615816752393;1022.5960745505483;1042.7393151712072;1049.7847941172042;28882.566761498594;29344.559831602543;29350.706492935224;29415.76426593073;29615.851920740257;1064.9361038337724;1074.3661239868516;1080.195254535376;1120.0759373516719;1123.1576317761678;14997.550073497812;15041.699166016619;15224.923875380553;15435.536933892;15483.380664773507;288286;293640;295449;296089;296617;53777.73111134419;53983;54396;54548;54595;1250.1748845761754;1307.1438207973792;1327.482281910056;1329.9135556188817;1338.5315139701027;28421.289467763472;28998.27504312409;29176.01218872577;29510.409791803613;29594;46839;47058.29412558746;47125.764371177924;47203.76398117987;47507.52492475031;278382;278424;278727;279152;279176;32625.510617341235;32717;32875.17812054718;32905.17737056593;33091.00726978194;43916.56083439253;44562.55437445584;44563;44709.55290447184;45197.74011299488;37095.25809483849;37297.25405491821;37611.2477750438;37816.81091594524;37942.43086353762;36567.4503378865;37159;37338.43992340063;37683.81158094192;38114;35916.64083359133;36054.84404407747;36189;36771.81614091912;37107.628923710414;33050.66949330476;34002.489962650085;34356.31287374189;34625.653743462244;34767.30465390627;25360.619590706523;25847.741522584533;25892.46452128708;26052;26053.869730651226 14:36:06 INFO - PROCESS | 16828 | |2;jquery.html;353.6604859335038;353.9168295450569;359.4482469409455;360.5601166576776;363.249888979258;16260.593485162877;16819.83180168198;17376.04431756253;17409.30362785487;17416.56458588536;17021.57446063849;17312.913435432838;17488.912555437237;17629.11854407278;17726.64546709065;5325.174597937326;5336.38631557372;5507.586930980173;5522;5565.582581306398;5424.891502169974;5505.834824955257;5511.448855114497;5528.695921724304;5536.640118392292;5439.673619582818;5488.341399032121;5500.889982200353;5690.118031705092;5704.686242256675;5408.675479471244;5552.833414997556;5591.4688104629995;5612.635178713371;5625.493705566499;5379.946200537984;5419.620626556142;5423.376311724123;5424.321959755031;5427.755750991215;13088.738225235536;13326.466941322335;15251.38994440221;20871;20989.68515472269;2085.092984551725;2127.8297736181066;2178.6623073423643;2179.0738935952318;2252.121672547708;9241.445513269226;9260.953695231481;9755.073268039525;10640.57437702491;13059.412326445237;1781.0827423876715;1802.1980218802637;1819.972700409495;1837.0539172326262;1892.139076720089;63723.68138159326;66019.66990165018;66520;67003.3299667002;67113;9632.711018669452;9766.267529935283;10056.094951454257;10104.69685909424;10204.948975255076;12866.421011054525;13191.340432978504;13206.207627542379;13210.273434960976;13220.933895330461;7496;7592.354649854714;7672.961635191788;7798;7798.376129909707;7647.235276472308;7678.846423071619;7683.615819209129;7766.339861111755;7771.844563108819;4319.827206911751;4362.083962367875;4382.276924307454;4425.800838962255;4520.276755719069;1712.212382304154;1737.348494314632;1774.112943528236;1789.5615574184408;1790.561312478451;888.9155530224618;921.2721949659693;977.5405559387077;995.8406654935176;1012.4178597306578;14520.709585808436;15429.922850385676;16387.754183687255;16627;16788.580285492717;895.7447127568612;918.1094338491653;921.9400738952081;943.6649989253854;943.719206323206;9371.906280937239;9634.71095867111;9637.566309516089;9704.611815527442;9836.213102951746;425887;436856;440056;441628;442779;55652.72173639187;69888;71933.2806671937;72076.63961680263;77609;978.7602037500716;991.7718924647227;994.5872462927804;1012.8328825743818;1016.7763092119721;15496.767548487007;15556.377744890531;15567;15677.372905083668;15798.76301855496;32065.519017214294;32845.17887052843;33473.163170920925;33786.83106584451;33985;44539.331910022025;47121.76439117782;48103;48447.75776121097;48464.515354846;7660.655270512952;7681.385489160742;7691.30778229962;7766.262205090507;7781.105172904962;8763.342749293955;11176;12729.872701272869;13080.869191308346;13206.009549284034;11061.889381106086;11226.270292430965;11315.151363647925;11343.432828358384;11454.885451145381;10633.680989570325;11288.887111129112;11343.092552595937;11351.943240283746;11413;7556.942028115958;9605.615775368908;10678.359298442118;11368.090552755924;11701.648950531498;7657.57883316423;7673.194314596887;7804.9609751950875;7897.802554935943;8033.55815430157;10717.089047431056;10725.946370268099;10842.945785271339;11039.889601104207;11045.28205666629 14:36:06 INFO - PROCESS | 16828 | |3;mootools.html;1474.7640377539594;1480.2154857925298;1650.1089411717674;1751.667183235186;1797.7393277974693;6756.594604323744;7434.7769566913075;7445.627718614068;7592.20281870404;7667.654955527;7454.180040195574;7534;7551.471397002212;7656.349210317116;7665.310122089011;2275.306031660347;2311.5492478966607;2319.0491898321693;2320.176337400224;2322.140807901079;2349.9177528786495;2358.6108292131776;2373.2761507740133;2383;2384.654225137354;2259.2770313499686;2269.6255117905525;2274.1812947339026;2290.3930458428445;2296.115995341797;2273.295278463673;2303.6659684345846;2309.0763694522157;2309.1571576374504;2316.224064938248;2279.7036385269976;2315.2012555668434;2317.2005658047947;2319.2346525646667;2325.9069637214493;7783.949166862458;7846.489978151402;7847.568383738892;7853.0576330840095;7856.921430785676;4728.66899317048;4852.344933433977;4855.295982082614;4860.368152140234;4871.050145221683;3045.8477076146105;3049.649290331618;3159.5418664293547;3160.7787454878166;3175.158582975513;945.8155659646371;958.9616415343378;960.5485421851719;962.5524131278919;973.9951300243524;10371.636992705218;10451.320664156881;10482.371057736636;10491.055804977588;10504.369737815756;4085.754854708727;4131.97934010328;4167.958010497376;4240.915181696349;4246.341817018367;8379.413441059189;8386.87419688705;8426.789330266793;8449.45078569891;8465.830683386297;4657.068586282757;4676.555727205978;4680.3915490985955;4700.88247793801;4701.318308845198;3869.6130386961077;4259.914801703949;4318.697691161588;4320.65434765218;4353.172897149531;3427.2802711430877;3442.604100528421;3461.671141241578;3484.094135524782;3490.458978858281;986.7335819328885;997.2122023601273;1012.104287705386;1017.9694609161737;1038.9584416623402;1289.5228765356878;1356.572679605921;1372.6499742565782;1373.2790285100402;1373.7527245095778;6964.233934267328;6977.092977912839;7060;7131.25121862197;7163.534370265916;453.1661742394011;455.9293309536961;456.26541268557594;459.5289827926402;486.26331108370846;5602.523785478198;5640.774369025193;5640.943590564042;5669;5691.174779656926;9006.369554131148;9016.143466370684;9248.21390181842;9294.628214871465;9334.486603236886;9161.725148245563;9187.678431254873;9189.770255743526;9203;9240.260779137652;7111.359977602041;7115.715371385087;7228.554289142193;7246.456515761339;7271.818204545035;6803.353681400259;6817.181938167451;6830.009648601024;6833.282505337067;6863.039174515671;8065.556394398364;8203.83592328162;8302.54336011525;8408.747737567883;8436.620352084048;8401.789955251168;8476.660933562835;8488.151184881463;8514.276286515715;8597.785055373666;6272.811815645356;6512.3162067982175;6634.303398143125;6726.966365168143;6734.124563806674;7207.387372073433;7251.347378735939;7290.453216008927;7305.41556675454;7339;6500;6702.36327548882;6775.796726098225;6793.490488213502;6907.896381554381;6542.953127499577;6558.606483610999;6659.2008958925235;6689.899651505329;6714.52998290115;6751.966240168767;6788.287229840993;6849;6854;6944.340287672663;5826.242588463472;5917.763289468545;5922.496587790086;5930.555208359304;5944.6730429826775;6158.661273629814;6179.28938172098;6230.937690623035;6256.718447669775;6265.216847894013 14:36:06 INFO - PROCESS | 16828 | |4;prototype.html;304.58120084883285;308.1018830110229;331.18032868650096;335.22395654060847;340.42638154709323;6207.627542347463;6293.27627322858;6302.668012835257;6304.71628776705;6349.492040636749;6155.599886007406;6160.260768707762;6167.660778657172;6175.876482470348;6185.474234690057;4548.31775233716;4650.488446270908;4653;4692.530746925314;4724.055188962204;4678.883027924295;4704.223803072489;4711.552402521772;4712.528747125294;4725.196716558176;4648.302754586822;4648.883777905546;4658.604018658418;4673.696209746356;4682.41469816273;4655.604273636745;4670.76646167692;4671.089137618166;4682.765861706901;4683;4032.5160980682213;4037.3338399164104;4046.6964977626794;4048.0891799345204;4049.473568436114;5911.674857882815;5926.081457374114;5931.851703707442;5939.049752039696;5960.523158147338;5218.330134357007;5428.701421421821;5436.401995780461;5439.48324909133;5439.5376393006245;6533;6590.340965903371;6644.634545100018;6647.3020332864835;6649.3018233085795;4436.489803672586;4442.800073996678;4447.288433850568;4459.888502787424;4461.665375096881;6843.828904277383;6905.309469053104;6917.169939607229;6921.653917304165;6922.861542769117;4460.977695111568;4465.26323156682;4532.524084971031;4548.727076375362;4573.931391029138;4587.105514424655;4599.494055653875;4607.8848028798875;4621.907561848744;4631.513691062457;5396.703181324986;5417.079096553595;5430.945690543044;5431.321084864392;5432.7555260012605;6608.768693095719;6631.403173714389;6677.632730199788;6678.6326752028135;6684.899726504106;1608.9919550402174;1635.4030778765664;1637.0750525953038;1638;1639.6064944413256;1032.4631191780231;1040.8490768838628;1058.8570542976754;1061.930974486656;1087.8912108789057;6314.810555683337;6332.556721029484;6334.049892516067;6347.68261586928;6349.079383489368;6737.562058466184;6779.15260592426;6803.183617965876;6825.48808839339;6835.350641689031;6306.400891915261;6325.304216536178;6332.968335158387;6339.302676705559;6343.080253363329;3673.7244706646575;3697.6672099511175;3698.4637227601847;3699.7780133192095;3702.8889133326043;6997.510174287852;7154.320339567733;7177.856442871113;7229.566226026455;7235.638218089074;6995;7003.404710599554;7013.193482749447;7022.613756243353;7024.719011239596;7190.173130090002;7193.064901562763;7199.568025918462;7202.099737532913;7206.531575447579;6814.897776533257;6820.31796820314;6825.2833452486775;6832.863342733018;6833.829154271183;6556.803295901131;6778.152730908637;6843.452523798183;6849.794506164823;6855.143107111611;7234.457415693739;7249.601271930094;7268.27317268269;7292.817679557841;7307.671154798153;4542.841575398253;4561.863144105682;4582.77086145698;4583.037562111994;4586.357909892685;6758.290379510081;6854.897176542256;6912.585244885323;6912.861742765217;6923.861522769415;6689.397954184147;6705.396514313735;6710.597364158166;6711.0940023096255;6719.361660642231;6707.061011458302;6708.932910670831;6710.094137291599;6710.6309152997055;6720.663966801738;6467.256265529524;6483.675816209265;6531.510136739668;6531.836704082436;6547.083408322934;6554.4756419485375;6734.393904548614;6736.8652626946205;6748.19021717397;6760.594364338155;6545.541812073299;6565.671716414256;6569.277379488348;6572.605643661395;6576.408123268929 14:36:06 INFO - PROCESS | 16828 | |5;yui.html;817.9141190175035;827.6772058897031;829.8507759353214;830.410408609887;832.3798769916413;12924.806127908078;12942.741145177091;12990;13081.345932703374;13091.149075310099;13023.94912054058;13263.336833158352;13822.308884555758;13912.791308130387;13967.231802250872;690.4476418864913;827.210014436215;836.9830655753259;838.7651457591884;841.8947631546057;827.8923739913803;841.9284360829306;847.2840449819923;847.7160151349306;848.0120659431755;875.6672464463495;876.8728534362546;876.9254613357872;876.9736907892742;879.4942907827992;865.8701194820765;871.9520426376547;873.4846440600045;875.0461996423896;876.4916348517844;643.491641603133;648.2059477140513;648.2383199740286;649.7693318871827;650.151552224347;13799.586012419644;13833;13839;13883.097598656155;13909.4436222552;13289.734205315839;13446.19322840623;13657.658558536017;13681.726365472734;13775.862241377557;10718;10849.643794525684;10854.891451085467;10880.836787448194;11532;3677.760945538558;3717.8698745543775;3788.2423515296773;3829.8659546916;3835.117922877726;44458.555414445764;44905.326420103724;45043.09913801739;45342;45483.31775023377;9977.45124018186;10082.395056296646;10123.139533139618;10145.898541014643;10195.133413659774;17793.555161120818;17827;17838.464846054638;17872.91063544674;17937.551561210814;7472.140703819022;7656.961715191388;7685.116211635622;7708.845823083507;7825;4363.149185908717;4401.339799030171;4415;4525.886852828706;4551.544845515422;3034.180771191766;3036.407900459433;3046.040497243361;3052.5879006334303;3071.7081877221626;551.4265164229237;554.8501904485847;563.5266376243975;577.1544687033517;577.177522031104;569.4391024840529;645.3385280087854;656.1371796088129;680.9290101641632;684.5858255755296;8289.4197406181;8689.17452841979;8712.912870871336;8768.210861022539;8797.317392042041;648.2447948140458;660.2769966886252;662.8873091574444;666.1074160624689;671.6373158494456;3816.5420149581673;3836.48207491985;3907.4529565860803;3988.780617066031;4029.49631296088;53436;54107.18839217415;54411.45588544064;54513;54778.72610636921;49276.75361623169;49797.502024980015;49856.75071624691;49923;50021;43480.782596086814;43755;44250.55749442529;44426.11147777026;44546.33180502295;7605.961970190114;7701.691932322644;7726.381889448943;7750.806229844074;7760.30157285847;33941.49087763636;34156.48765268473;34180.14549636279;34712.13219669528;35344.29311413809;38938.44246230232;39929.60070399259;42290.788546057076;42368.364474533526;42459.787701061294;10389.168866490512;10416.479176041319;10423.166146708396;10580.788384232119;11090.833637495283;12181.086418518824;12243.32661703615;12390.62828115158;12465.314407707663;12793.42429590652;11374.488148033524;11432.94283528577;11646.126540509325;11769.705757356134;12240.326782026717;11570.305781653127;11592.710182245512;11726.88273117258;11875.346855923008;12132.211406258564;10791.190660700322;10905.127589792639;11613;11913.761724765629;11969.102317326062;9833.164181044405;9988.650397236062;10020;10125.240606954361;10349.430781307101;9164.312676549152;9241.676541321021;9674.274429417681;9894.554745036634;9961.750956226153 14:36:06 INFO - PROCESS | 16828 | __end_tp_report 14:36:06 INFO - PROCESS | 16828 | __start_cc_report 14:36:06 INFO - PROCESS | 16828 | _x_x_mozilla_cycle_collect,311 14:36:06 INFO - PROCESS | 16828 | __end_cc_report 14:36:06 INFO - PROCESS | 16828 | __startTimestamp1456785366245__endTimestamp 14:36:06 INFO - PROCESS | 16828 | 14:36:06 INFO - PROCESS | 16828 | ------- Summary: start ------- 14:36:06 INFO - PROCESS | 16828 | Number of tests: 6 14:36:06 INFO - PROCESS | 16828 | 14:36:06 INFO - PROCESS | 16828 | [#0] dojo.html Cycles:165 Average:5158.14 Median:5381.46 stddev:664.14 (12.3%) stddev-sans-first:648.23 14:36:06 INFO - PROCESS | 16828 | Values: 3203.5 3216.8 3237.0 3256.4 3265.2 5144.8 5205.9 5215.9 5231.2 5253.1 5081.9 5162.7 5177.7 5196.2 5218.8 4713.5 4781.7 4851.7 4910.1 4941.9 483.7 4700.7 4791.8 4810.0 4852.2 4772.0 4781.2 4798.4 4798.6 4817.4 4731.1 4779.1 4817.1 4821.7 4891.7 4696.6 4726.4 4732.7 4736.6 4786.8 5098.7 5108.5 5121.5 5163.4 5200.2 5462.8 5497.4 5627.4 5631.5 5646.1 5581.4 5612.7 5626.0 5645.9 5679.8 5184.6 5218.9 5225.1 5225.9 5292.0 5548.8 5635.0 5656.3 5679.1 5681.4 5382.9 5398.8 5420.7 5427.1 5441.1 5525.6 5553.1 5576.2 5587.6 5614.7 5471.0 5475.3 5478.6 5489.6 5490.5 5474.8 5502.1 5552.7 5614.7 5641.9 4218.3 4238.0 4248.6 4256.2 4284.8 3818.5 3833.7 3851.9 3874.2 3898.6 5163.5 5251.7 5276.5 5328.7 5374.7 5563.0 5620.7 5624.1 5640.1 5664.0 5124.7 5308.6 5326.0 5332.4 5376.7 4654.3 4656.4 4675.5 4701.3 4718.2 5556.8 5560.7 5570.3 5575.4 5584.7 5432.4 5445.3 5461.0 5467.6 5567.0 5802.1 5811.1 5814.8 5875.6 5912.1 5526.5 5548.6 5549.1 5553.5 5556.9 5531.2 5603.2 5646.7 5673.3 5735.7 5495.4 5500.2 5504.9 5506.3 5526.3 5464.6 5475.0 5485.9 5497.4 5541.4 5247.5 5266.1 5311.3 5373.7 5377.7 5311.4 5509.8 5516.9 5535.4 5561.2 5350.7 5381.5 5433.5 5442.3 5450.6 14:36:06 INFO - PROCESS | 16828 | 14:36:06 INFO - PROCESS | 16828 | [#1] ext.html Cycles:180 Average:43453.76 Median:20437.84 stddev:70240.33 (343.7%) stddev-sans-first:70363.29 14:36:06 INFO - PROCESS | 16828 | Values: 490.2 521.8 541.7 551.0 608.7 30587.7 36890.3 37386.8 37512.6 37748.4 40479.8 40782.8 41013.2 41066.6 41310.0 8518.3 8842.6 8844.7 8851.7 8862.1 8642.2 8730.4 8744.7 8787.3 8812.1 8704.8 8850.1 8876.0 8885.1 8888.0 8661.1 8804.1 8806.3 8827.6 8845.7 8616.9 8771.6 8773.6 8785.2 8790.1 41064.6 41259.4 41276.6 41496.6 41541.4 3182.3 3363.8 3485.5 3716.7 4085.2 26823.2 27464.5 27528.3 27585.2 27712.3 3846.2 3951.9 3977.9 4018.9 4114.7 230271.0 231123.0 231668.0 232928.0 233560.0 42872.6 43171.8 43236.6 57808.7 58030.0 39993.0 40408.2 40516.0 40609.8 40653.0 13419.7 13518.5 13566.2 13570.3 13649.4 11764.4 11915.5 11947.1 11961.4 12032.4 14053.8 14067.2 14105.4 14146.9 14148.2 5533.4 5617.8 5629.8 5631.9 5671.8 957.0 972.6 1022.6 1042.7 1049.8 28882.6 29344.6 29350.7 29415.8 29615.9 1064.9 1074.4 1080.2 1120.1 1123.2 14997.6 15041.7 15224.9 15435.5 15483.4 288286.0 293640.0 295449.0 296089.0 296617.0 53777.7 53983.0 54396.0 54548.0 54595.0 1250.2 1307.1 1327.5 1329.9 1338.5 28421.3 28998.3 29176.0 29510.4 29594.0 46839.0 47058.3 47125.8 47203.8 47507.5 278382.0 278424.0 278727.0 279152.0 279176.0 32625.5 32717.0 32875.2 32905.2 33091.0 43916.6 44562.6 44563.0 44709.6 45197.7 37095.3 37297.3 37611.2 37816.8 37942.4 36567.5 37159.0 37338.4 37683.8 38114.0 35916.6 36054.8 36189.0 36771.8 37107.6 33050.7 34002.5 34356.3 34625.7 34767.3 25360.6 25847.7 25892.5 26052.0 26053.9 14:36:06 INFO - PROCESS | 16828 | 14:36:06 INFO - PROCESS | 16828 | [#2] jquery.html Cycles:180 Average:25181.50 Median:440842.00 stddev:71702.62 (16.3%) stddev-sans-first:71879.53 14:36:06 INFO - PROCESS | 16828 | Values: 353.7 353.9 359.4 360.6 363.2 16260.6 16819.8 17376.0 17409.3 17416.6 17021.6 17312.9 17488.9 17629.1 17726.6 5325.2 5336.4 5507.6 5522.0 5565.6 5424.9 5505.8 5511.4 5528.7 5536.6 5439.7 5488.3 5500.9 5690.1 5704.7 5408.7 5552.8 5591.5 5612.6 5625.5 5379.9 5419.6 5423.4 5424.3 5427.8 13088.7 13326.5 15251.4 20871.0 20989.7 2085.1 2127.8 2178.7 2179.1 2252.1 9241.4 9261.0 9755.1 10640.6 13059.4 1781.1 1802.2 1820.0 1837.1 1892.1 63723.7 66019.7 66520.0 67003.3 67113.0 9632.7 9766.3 10056.1 10104.7 10204.9 12866.4 13191.3 13206.2 13210.3 13220.9 7496.0 7592.4 7673.0 7798.0 7798.4 7647.2 7678.8 7683.6 7766.3 7771.8 4319.8 4362.1 4382.3 4425.8 4520.3 1712.2 1737.3 1774.1 1789.6 1790.6 888.9 921.3 977.5 995.8 1012.4 14520.7 15429.9 16387.8 16627.0 16788.6 895.7 918.1 921.9 943.7 943.7 9371.9 9634.7 9637.6 9704.6 9836.2 425887.0 436856.0 440056.0 441628.0 442779.0 55652.7 69888.0 71933.3 72076.6 77609.0 978.8 991.8 994.6 1012.8 1016.8 15496.8 15556.4 15567.0 15677.4 15798.8 32065.5 32845.2 33473.2 33786.8 33985.0 44539.3 47121.8 48103.0 48447.8 48464.5 7660.7 7681.4 7691.3 7766.3 7781.1 8763.3 11176.0 12729.9 13080.9 13206.0 11061.9 11226.3 11315.2 11343.4 11454.9 10633.7 11288.9 11343.1 11351.9 11413.0 7556.9 9605.6 10678.4 11368.1 11701.6 7657.6 7673.2 7805.0 7897.8 8033.6 10717.1 10725.9 10842.9 11039.9 11045.3 14:36:06 INFO - PROCESS | 16828 | 14:36:06 INFO - PROCESS | 16828 | [#3] mootools.html Cycles:180 Average:5311.96 Median:6243.83 stddev:2743.52 (43.9%) stddev-sans-first:2736.05 14:36:06 INFO - PROCESS | 16828 | Values: 1474.8 1480.2 1650.1 1751.7 1797.7 6756.6 7434.8 7445.6 7592.2 7667.7 7454.2 7534.0 7551.5 7656.3 7665.3 2275.3 2311.5 2319.0 2320.2 2322.1 2349.9 2358.6 2373.3 2383.0 2384.7 2259.3 2269.6 2274.2 2290.4 2296.1 2273.3 2303.7 2309.1 2309.2 2316.2 2279.7 2315.2 2317.2 2319.2 2325.9 7783.9 7846.5 7847.6 7853.1 7856.9 4728.7 4852.3 4855.3 4860.4 4871.1 3045.8 3049.6 3159.5 3160.8 3175.2 945.8 959.0 960.5 962.6 974.0 10371.6 10451.3 10482.4 10491.1 10504.4 4085.8 4132.0 4168.0 4240.9 4246.3 8379.4 8386.9 8426.8 8449.5 8465.8 4657.1 4676.6 4680.4 4700.9 4701.3 3869.6 4259.9 4318.7 4320.7 4353.2 3427.3 3442.6 3461.7 3484.1 3490.5 986.7 997.2 1012.1 1018.0 1039.0 1289.5 1356.6 1372.6 1373.3 1373.8 6964.2 6977.1 7060.0 7131.3 7163.5 453.2 455.9 456.3 459.5 486.3 5602.5 5640.8 5640.9 5669.0 5691.2 9006.4 9016.1 9248.2 9294.6 9334.5 9161.7 9187.7 9189.8 9203.0 9240.3 7111.4 7115.7 7228.6 7246.5 7271.8 6803.4 6817.2 6830.0 6833.3 6863.0 8065.6 8203.8 8302.5 8408.7 8436.6 8401.8 8476.7 8488.2 8514.3 8597.8 6272.8 6512.3 6634.3 6727.0 6734.1 7207.4 7251.3 7290.5 7305.4 7339.0 6500.0 6702.4 6775.8 6793.5 6907.9 6543.0 6558.6 6659.2 6689.9 6714.5 6752.0 6788.3 6849.0 6854.0 6944.3 5826.2 5917.8 5922.5 5930.6 5944.7 6158.7 6179.3 6230.9 6256.7 6265.2 14:36:06 INFO - PROCESS | 16828 | 14:36:06 INFO - PROCESS | 16828 | [#4] prototype.html Cycles:180 Average:5520.85 Median:6320.06 stddev:1713.72 (27.1%) stddev-sans-first:1673.21 14:36:06 INFO - PROCESS | 16828 | Values: 304.6 308.1 331.2 335.2 340.4 6207.6 6293.3 6302.7 6304.7 6349.5 6155.6 6160.3 6167.7 6175.9 6185.5 4548.3 4650.5 4653.0 4692.5 4724.1 4678.9 4704.2 4711.6 4712.5 4725.2 4648.3 4648.9 4658.6 4673.7 4682.4 4655.6 4670.8 4671.1 4682.8 4683.0 4032.5 4037.3 4046.7 4048.1 4049.5 5911.7 5926.1 5931.9 5939.0 5960.5 5218.3 5428.7 5436.4 5439.5 5439.5 6533.0 6590.3 6644.6 6647.3 6649.3 4436.5 4442.8 4447.3 4459.9 4461.7 6843.8 6905.3 6917.2 6921.7 6922.9 4461.0 4465.3 4532.5 4548.7 4573.9 4587.1 4599.5 4607.9 4621.9 4631.5 5396.7 5417.1 5430.9 5431.3 5432.8 6608.8 6631.4 6677.6 6678.6 6684.9 1609.0 1635.4 1637.1 1638.0 1639.6 1032.5 1040.8 1058.9 1061.9 1087.9 6314.8 6332.6 6334.0 6347.7 6349.1 6737.6 6779.2 6803.2 6825.5 6835.4 6306.4 6325.3 6333.0 6339.3 6343.1 3673.7 3697.7 3698.5 3699.8 3702.9 6997.5 7154.3 7177.9 7229.6 7235.6 6995.0 7003.4 7013.2 7022.6 7024.7 7190.2 7193.1 7199.6 7202.1 7206.5 6814.9 6820.3 6825.3 6832.9 6833.8 6556.8 6778.2 6843.5 6849.8 6855.1 7234.5 7249.6 7268.3 7292.8 7307.7 4542.8 4561.9 4582.8 4583.0 4586.4 6758.3 6854.9 6912.6 6912.9 6923.9 6689.4 6705.4 6710.6 6711.1 6719.4 6707.1 6708.9 6710.1 6710.6 6720.7 6467.3 6483.7 6531.5 6531.8 6547.1 6554.5 6734.4 6736.9 6748.2 6760.6 6545.5 6565.7 6569.3 6572.6 6576.4 14:36:06 INFO - PROCESS | 16828 | 14:36:06 INFO - PROCESS | 16828 | [#5] yui.html Cycles:180 Average:13480.55 Median:4408.17 stddev:15073.95 (342.0%) stddev-sans-first:15086.25 14:36:06 INFO - PROCESS | 16828 | Values: 817.9 827.7 829.9 830.4 832.4 12924.8 12942.7 12990.0 13081.3 13091.1 13023.9 13263.3 13822.3 13912.8 13967.2 690.4 827.2 837.0 838.8 841.9 827.9 841.9 847.3 847.7 848.0 875.7 876.9 876.9 877.0 879.5 865.9 872.0 873.5 875.0 876.5 643.5 648.2 648.2 649.8 650.2 13799.6 13833.0 13839.0 13883.1 13909.4 13289.7 13446.2 13657.7 13681.7 13775.9 10718.0 10849.6 10854.9 10880.8 11532.0 3677.8 3717.9 3788.2 3829.9 3835.1 44458.6 44905.3 45043.1 45342.0 45483.3 9977.5 10082.4 10123.1 10145.9 10195.1 17793.6 17827.0 17838.5 17872.9 17937.6 7472.1 7657.0 7685.1 7708.8 7825.0 4363.1 4401.3 4415.0 4525.9 4551.5 3034.2 3036.4 3046.0 3052.6 3071.7 551.4 554.9 563.5 577.2 577.2 569.4 645.3 656.1 680.9 684.6 8289.4 8689.2 8712.9 8768.2 8797.3 648.2 660.3 662.9 666.1 671.6 3816.5 3836.5 3907.5 3988.8 4029.5 53436.0 54107.2 54411.5 54513.0 54778.7 49276.8 49797.5 49856.8 49923.0 50021.0 43480.8 43755.0 44250.6 44426.1 44546.3 7606.0 7701.7 7726.4 7750.8 7760.3 33941.5 34156.5 34180.1 34712.1 35344.3 38938.4 39929.6 42290.8 42368.4 42459.8 10389.2 10416.5 10423.2 10580.8 11090.8 12181.1 12243.3 12390.6 12465.3 12793.4 11374.5 11432.9 11646.1 11769.7 12240.3 11570.3 11592.7 11726.9 11875.3 12132.2 10791.2 10905.1 11613.0 11913.8 11969.1 9833.2 9988.7 10020.0 10125.2 10349.4 9164.3 9241.7 9674.3 9894.6 9961.8 14:36:06 INFO - PROCESS | 16828 | -------- Summary: end -------- 14:36:06 INFO - PROCESS | 16828 | 14:36:06 INFO - PROCESS | 16828 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:36:06 INFO - PROCESS | 16828 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:36:06 INFO - PROCESS | 16828 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:36:06 INFO - PROCESS | 16828 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:36:06 INFO - PROCESS | 16828 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:36:06 INFO - PROCESS | 16828 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:36:06 INFO - PROCESS | 16828 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:36:06 INFO - PROCESS | 16828 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:36:06 INFO - TEST-INFO | 16828: exit 0 14:36:06 INFO - TEST-OK | dromaeo_css | took 1110011ms 14:36:06 INFO - TEST-START | kraken 14:36:06 INFO - operating with platform_type : linux_ 14:36:06 INFO - Initialising browser for kraken test... 14:36:06 INFO - TEST-INFO | started process 17062 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDKPkTv/profile http://localhost:43734/getInfo.html) 14:36:10 INFO - PROCESS | 17062 | 14:36:10 INFO - PROCESS | 17062 | (process:17130): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:36:11 INFO - PROCESS | 17062 | __metrics Screen width/height:1600/1200 14:36:11 INFO - PROCESS | 17062 | colorDepth:24 14:36:11 INFO - PROCESS | 17062 | Browser inner width/height: 1024/697 14:36:11 INFO - PROCESS | 17062 | __metrics 14:36:11 ERROR - PROCESS | 17062 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 14:36:11 INFO - PROCESS | 17062 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:36:11 INFO - PROCESS | 17062 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:36:11 INFO - PROCESS | 17062 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:36:11 INFO - PROCESS | 17062 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:36:11 INFO - PROCESS | 17062 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:36:11 INFO - PROCESS | 17062 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:36:11 INFO - PROCESS | 17062 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:36:11 INFO - PROCESS | 17062 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:36:11 INFO - PROCESS | 17062 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:36:12 INFO - TEST-INFO | 17062: exit 0 14:36:12 INFO - Browser initialized. 14:36:12 INFO - Running cycle 1/1 for kraken test... 14:36:12 INFO - TEST-INFO | started process 17181 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDKPkTv/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:36:13 INFO - PROCESS | 17181 | 14:36:13 INFO - PROCESS | 17181 | (process:17238): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:36:24 INFO - PROCESS | 17181 | RSS: Main: 161116160 14:36:24 INFO - PROCESS | 17181 | 14:36:26 INFO - PROCESS | 17181 | Cycle 1(1): loaded http://localhost:43734/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43734/tests/kraken/driver.html?testName=audio-beat-detection) 14:36:27 INFO - PROCESS | 17181 | RSS: Main: 167309312 14:36:27 INFO - PROCESS | 17181 | 14:36:30 INFO - PROCESS | 17181 | Cycle 1(1): loaded http://localhost:43734/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43734/tests/kraken/driver.html?testName=audio-dft) 14:36:30 INFO - PROCESS | 17181 | RSS: Main: 170274816 14:36:30 INFO - PROCESS | 17181 | 14:36:33 INFO - PROCESS | 17181 | Cycle 1(1): loaded http://localhost:43734/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43734/tests/kraken/driver.html?testName=audio-fft) 14:36:34 INFO - PROCESS | 17181 | RSS: Main: 164556800 14:36:34 INFO - PROCESS | 17181 | 14:36:36 INFO - PROCESS | 17181 | Cycle 1(1): loaded http://localhost:43734/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43734/tests/kraken/driver.html?testName=audio-oscillator) 14:36:37 INFO - PROCESS | 17181 | RSS: Main: 163954688 14:36:37 INFO - PROCESS | 17181 | 14:36:39 INFO - PROCESS | 17181 | Cycle 1(1): loaded http://localhost:43734/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43734/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:36:39 INFO - PROCESS | 17181 | RSS: Main: 164323328 14:36:39 INFO - PROCESS | 17181 | 14:36:42 INFO - PROCESS | 17181 | Cycle 1(1): loaded http://localhost:43734/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43734/tests/kraken/driver.html?testName=imaging-darkroom) 14:36:43 INFO - PROCESS | 17181 | RSS: Main: 165720064 14:36:43 INFO - PROCESS | 17181 | 14:36:46 INFO - PROCESS | 17181 | Cycle 1(1): loaded http://localhost:43734/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43734/tests/kraken/driver.html?testName=imaging-desaturate) 14:36:47 INFO - PROCESS | 17181 | RSS: Main: 166494208 14:36:47 INFO - PROCESS | 17181 | 14:36:50 INFO - PROCESS | 17181 | Cycle 1(1): loaded http://localhost:43734/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43734/tests/kraken/driver.html?testName=json-parse-financial) 14:36:50 INFO - PROCESS | 17181 | RSS: Main: 166547456 14:36:50 INFO - PROCESS | 17181 | 14:36:52 INFO - PROCESS | 17181 | Cycle 1(1): loaded http://localhost:43734/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43734/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:36:52 INFO - PROCESS | 17181 | RSS: Main: 166920192 14:36:52 INFO - PROCESS | 17181 | 14:36:54 INFO - PROCESS | 17181 | Cycle 1(1): loaded http://localhost:43734/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43734/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:36:55 INFO - PROCESS | 17181 | RSS: Main: 164851712 14:36:55 INFO - PROCESS | 17181 | 14:36:57 INFO - PROCESS | 17181 | Cycle 1(1): loaded http://localhost:43734/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43734/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:36:58 INFO - PROCESS | 17181 | RSS: Main: 165072896 14:36:58 INFO - PROCESS | 17181 | 14:37:00 INFO - PROCESS | 17181 | Cycle 1(1): loaded http://localhost:43734/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43734/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:37:01 INFO - PROCESS | 17181 | RSS: Main: 166563840 14:37:01 INFO - PROCESS | 17181 | 14:37:03 INFO - PROCESS | 17181 | Cycle 1(1): loaded http://localhost:43734/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43734/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:37:04 INFO - PROCESS | 17181 | RSS: Main: 166973440 14:37:04 INFO - PROCESS | 17181 | 14:37:06 INFO - PROCESS | 17181 | Cycle 1(1): loaded http://localhost:43734/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43734/tests/kraken/driver.html?testName=ai-astar) 14:37:06 INFO - PROCESS | 17181 | RSS: Main: 166830080 14:37:06 INFO - PROCESS | 17181 | 14:37:06 INFO - PROCESS | 17181 | __start_tp_report 14:37:06 INFO - PROCESS | 17181 | _x_x_mozilla_page_load 14:37:06 INFO - PROCESS | 17181 | _x_x_mozilla_page_load_details 14:37:06 INFO - PROCESS | 17181 | |i|pagename|runs| 14:37:06 INFO - PROCESS | 17181 | |0;ai-astar;113;109;112;113;111;123;111;110;114;114 14:37:06 INFO - PROCESS | 17181 | |1;audio-beat-detection;159;128;154;164;126;146;158;127;171;125 14:37:06 INFO - PROCESS | 17181 | |2;audio-dft;162;163;163;164;163;160;163;162;173;164 14:37:06 INFO - PROCESS | 17181 | |3;audio-fft;73;75;75;74;73;75;75;132;73;72 14:37:06 INFO - PROCESS | 17181 | |4;audio-oscillator;94;97;148;96;95;96;144;96;96;143 14:37:06 INFO - PROCESS | 17181 | |5;imaging-gaussian-blur;120;116;115;116;115;115;116;115;116;116 14:37:06 INFO - PROCESS | 17181 | |6;imaging-darkroom;146;147;147;147;147;147;147;149;147;147 14:37:06 INFO - PROCESS | 17181 | |7;imaging-desaturate;96;97;97;97;97;97;96;97;96;106 14:37:06 INFO - PROCESS | 17181 | |8;json-parse-financial;56;58;56;55;57;56;56;56;55;53 14:37:06 INFO - PROCESS | 17181 | |9;json-stringify-tinderbox;66;66;67;67;68;68;67;68;67;68 14:37:06 INFO - PROCESS | 17181 | |10;stanford-crypto-aes;85;85;92;85;85;95;96;90;87;85 14:37:06 INFO - PROCESS | 17181 | |11;stanford-crypto-ccm;126;122;118;126;123;117;119;130;117;117 14:37:06 INFO - PROCESS | 17181 | |12;stanford-crypto-pbkdf2;146;157;157;156;162;145;156;165;156;148 14:37:06 INFO - PROCESS | 17181 | |13;stanford-crypto-sha256-iterative;72;70;71;69;70;74;71;73;72;71 14:37:06 INFO - PROCESS | 17181 | __end_tp_report 14:37:06 INFO - PROCESS | 17181 | __start_cc_report 14:37:06 INFO - PROCESS | 17181 | _x_x_mozilla_cycle_collect,772 14:37:06 INFO - PROCESS | 17181 | __end_cc_report 14:37:06 INFO - PROCESS | 17181 | __startTimestamp1456785426409__endTimestamp 14:37:06 INFO - PROCESS | 17181 | 14:37:06 INFO - PROCESS | 17181 | ------- Summary: start ------- 14:37:06 INFO - PROCESS | 17181 | Number of tests: 14 14:37:06 INFO - PROCESS | 17181 | 14:37:06 INFO - PROCESS | 17181 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.00 stddev:3.89 (3.4%) stddev-sans-first:4.12 14:37:06 INFO - PROCESS | 17181 | Values: 113.0 109.0 112.0 113.0 111.0 123.0 111.0 110.0 114.0 114.0 14:37:06 INFO - PROCESS | 17181 | 14:37:06 INFO - PROCESS | 17181 | [#1] audio-beat-detection Cycles:10 Average:145.80 Median:156.00 stddev:17.80 (11.4%) stddev-sans-first:18.23 14:37:06 INFO - PROCESS | 17181 | Values: 159.0 128.0 154.0 164.0 126.0 146.0 158.0 127.0 171.0 125.0 14:37:06 INFO - PROCESS | 17181 | 14:37:06 INFO - PROCESS | 17181 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.00 stddev:3.47 (2.1%) stddev-sans-first:3.62 14:37:06 INFO - PROCESS | 17181 | Values: 162.0 163.0 163.0 164.0 163.0 160.0 163.0 162.0 173.0 164.0 14:37:06 INFO - PROCESS | 17181 | 14:37:06 INFO - PROCESS | 17181 | [#3] audio-fft Cycles:10 Average:79.70 Median:74.50 stddev:18.41 (24.7%) stddev-sans-first:19.37 14:37:06 INFO - PROCESS | 17181 | Values: 73.0 75.0 75.0 74.0 73.0 75.0 75.0 132.0 73.0 72.0 14:37:06 INFO - PROCESS | 17181 | 14:37:06 INFO - PROCESS | 17181 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:96.00 stddev:23.85 (24.8%) stddev-sans-first:24.54 14:37:06 INFO - PROCESS | 17181 | Values: 94.0 97.0 148.0 96.0 95.0 96.0 144.0 96.0 96.0 143.0 14:37:06 INFO - PROCESS | 17181 | 14:37:06 INFO - PROCESS | 17181 | [#5] imaging-gaussian-blur Cycles:10 Average:116.00 Median:116.00 stddev:1.49 (1.3%) stddev-sans-first:0.53 14:37:06 INFO - PROCESS | 17181 | Values: 120.0 116.0 115.0 116.0 115.0 115.0 116.0 115.0 116.0 116.0 14:37:06 INFO - PROCESS | 17181 | 14:37:06 INFO - PROCESS | 17181 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 14:37:06 INFO - PROCESS | 17181 | Values: 146.0 147.0 147.0 147.0 147.0 147.0 147.0 149.0 147.0 147.0 14:37:06 INFO - PROCESS | 17181 | 14:37:06 INFO - PROCESS | 17181 | [#7] imaging-desaturate Cycles:10 Average:97.60 Median:97.00 stddev:2.99 (3.1%) stddev-sans-first:3.11 14:37:06 INFO - PROCESS | 17181 | Values: 96.0 97.0 97.0 97.0 97.0 97.0 96.0 97.0 96.0 106.0 14:37:06 INFO - PROCESS | 17181 | 14:37:06 INFO - PROCESS | 17181 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:56.00 stddev:1.32 (2.4%) stddev-sans-first:1.39 14:37:06 INFO - PROCESS | 17181 | Values: 56.0 58.0 56.0 55.0 57.0 56.0 56.0 56.0 55.0 53.0 14:37:06 INFO - PROCESS | 17181 | 14:37:06 INFO - PROCESS | 17181 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.50 stddev:0.79 (1.2%) stddev-sans-first:0.71 14:37:06 INFO - PROCESS | 17181 | Values: 66.0 66.0 67.0 67.0 68.0 68.0 67.0 68.0 67.0 68.0 14:37:06 INFO - PROCESS | 17181 | 14:37:06 INFO - PROCESS | 17181 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:88.50 stddev:4.43 (5.0%) stddev-sans-first:4.51 14:37:06 INFO - PROCESS | 17181 | Values: 85.0 85.0 92.0 85.0 85.0 95.0 96.0 90.0 87.0 85.0 14:37:06 INFO - PROCESS | 17181 | 14:37:06 INFO - PROCESS | 17181 | [#11] stanford-crypto-ccm Cycles:10 Average:121.50 Median:122.50 stddev:4.65 (3.8%) stddev-sans-first:4.64 14:37:06 INFO - PROCESS | 17181 | Values: 126.0 122.0 118.0 126.0 123.0 117.0 119.0 130.0 117.0 117.0 14:37:06 INFO - PROCESS | 17181 | 14:37:06 INFO - PROCESS | 17181 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.80 Median:156.50 stddev:6.58 (4.2%) stddev-sans-first:6.16 14:37:06 INFO - PROCESS | 17181 | Values: 146.0 157.0 157.0 156.0 162.0 145.0 156.0 165.0 156.0 148.0 14:37:06 INFO - PROCESS | 17181 | 14:37:06 INFO - PROCESS | 17181 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:71.50 stddev:1.49 (2.1%) stddev-sans-first:1.56 14:37:06 INFO - PROCESS | 17181 | Values: 72.0 70.0 71.0 69.0 70.0 74.0 71.0 73.0 72.0 71.0 14:37:06 INFO - PROCESS | 17181 | -------- Summary: end -------- 14:37:06 INFO - PROCESS | 17181 | 14:37:06 INFO - PROCESS | 17181 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:37:06 INFO - PROCESS | 17181 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:37:06 INFO - PROCESS | 17181 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:37:06 INFO - PROCESS | 17181 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:37:06 INFO - PROCESS | 17181 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:37:06 INFO - PROCESS | 17181 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:37:06 INFO - PROCESS | 17181 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:37:06 INFO - PROCESS | 17181 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:37:07 INFO - TEST-INFO | 17181: exit 0 14:37:07 INFO - TEST-OK | kraken | took 60443ms 14:37:07 INFO - SUITE-END | took 1170s 14:37:07 INFO - Completed test suite (00:19:30) 14:37:07 INFO - Working with test: dromaeo_css 14:37:07 INFO - Generating results file: dromaeo_css 14:37:07 INFO - Working with test: kraken 14:37:07 INFO - Generating results file: kraken 14:37:07 INFO - javascript benchmark 14:37:07 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:37:07 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 14:37:07 INFO - process_Request line: dromaeo_css 6842.35 graph.html#tests=[[72,64,43]] 14:37:07 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:37:07 INFO - process_Request line: kraken 1532.50 graph.html#tests=[[232,64,43]] 14:37:07 INFO - RETURN: dromaeo_css: 6842.35 14:37:07 INFO - RETURN: kraken: 1532.50 14:37:07 INFO - javascript benchmark 14:37:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3203.519472079188, 3216.758743094267, 3236.967630323699, 3256.3975664502063, 3265.16738231751, 5144.819931302405, 5205.947940520594, 5215.895682086356, 5231.163013917774, 5253.133233016548, 5081.872953176173, 5162.6644268122545, 5177.689338639684, 5196.194589838572, 5218.791248350061, 4713.528647135285, 4781.737004464753, 4851.733154676509, 4910.140725373046, 4941.925871111936, 483.7222693242813, 4700.717956922578, 4791.808327666907, 4809.951900481003, 4852.150873597124, 4771.9761401192945, 4781.211100168468, 4798.4001999750035, 4798.616110711152, 4817.445993710716, 4731.124741922756, 4779.068081724065, 4817.132916075105, 4821.662483626147, 4891.682040667345, 4696.600788932945, 4726.385569875929, 4732.716037037789, 4736.550027747358, 4786.7845946932475, 5098.668586541863, 5108.463611320833, 5121.4622464641425, 5163.406208286057, 5200.167973124319, 5462.808801691922, 5497.367802702701, 5627.352854421712, 5631.549476041907, 5646.124850648156, 5581.386047534768, 5612.719364031782, 5626.043572592628, 5645.943540564624, 5679.829605111853, 5184.559312458446, 5218.921716174261, 5225.085610018232, 5225.947740522584, 5292.047431462373, 5548.77804887808, 5635.0, 5656.321241451053, 5679.091345384719, 5681.375048744635, 5382.865428364322, 5398.78404863801, 5420.7289635518855, 5427.1045277528765, 5441.075017247077, 5525.613207075547, 5553.111502159635, 5576.219329293902, 5587.552995760329, 5614.6631202128, 5470.972645136749, 5475.315585551806, 5478.643888147338, 5489.58828087887, 5490.505854473116, 5474.781008759605, 5502.064649009678, 5552.666839989613, 5614.69119198448, 5641.943580564224, 4218.34615634571, 4237.978810105929, 4248.638865696388, 4256.233877901946, 4284.843092365107, 3818.4610475088402, 3833.654971052563, 3851.8844434667003, 3874.2057878134915, 3898.6101389861356, 5163.535281824654, 5251.711155886463, 5276.472352764693, 5328.706921119298, 5374.650647707965, 5562.97085039269, 5620.690862002547, 5624.072028115397, 5640.097584386478, 5664.0, 5124.718140502234, 5308.601854860901, 5326.041312563776, 5332.413434522199, 5376.7042812644895, 4654.25531914892, 4656.41794775653, 4675.485696573374, 4701.271302948048, 4718.2214934536105, 5556.805511807067, 5560.694161821058, 5570.303712035996, 5575.386707462176, 5584.748686309044, 5432.429594892479, 5445.319335083114, 5461.044317244546, 5467.589930755209, 5567.0, 5802.071668533014, 5811.128330750252, 5814.796482123105, 5875.559333049953, 5912.083627037816, 5526.47498487643, 5548.583856210719, 5549.139883318092, 5553.500184983371, 5556.916646250229, 5531.197976293495, 5603.243562119062, 5646.689432081275, 5673.319201695823, 5735.655860648374, 5495.395506494362, 5500.1749737539685, 5504.862378440411, 5506.256655351476, 5526.309211348582, 5464.590155738256, 5475.0, 5485.945140548543, 5497.3952865184, 5541.362743284574, 5247.475252474722, 5266.07843627356, 5311.336082989626, 5373.731313434391, 5377.650452720561, 5311.41574426805, 5509.779608815603, 5516.889662206653, 5535.3634332050715, 5561.249231353715, 5350.652207606493, 5381.461853814587, 5433.5381492572, 5442.292501974718, 5450.618456707993], "unit": "score", "name": "dojo.html", "value": 5119.055991512956}, {"lowerIsBetter": false, "replicates": [490.24257522128306, 521.7886755863875, 541.7237209023397, 551.0494397164891, 608.7443273824993, 30587.69412305876, 36890.26219475609, 37386.813065934635, 37512.62487375126, 37748.433773493416, 40479.79760101195, 40782.79608601953, 41013.179736405255, 41066.58933410665, 41310.0, 8518.275946544536, 8842.602082906253, 8844.690435834747, 8851.69019084329, 8862.11378862115, 8642.222200002, 8730.388872778907, 8744.737657870273, 8787.25308348788, 8812.1187881212, 8704.782380440476, 8850.114988501162, 8875.95562022189, 8885.067067957869, 8888.022317545065, 8661.13388661132, 8804.119588041145, 8806.295496360308, 8827.558622068871, 8845.734627961172, 8616.913830861673, 8771.561421928878, 8773.561321933877, 8785.165409286108, 8790.077041910572, 41064.58935410638, 41259.381109283386, 41276.587234127575, 41496.585034149575, 41541.37687934683, 3182.2839861031084, 3363.83180840957, 3485.5468789057513, 3716.684081853046, 4085.1829634073306, 26823.195304140907, 27464.450710985868, 27528.311792205153, 27585.172444826687, 27712.307192320153, 3846.173072789336, 3951.940720889189, 3977.8607748728655, 4018.9196216075807, 4114.670826333886, 230271.0, 231123.0, 231668.0, 232928.0, 233560.0, 42872.57127428748, 43171.78414107972, 43236.567634323255, 57808.71095644495, 58030.0, 39993.0, 40408.19183616311, 40516.0, 40609.79695101506, 40653.0, 13419.664508387368, 13518.526851560147, 13566.186028838103, 13570.321483925763, 13649.385777640031, 11764.411779410995, 11915.52337906474, 11947.103967202494, 11961.401929903644, 12032.39838008096, 14053.78919316211, 14067.226302553458, 14105.435782568582, 14146.929265353607, 14148.151110933377, 5533.446655334435, 5617.83159493259, 5629.802956896489, 5631.915521267184, 5671.829845104653, 956.9665061722807, 972.615816752393, 1022.5960745505483, 1042.7393151712072, 1049.7847941172042, 28882.566761498594, 29344.559831602543, 29350.706492935224, 29415.76426593073, 29615.851920740257, 1064.9361038337724, 1074.3661239868516, 1080.195254535376, 1120.0759373516719, 1123.1576317761678, 14997.550073497812, 15041.699166016619, 15224.923875380553, 15435.536933892, 15483.380664773507, 288286.0, 293640.0, 295449.0, 296089.0, 296617.0, 53777.73111134419, 53983.0, 54396.0, 54548.0, 54595.0, 1250.1748845761754, 1307.1438207973792, 1327.482281910056, 1329.9135556188817, 1338.5315139701027, 28421.289467763472, 28998.27504312409, 29176.01218872577, 29510.409791803613, 29594.0, 46839.0, 47058.29412558746, 47125.764371177924, 47203.76398117987, 47507.52492475031, 278382.0, 278424.0, 278727.0, 279152.0, 279176.0, 32625.510617341235, 32717.0, 32875.17812054718, 32905.17737056593, 33091.00726978194, 43916.56083439253, 44562.55437445584, 44563.0, 44709.55290447184, 45197.74011299488, 37095.25809483849, 37297.25405491821, 37611.2477750438, 37816.81091594524, 37942.43086353762, 36567.4503378865, 37159.0, 37338.43992340063, 37683.81158094192, 38114.0, 35916.64083359133, 36054.84404407747, 36189.0, 36771.81614091912, 37107.628923710414, 33050.66949330476, 34002.489962650085, 34356.31287374189, 34625.653743462244, 34767.30465390627, 25360.619590706523, 25847.741522584533, 25892.46452128708, 26052.0, 26053.869730651226], "unit": "score", "name": "ext.html", "value": 17799.801836318555}, {"lowerIsBetter": false, "replicates": [353.6604859335038, 353.9168295450569, 359.4482469409455, 360.5601166576776, 363.249888979258, 16260.593485162877, 16819.83180168198, 17376.04431756253, 17409.30362785487, 17416.56458588536, 17021.57446063849, 17312.913435432838, 17488.912555437237, 17629.11854407278, 17726.64546709065, 5325.174597937326, 5336.38631557372, 5507.586930980173, 5522.0, 5565.582581306398, 5424.891502169974, 5505.834824955257, 5511.448855114497, 5528.695921724304, 5536.640118392292, 5439.673619582818, 5488.341399032121, 5500.889982200353, 5690.118031705092, 5704.686242256675, 5408.675479471244, 5552.833414997556, 5591.4688104629995, 5612.635178713371, 5625.493705566499, 5379.946200537984, 5419.620626556142, 5423.376311724123, 5424.321959755031, 5427.755750991215, 13088.738225235536, 13326.466941322335, 15251.38994440221, 20871.0, 20989.68515472269, 2085.092984551725, 2127.8297736181066, 2178.6623073423643, 2179.0738935952318, 2252.121672547708, 9241.445513269226, 9260.953695231481, 9755.073268039525, 10640.57437702491, 13059.412326445237, 1781.0827423876715, 1802.1980218802637, 1819.972700409495, 1837.0539172326262, 1892.139076720089, 63723.68138159326, 66019.66990165018, 66520.0, 67003.3299667002, 67113.0, 9632.711018669452, 9766.267529935283, 10056.094951454257, 10104.69685909424, 10204.948975255076, 12866.421011054525, 13191.340432978504, 13206.207627542379, 13210.273434960976, 13220.933895330461, 7496.0, 7592.354649854714, 7672.961635191788, 7798.0, 7798.376129909707, 7647.235276472308, 7678.846423071619, 7683.615819209129, 7766.339861111755, 7771.844563108819, 4319.827206911751, 4362.083962367875, 4382.276924307454, 4425.800838962255, 4520.276755719069, 1712.212382304154, 1737.348494314632, 1774.112943528236, 1789.5615574184408, 1790.561312478451, 888.9155530224618, 921.2721949659693, 977.5405559387077, 995.8406654935176, 1012.4178597306578, 14520.709585808436, 15429.922850385676, 16387.754183687255, 16627.0, 16788.580285492717, 895.7447127568612, 918.1094338491653, 921.9400738952081, 943.6649989253854, 943.719206323206, 9371.906280937239, 9634.71095867111, 9637.566309516089, 9704.611815527442, 9836.213102951746, 425887.0, 436856.0, 440056.0, 441628.0, 442779.0, 55652.72173639187, 69888.0, 71933.2806671937, 72076.63961680263, 77609.0, 978.7602037500716, 991.7718924647227, 994.5872462927804, 1012.8328825743818, 1016.7763092119721, 15496.767548487007, 15556.377744890531, 15567.0, 15677.372905083668, 15798.76301855496, 32065.519017214294, 32845.17887052843, 33473.163170920925, 33786.83106584451, 33985.0, 44539.331910022025, 47121.76439117782, 48103.0, 48447.75776121097, 48464.515354846, 7660.655270512952, 7681.385489160742, 7691.30778229962, 7766.262205090507, 7781.105172904962, 8763.342749293955, 11176.0, 12729.872701272869, 13080.869191308346, 13206.009549284034, 11061.889381106086, 11226.270292430965, 11315.151363647925, 11343.432828358384, 11454.885451145381, 10633.680989570325, 11288.887111129112, 11343.092552595937, 11351.943240283746, 11413.0, 7556.942028115958, 9605.615775368908, 10678.359298442118, 11368.090552755924, 11701.648950531498, 7657.57883316423, 7673.194314596887, 7804.9609751950875, 7897.802554935943, 8033.55815430157, 10717.089047431056, 10725.946370268099, 10842.945785271339, 11039.889601104207, 11045.28205666629], "unit": "score", "name": "jquery.html", "value": 8344.378683138733}, {"lowerIsBetter": false, "replicates": [1474.7640377539594, 1480.2154857925298, 1650.1089411717674, 1751.667183235186, 1797.7393277974693, 6756.594604323744, 7434.7769566913075, 7445.627718614068, 7592.20281870404, 7667.654955527, 7454.180040195574, 7534.0, 7551.471397002212, 7656.349210317116, 7665.310122089011, 2275.306031660347, 2311.5492478966607, 2319.0491898321693, 2320.176337400224, 2322.140807901079, 2349.9177528786495, 2358.6108292131776, 2373.2761507740133, 2383.0, 2384.654225137354, 2259.2770313499686, 2269.6255117905525, 2274.1812947339026, 2290.3930458428445, 2296.115995341797, 2273.295278463673, 2303.6659684345846, 2309.0763694522157, 2309.1571576374504, 2316.224064938248, 2279.7036385269976, 2315.2012555668434, 2317.2005658047947, 2319.2346525646667, 2325.9069637214493, 7783.949166862458, 7846.489978151402, 7847.568383738892, 7853.0576330840095, 7856.921430785676, 4728.66899317048, 4852.344933433977, 4855.295982082614, 4860.368152140234, 4871.050145221683, 3045.8477076146105, 3049.649290331618, 3159.5418664293547, 3160.7787454878166, 3175.158582975513, 945.8155659646371, 958.9616415343378, 960.5485421851719, 962.5524131278919, 973.9951300243524, 10371.636992705218, 10451.320664156881, 10482.371057736636, 10491.055804977588, 10504.369737815756, 4085.754854708727, 4131.97934010328, 4167.958010497376, 4240.915181696349, 4246.341817018367, 8379.413441059189, 8386.87419688705, 8426.789330266793, 8449.45078569891, 8465.830683386297, 4657.068586282757, 4676.555727205978, 4680.3915490985955, 4700.88247793801, 4701.318308845198, 3869.6130386961077, 4259.914801703949, 4318.697691161588, 4320.65434765218, 4353.172897149531, 3427.2802711430877, 3442.604100528421, 3461.671141241578, 3484.094135524782, 3490.458978858281, 986.7335819328885, 997.2122023601273, 1012.104287705386, 1017.9694609161737, 1038.9584416623402, 1289.5228765356878, 1356.572679605921, 1372.6499742565782, 1373.2790285100402, 1373.7527245095778, 6964.233934267328, 6977.092977912839, 7060.0, 7131.25121862197, 7163.534370265916, 453.1661742394011, 455.9293309536961, 456.26541268557594, 459.5289827926402, 486.26331108370846, 5602.523785478198, 5640.774369025193, 5640.943590564042, 5669.0, 5691.174779656926, 9006.369554131148, 9016.143466370684, 9248.21390181842, 9294.628214871465, 9334.486603236886, 9161.725148245563, 9187.678431254873, 9189.770255743526, 9203.0, 9240.260779137652, 7111.359977602041, 7115.715371385087, 7228.554289142193, 7246.456515761339, 7271.818204545035, 6803.353681400259, 6817.181938167451, 6830.009648601024, 6833.282505337067, 6863.039174515671, 8065.556394398364, 8203.83592328162, 8302.54336011525, 8408.747737567883, 8436.620352084048, 8401.789955251168, 8476.660933562835, 8488.151184881463, 8514.276286515715, 8597.785055373666, 6272.811815645356, 6512.3162067982175, 6634.303398143125, 6726.966365168143, 6734.124563806674, 7207.387372073433, 7251.347378735939, 7290.453216008927, 7305.41556675454, 7339.0, 6500.0, 6702.36327548882, 6775.796726098225, 6793.490488213502, 6907.896381554381, 6542.953127499577, 6558.606483610999, 6659.2008958925235, 6689.899651505329, 6714.52998290115, 6751.966240168767, 6788.287229840993, 6849.0, 6854.0, 6944.340287672663, 5826.242588463472, 5917.763289468545, 5922.496587790086, 5930.555208359304, 5944.6730429826775, 6158.661273629814, 6179.28938172098, 6230.937690623035, 6256.718447669775, 6265.216847894013], "unit": "score", "name": "mootools.html", "value": 4308.546335500755}, {"lowerIsBetter": false, "replicates": [304.58120084883285, 308.1018830110229, 331.18032868650096, 335.22395654060847, 340.42638154709323, 6207.627542347463, 6293.27627322858, 6302.668012835257, 6304.71628776705, 6349.492040636749, 6155.599886007406, 6160.260768707762, 6167.660778657172, 6175.876482470348, 6185.474234690057, 4548.31775233716, 4650.488446270908, 4653.0, 4692.530746925314, 4724.055188962204, 4678.883027924295, 4704.223803072489, 4711.552402521772, 4712.528747125294, 4725.196716558176, 4648.302754586822, 4648.883777905546, 4658.604018658418, 4673.696209746356, 4682.41469816273, 4655.604273636745, 4670.76646167692, 4671.089137618166, 4682.765861706901, 4683.0, 4032.5160980682213, 4037.3338399164104, 4046.6964977626794, 4048.0891799345204, 4049.473568436114, 5911.674857882815, 5926.081457374114, 5931.851703707442, 5939.049752039696, 5960.523158147338, 5218.330134357007, 5428.701421421821, 5436.401995780461, 5439.48324909133, 5439.5376393006245, 6533.0, 6590.340965903371, 6644.634545100018, 6647.3020332864835, 6649.3018233085795, 4436.489803672586, 4442.800073996678, 4447.288433850568, 4459.888502787424, 4461.665375096881, 6843.828904277383, 6905.309469053104, 6917.169939607229, 6921.653917304165, 6922.861542769117, 4460.977695111568, 4465.26323156682, 4532.524084971031, 4548.727076375362, 4573.931391029138, 4587.105514424655, 4599.494055653875, 4607.8848028798875, 4621.907561848744, 4631.513691062457, 5396.703181324986, 5417.079096553595, 5430.945690543044, 5431.321084864392, 5432.7555260012605, 6608.768693095719, 6631.403173714389, 6677.632730199788, 6678.6326752028135, 6684.899726504106, 1608.9919550402174, 1635.4030778765664, 1637.0750525953038, 1638.0, 1639.6064944413256, 1032.4631191780231, 1040.8490768838628, 1058.8570542976754, 1061.930974486656, 1087.8912108789057, 6314.810555683337, 6332.556721029484, 6334.049892516067, 6347.68261586928, 6349.079383489368, 6737.562058466184, 6779.15260592426, 6803.183617965876, 6825.48808839339, 6835.350641689031, 6306.400891915261, 6325.304216536178, 6332.968335158387, 6339.302676705559, 6343.080253363329, 3673.7244706646575, 3697.6672099511175, 3698.4637227601847, 3699.7780133192095, 3702.8889133326043, 6997.510174287852, 7154.320339567733, 7177.856442871113, 7229.566226026455, 7235.638218089074, 6995.0, 7003.404710599554, 7013.193482749447, 7022.613756243353, 7024.719011239596, 7190.173130090002, 7193.064901562763, 7199.568025918462, 7202.099737532913, 7206.531575447579, 6814.897776533257, 6820.31796820314, 6825.2833452486775, 6832.863342733018, 6833.829154271183, 6556.803295901131, 6778.152730908637, 6843.452523798183, 6849.794506164823, 6855.143107111611, 7234.457415693739, 7249.601271930094, 7268.27317268269, 7292.817679557841, 7307.671154798153, 4542.841575398253, 4561.863144105682, 4582.77086145698, 4583.037562111994, 4586.357909892685, 6758.290379510081, 6854.897176542256, 6912.585244885323, 6912.861742765217, 6923.861522769415, 6689.397954184147, 6705.396514313735, 6710.597364158166, 6711.0940023096255, 6719.361660642231, 6707.061011458302, 6708.932910670831, 6710.094137291599, 6710.6309152997055, 6720.663966801738, 6467.256265529524, 6483.675816209265, 6531.510136739668, 6531.836704082436, 6547.083408322934, 6554.4756419485375, 6734.393904548614, 6736.8652626946205, 6748.19021717397, 6760.594364338155, 6545.541812073299, 6565.671716414256, 6569.277379488348, 6572.605643661395, 6576.408123268929], "unit": "score", "name": "prototype.html", "value": 4950.353178601211}, {"lowerIsBetter": false, "replicates": [817.9141190175035, 827.6772058897031, 829.8507759353214, 830.410408609887, 832.3798769916413, 12924.806127908078, 12942.741145177091, 12990.0, 13081.345932703374, 13091.149075310099, 13023.94912054058, 13263.336833158352, 13822.308884555758, 13912.791308130387, 13967.231802250872, 690.4476418864913, 827.210014436215, 836.9830655753259, 838.7651457591884, 841.8947631546057, 827.8923739913803, 841.9284360829306, 847.2840449819923, 847.7160151349306, 848.0120659431755, 875.6672464463495, 876.8728534362546, 876.9254613357872, 876.9736907892742, 879.4942907827992, 865.8701194820765, 871.9520426376547, 873.4846440600045, 875.0461996423896, 876.4916348517844, 643.491641603133, 648.2059477140513, 648.2383199740286, 649.7693318871827, 650.151552224347, 13799.586012419644, 13833.0, 13839.0, 13883.097598656155, 13909.4436222552, 13289.734205315839, 13446.19322840623, 13657.658558536017, 13681.726365472734, 13775.862241377557, 10718.0, 10849.643794525684, 10854.891451085467, 10880.836787448194, 11532.0, 3677.760945538558, 3717.8698745543775, 3788.2423515296773, 3829.8659546916, 3835.117922877726, 44458.555414445764, 44905.326420103724, 45043.09913801739, 45342.0, 45483.31775023377, 9977.45124018186, 10082.395056296646, 10123.139533139618, 10145.898541014643, 10195.133413659774, 17793.555161120818, 17827.0, 17838.464846054638, 17872.91063544674, 17937.551561210814, 7472.140703819022, 7656.961715191388, 7685.116211635622, 7708.845823083507, 7825.0, 4363.149185908717, 4401.339799030171, 4415.0, 4525.886852828706, 4551.544845515422, 3034.180771191766, 3036.407900459433, 3046.040497243361, 3052.5879006334303, 3071.7081877221626, 551.4265164229237, 554.8501904485847, 563.5266376243975, 577.1544687033517, 577.177522031104, 569.4391024840529, 645.3385280087854, 656.1371796088129, 680.9290101641632, 684.5858255755296, 8289.4197406181, 8689.17452841979, 8712.912870871336, 8768.210861022539, 8797.317392042041, 648.2447948140458, 660.2769966886252, 662.8873091574444, 666.1074160624689, 671.6373158494456, 3816.5420149581673, 3836.48207491985, 3907.4529565860803, 3988.780617066031, 4029.49631296088, 53436.0, 54107.18839217415, 54411.45588544064, 54513.0, 54778.72610636921, 49276.75361623169, 49797.502024980015, 49856.75071624691, 49923.0, 50021.0, 43480.782596086814, 43755.0, 44250.55749442529, 44426.11147777026, 44546.33180502295, 7605.961970190114, 7701.691932322644, 7726.381889448943, 7750.806229844074, 7760.30157285847, 33941.49087763636, 34156.48765268473, 34180.14549636279, 34712.13219669528, 35344.29311413809, 38938.44246230232, 39929.60070399259, 42290.788546057076, 42368.364474533526, 42459.787701061294, 10389.168866490512, 10416.479176041319, 10423.166146708396, 10580.788384232119, 11090.833637495283, 12181.086418518824, 12243.32661703615, 12390.62828115158, 12465.314407707663, 12793.42429590652, 11374.488148033524, 11432.94283528577, 11646.126540509325, 11769.705757356134, 12240.326782026717, 11570.305781653127, 11592.710182245512, 11726.88273117258, 11875.346855923008, 12132.211406258564, 10791.190660700322, 10905.127589792639, 11613.0, 11913.761724765629, 11969.102317326062, 9833.164181044405, 9988.650397236062, 10020.0, 10125.240606954361, 10349.430781307101, 9164.312676549152, 9241.676541321021, 9674.274429417681, 9894.554745036634, 9961.750956226153], "unit": "score", "name": "yui.html", "value": 6327.441868121773}], "name": "dromaeo_css", "value": 6842.350170878594}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 109.0, 112.0, 113.0, 111.0, 123.0, 111.0, 110.0, 114.0, 114.0], "unit": "score", "name": "ai-astar", "value": 113.0}, {"lowerIsBetter": true, "replicates": [159.0, 128.0, 154.0, 164.0, 126.0, 146.0, 158.0, 127.0, 171.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 145.8}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 163.0, 164.0, 163.0, 160.0, 163.0, 162.0, 173.0, 164.0], "unit": "score", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 75.0, 74.0, 73.0, 75.0, 75.0, 132.0, 73.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.7}, {"lowerIsBetter": true, "replicates": [94.0, 97.0, 148.0, 96.0, 95.0, 96.0, 144.0, 96.0, 96.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 110.5}, {"lowerIsBetter": true, "replicates": [120.0, 116.0, 115.0, 116.0, 115.0, 115.0, 116.0, 115.0, 116.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.0}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 149.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 97.0, 97.0, 97.0, 96.0, 97.0, 96.0, 106.0], "unit": "score", "name": "imaging-desaturate", "value": 97.6}, {"lowerIsBetter": true, "replicates": [56.0, 58.0, 56.0, 55.0, 57.0, 56.0, 56.0, 56.0, 55.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.8}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 67.0, 67.0, 68.0, 68.0, 67.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 92.0, 85.0, 85.0, 95.0, 96.0, 90.0, 87.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.5}, {"lowerIsBetter": true, "replicates": [126.0, 122.0, 118.0, 126.0, 123.0, 117.0, 119.0, 130.0, 117.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.5}, {"lowerIsBetter": true, "replicates": [146.0, 157.0, 157.0, 156.0, 162.0, 145.0, 156.0, 165.0, 156.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 154.8}, {"lowerIsBetter": true, "replicates": [72.0, 70.0, 71.0, 69.0, 70.0, 74.0, 71.0, 73.0, 72.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.3}], "name": "kraken", "value": 1532.5}]} 14:37:07 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1532.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6842.35"}}} 14:37:07 INFO - Return code: 0 14:37:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:37:07 ERROR - # TBPL SUCCESS # 14:37:07 INFO - Running post-action listener: _resource_record_post_action 14:37:07 INFO - Running post-run listener: _resource_record_post_run 14:37:08 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 98304; Write bytes: 541081600; Read time: 512; Write time: 780516 14:37:08 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 4096; Write bytes: 247341056; Read time: 252; Write time: 477460 14:37:08 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 94208; Write bytes: 293736448; Read time: 260; Write time: 303056 14:37:08 INFO - Running post-run listener: _upload_blobber_files 14:37:08 INFO - Blob upload gear active. 14:37:08 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:37:08 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:37:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 14:37:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 14:37:09 INFO - (blobuploader) - INFO - Open directory for files ... 14:37:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:37:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:37:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:37:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:37:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:37:10 INFO - (blobuploader) - INFO - Done attempting. 14:37:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:37:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:37:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:37:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:37:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:37:10 INFO - (blobuploader) - INFO - Done attempting. 14:37:10 INFO - (blobuploader) - INFO - Iteration through files over. 14:37:10 INFO - Return code: 0 14:37:10 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:37:10 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:37:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ddd81cb3afc2556701189c0d02a0382140cc83f7b770785c1d1cfd3bdb0180f92e07e9e40125a44cddcf030716de961677e3d5a70118447eddb769c5f1d468ec", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68f1348c56401ce1dbe56f4b14e23f579c7b9b0b474b2003acda89227fde2be5045fd68e487d1930fedd3655e7eebaa7f978ebce3e1beff3b607612759667c0b"} 14:37:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:37:10 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:37:10 INFO - Contents: 14:37:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ddd81cb3afc2556701189c0d02a0382140cc83f7b770785c1d1cfd3bdb0180f92e07e9e40125a44cddcf030716de961677e3d5a70118447eddb769c5f1d468ec", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68f1348c56401ce1dbe56f4b14e23f579c7b9b0b474b2003acda89227fde2be5045fd68e487d1930fedd3655e7eebaa7f978ebce3e1beff3b607612759667c0b"} 14:37:10 INFO - Running post-run listener: copy_logs_to_upload_dir 14:37:10 INFO - Copying logs to upload dir... 14:37:10 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 14:37:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.586172 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-02-29 14:37:10.844867) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 14:37:10.848394) ========= 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=62c568580acbfdaac3eec7be000001dc-1456784199.979327-1473393899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ddd81cb3afc2556701189c0d02a0382140cc83f7b770785c1d1cfd3bdb0180f92e07e9e40125a44cddcf030716de961677e3d5a70118447eddb769c5f1d468ec", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68f1348c56401ce1dbe56f4b14e23f579c7b9b0b474b2003acda89227fde2be5045fd68e487d1930fedd3655e7eebaa7f978ebce3e1beff3b607612759667c0b"} build_url:https://queue.taskcluster.net/v1/task/Ef30RNz6R1WmGSRwmhtfvQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011218 build_url: 'https://queue.taskcluster.net/v1/task/Ef30RNz6R1WmGSRwmhtfvQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ddd81cb3afc2556701189c0d02a0382140cc83f7b770785c1d1cfd3bdb0180f92e07e9e40125a44cddcf030716de961677e3d5a70118447eddb769c5f1d468ec", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68f1348c56401ce1dbe56f4b14e23f579c7b9b0b474b2003acda89227fde2be5045fd68e487d1930fedd3655e7eebaa7f978ebce3e1beff3b607612759667c0b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 14:37:10.876452) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 14:37:10.877222) ========= 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=62c568580acbfdaac3eec7be000001dc-1456784199.979327-1473393899 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004415 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 14:37:10.960793) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 14:37:10.961515) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 14:37:10.962144) ========= ========= Total master_lag: 0.26 =========