builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-004 starttime: 1456610896.53 results: success (0) buildid: 20160227113018 builduid: 0599bbd7c5734f84a19fd295b6f8351b revision: aba2c94b1bf8d1b0423205a8b45e442c4b35252d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-27 14:08:16.534638) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-27 14:08:16.535473) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-27 14:08:16.535798) ========= 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=c6927cf182745ad25b1d38b9000001fe-1456608482.192647-1456463062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.009184 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-27 14:08:16.572315) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-27 14:08:16.572589) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-27 14:08:16.599621) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 14:08:16.599892) ========= 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=c6927cf182745ad25b1d38b9000001fe-1456608482.192647-1456463062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004692 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 14:08:16.650498) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-27 14:08:16.650776) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-27 14:08:16.651125) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 14:08:16.651760) ========= 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=c6927cf182745ad25b1d38b9000001fe-1456608482.192647-1456463062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-27 14:08:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2016-02-27 14:08:17 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.185911 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 14:08:16.858059) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 14:08:16.858384) ========= 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=c6927cf182745ad25b1d38b9000001fe-1456608482.192647-1456463062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014009 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 14:08:16.927666) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 14:08:16.928012) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev aba2c94b1bf8d1b0423205a8b45e442c4b35252d --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 aba2c94b1bf8d1b0423205a8b45e442c4b35252d --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=c6927cf182745ad25b1d38b9000001fe-1456608482.192647-1456463062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-27 14:08:17,717 truncating revision to first 12 chars 2016-02-27 14:08:17,717 Setting DEBUG logging. 2016-02-27 14:08:17,717 attempt 1/10 2016-02-27 14:08:17,717 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/aba2c94b1bf8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-27 14:08:18,038 unpacking tar archive at: fx-team-aba2c94b1bf8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.628620 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 14:08:17.569350) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-27 14:08:17.569690) ========= echo aba2c94b1bf8d1b0423205a8b45e442c4b35252d in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'aba2c94b1bf8d1b0423205a8b45e442c4b35252d'] 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=c6927cf182745ad25b1d38b9000001fe-1456608482.192647-1456463062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False aba2c94b1bf8d1b0423205a8b45e442c4b35252d program finished with exit code 0 elapsedTime=0.004456 script_repo_revision: 'aba2c94b1bf8d1b0423205a8b45e442c4b35252d' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-27 14:08:17.620172) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-27 14:08:17.620486) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-27 14:08:17.630093) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-02-27 14:08:17.630442) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1456608482.192647-1456463062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:08:18 INFO - MultiFileLogger online at 20160227 14:08:18 in /builds/slave/test-pgo 14:08:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:08:18 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:08:18 INFO - {'append_to_log': False, 14:08:18 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:08:18 INFO - 'blob_upload_branch': 'Fx-Team', 14:08:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:08:18 INFO - 'branch': 'Fx-Team', 14:08:18 INFO - 'buildbot_json_path': 'buildprops.json', 14:08:18 INFO - 'config_files': ('talos/linux_config.py',), 14:08:18 INFO - 'default_actions': ('clobber', 14:08:18 INFO - 'read-buildbot-config', 14:08:18 INFO - 'download-and-extract', 14:08:18 INFO - 'populate-webroot', 14:08:18 INFO - 'create-virtualenv', 14:08:18 INFO - 'install', 14:08:18 INFO - 'run-tests'), 14:08:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:08:18 INFO - 'download_minidump_stackwalk': True, 14:08:18 INFO - 'download_symbols': 'ondemand', 14:08:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:08:18 INFO - 'tooltool.py': '/tools/tooltool.py', 14:08:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:08:18 INFO - '/tools/misc-python/virtualenv.py')}, 14:08:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:08:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:08:18 INFO - 'installer_path': 'installer.exe', 14:08:18 INFO - 'log_level': 'info', 14:08:18 INFO - 'log_name': 'talos', 14:08:18 INFO - 'log_to_console': True, 14:08:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:08:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:08:18 INFO - 'opt_config_files': (), 14:08:18 INFO - 'pip_index': False, 14:08:18 INFO - 'sps_profile': False, 14:08:18 INFO - 'sps_profile_interval': 0, 14:08:18 INFO - 'suite': 'dromaeojs', 14:08:18 INFO - 'system_bits': '32', 14:08:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:08:18 INFO - 'title': 'talos-linux64-ix-004', 14:08:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:08:18 INFO - 'use_talos_json': True, 14:08:18 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:08:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:08:18 INFO - 'work_dir': 'build'} 14:08:18 INFO - ##### 14:08:18 INFO - ##### Running clobber step. 14:08:18 INFO - ##### 14:08:18 INFO - Running pre-action listener: _resource_record_pre_action 14:08:18 INFO - Running main action method: clobber 14:08:18 INFO - rmtree: /builds/slave/test-pgo/build 14:08:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:08:19 INFO - Running post-action listener: _resource_record_post_action 14:08:19 INFO - ##### 14:08:19 INFO - ##### Running read-buildbot-config step. 14:08:19 INFO - ##### 14:08:19 INFO - Running pre-action listener: _resource_record_pre_action 14:08:19 INFO - Running main action method: read_buildbot_config 14:08:19 INFO - Using buildbot properties: 14:08:19 INFO - { 14:08:19 INFO - "project": "", 14:08:19 INFO - "product": "firefox", 14:08:19 INFO - "script_repo_revision": "production", 14:08:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:08:19 INFO - "repository": "", 14:08:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:08:19 INFO - "buildid": "20160227113018", 14:08:19 INFO - "pgo_build": "True", 14:08:19 INFO - "basedir": "/builds/slave/test-pgo", 14:08:19 INFO - "buildnumber": 681, 14:08:19 INFO - "slavename": "talos-linux64-ix-004", 14:08:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:08:19 INFO - "platform": "ubuntu64_hw", 14:08:19 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:08:19 INFO - "branch": "fx-team", 14:08:19 INFO - "repo_path": "integration/fx-team", 14:08:19 INFO - "revision": "aba2c94b1bf8d1b0423205a8b45e442c4b35252d", 14:08:19 INFO - "stage_platform": "linux64-pgo", 14:08:19 INFO - "builduid": "0599bbd7c5734f84a19fd295b6f8351b", 14:08:19 INFO - "slavebuilddir": "test" 14:08:19 INFO - } 14:08:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/dWH9HHW_Tu2lfCm26SRReQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 14:08:19 INFO - Running post-action listener: _resource_record_post_action 14:08:19 INFO - ##### 14:08:19 INFO - ##### Running download-and-extract step. 14:08:19 INFO - ##### 14:08:19 INFO - Running pre-action listener: _resource_record_pre_action 14:08:19 INFO - Running main action method: download_and_extract 14:08:19 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:08:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:19 INFO - https://queue.taskcluster.net/v1/task/dWH9HHW_Tu2lfCm26SRReQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:08:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dWH9HHW_Tu2lfCm26SRReQ/artifacts/public/build/test_packages.json 14:08:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dWH9HHW_Tu2lfCm26SRReQ/artifacts/public/build/test_packages.json 14:08:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dWH9HHW_Tu2lfCm26SRReQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 14:08:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dWH9HHW_Tu2lfCm26SRReQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 14:08:24 INFO - Downloaded 1448 bytes. 14:08:24 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 14:08:24 INFO - Using the following test package requirements: 14:08:24 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 14:08:24 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:08:24 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:08:24 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:08:24 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:08:24 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:08:24 INFO - u'jsshell-linux-x86_64.zip'], 14:08:24 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:08:24 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:08:24 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 14:08:24 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:08:24 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:08:24 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:08:24 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:08:24 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:08:24 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:08:24 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 14:08:24 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:08:24 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:08:24 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:08:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:24 INFO - https://queue.taskcluster.net/v1/task/dWH9HHW_Tu2lfCm26SRReQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:08:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dWH9HHW_Tu2lfCm26SRReQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:08:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dWH9HHW_Tu2lfCm26SRReQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:08:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dWH9HHW_Tu2lfCm26SRReQ/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:08:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dWH9HHW_Tu2lfCm26SRReQ/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:08:30 INFO - Downloaded 23371666 bytes. 14:08:30 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:08:30 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:08:31 INFO - Return code: 0 14:08:31 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:08:31 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:08:31 INFO - https://queue.taskcluster.net/v1/task/dWH9HHW_Tu2lfCm26SRReQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:08:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dWH9HHW_Tu2lfCm26SRReQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:08:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dWH9HHW_Tu2lfCm26SRReQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:08:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dWH9HHW_Tu2lfCm26SRReQ/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:08:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dWH9HHW_Tu2lfCm26SRReQ/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:08:35 INFO - Downloaded 23371666 bytes. 14:08:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 14:08:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 14:08:37 INFO - Return code: 0 14:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:37 INFO - https://queue.taskcluster.net/v1/task/dWH9HHW_Tu2lfCm26SRReQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:08:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dWH9HHW_Tu2lfCm26SRReQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 14:08:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dWH9HHW_Tu2lfCm26SRReQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 14:08:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dWH9HHW_Tu2lfCm26SRReQ/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:08:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dWH9HHW_Tu2lfCm26SRReQ/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:08:38 INFO - Downloaded 10713410 bytes. 14:08:38 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:08:38 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:08:38 INFO - Return code: 0 14:08:38 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:08:38 INFO - https://queue.taskcluster.net/v1/task/dWH9HHW_Tu2lfCm26SRReQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:08:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dWH9HHW_Tu2lfCm26SRReQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:08:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dWH9HHW_Tu2lfCm26SRReQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:08:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dWH9HHW_Tu2lfCm26SRReQ/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:08:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dWH9HHW_Tu2lfCm26SRReQ/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:08:40 INFO - Downloaded 56629496 bytes. 14:08:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dWH9HHW_Tu2lfCm26SRReQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:08:40 INFO - mkdir: /builds/slave/test-pgo/properties 14:08:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:08:40 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:08:40 INFO - Contents: 14:08:40 INFO - build_url:https://queue.taskcluster.net/v1/task/dWH9HHW_Tu2lfCm26SRReQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:08:40 INFO - Running post-action listener: _resource_record_post_action 14:08:40 INFO - Running post-action listener: set_extra_try_arguments 14:08:40 INFO - ##### 14:08:40 INFO - ##### Running populate-webroot step. 14:08:40 INFO - ##### 14:08:40 INFO - Running pre-action listener: _resource_record_pre_action 14:08:40 INFO - Running main action method: populate_webroot 14:08:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:08:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:08:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:08:40 INFO - '--tppagecycles', 14:08:40 INFO - '7'], 14:08:40 INFO - 'tests': ['tsvgm']}}, 14:08:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:08:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:08:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:08:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:08:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:08:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:08:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:08:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:40 INFO - 'talos_options': ['--e10s'], 14:08:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:08:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:40 INFO - 'tests': ['damp', 'tps']}, 14:08:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:40 INFO - 'talos_options': ['--e10s'], 14:08:40 INFO - 'tests': ['damp', 'tps']}, 14:08:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:08:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:08:40 INFO - 'other': {'tests': ['a11yr', 14:08:40 INFO - 'ts_paint', 14:08:40 INFO - 'tpaint', 14:08:40 INFO - 'sessionrestore', 14:08:40 INFO - 'sessionrestore_no_auto_restore']}, 14:08:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:08:40 INFO - 'tests': ['a11yr', 14:08:40 INFO - 'ts_paint', 14:08:40 INFO - 'tpaint', 14:08:40 INFO - 'sessionrestore', 14:08:40 INFO - 'sessionrestore_no_auto_restore']}, 14:08:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:08:40 INFO - 'tests': ['a11yr', 14:08:40 INFO - 'ts_paint', 14:08:40 INFO - 'tpaint', 14:08:40 INFO - 'sessionrestore', 14:08:40 INFO - 'sessionrestore_no_auto_restore']}, 14:08:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:08:40 INFO - 'tests': ['a11yr', 14:08:40 INFO - 'ts_paint', 14:08:40 INFO - 'tpaint', 14:08:40 INFO - 'sessionrestore', 14:08:40 INFO - 'sessionrestore_no_auto_restore']}, 14:08:40 INFO - 'other_l64': {'tests': ['a11yr', 14:08:40 INFO - 'ts_paint', 14:08:40 INFO - 'tpaint', 14:08:40 INFO - 'sessionrestore', 14:08:40 INFO - 'sessionrestore_no_auto_restore']}, 14:08:40 INFO - 'other_nol64': {'tests': ['a11yr', 14:08:40 INFO - 'ts_paint', 14:08:40 INFO - 'tpaint', 14:08:40 INFO - 'sessionrestore', 14:08:40 INFO - 'sessionrestore_no_auto_restore']}, 14:08:40 INFO - 'svgr': {'tests': ['tsvgx', 14:08:40 INFO - 'tsvgr_opacity', 14:08:40 INFO - 'tart', 14:08:40 INFO - 'tscrollx', 14:08:40 INFO - 'cart']}, 14:08:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:08:40 INFO - 'tests': ['tsvgx', 14:08:40 INFO - 'tsvgr_opacity', 14:08:40 INFO - 'tart', 14:08:40 INFO - 'tscrollx', 14:08:40 INFO - 'cart']}, 14:08:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:40 INFO - 'tests': ['tp5o']}, 14:08:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:40 INFO - 'talos_options': ['--e10s'], 14:08:40 INFO - 'tests': ['tp5o']}, 14:08:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:40 INFO - 'talos_options': ['--xperf_path', 14:08:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:08:40 INFO - 'tests': ['tp5n']}, 14:08:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:08:40 INFO - 'talos_options': ['--e10s', 14:08:40 INFO - '--xperf_path', 14:08:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:08:40 INFO - 'tests': ['tp5n']}}, 14:08:40 INFO - 'talos.zip': {'path': '', 14:08:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:08:40 INFO - Running post-action listener: _resource_record_post_action 14:08:40 INFO - ##### 14:08:40 INFO - ##### Running create-virtualenv step. 14:08:40 INFO - ##### 14:08:40 INFO - Running pre-action listener: _resource_record_pre_action 14:08:40 INFO - Running main action method: create_virtualenv 14:08:40 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:08:40 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 14:08:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:08:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:08:40 INFO - Using real prefix '/usr' 14:08:40 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:08:41 INFO - Installing distribute.............................................................................................................................................................................................done. 14:08:43 INFO - Installing pip.................done. 14:08:43 INFO - Return code: 0 14:08:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f55ec546f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15af670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163e8c0>, '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 0x163f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x163fc50>, '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': 'c6927cf182745ad25b1d38b9000001fe-1456608482.192647-1456463062', '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:08:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 14:08:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:08:43 INFO - Using env: {'DISPLAY': ':0', 14:08:43 INFO - 'HOME': '/home/cltbld', 14:08:43 INFO - 'LANG': 'en_US.UTF-8', 14:08:43 INFO - 'LANGUAGE': 'en_US:en', 14:08:43 INFO - 'LOGNAME': 'cltbld', 14:08:43 INFO - 'MAIL': '/var/mail/cltbld', 14:08:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:43 INFO - 'MOZ_NO_REMOTE': '1', 14:08:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:43 INFO - 'NO_EM_RESTART': '1', 14:08:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:08:43 INFO - 'PWD': '/builds/slave/test-pgo', 14:08:43 INFO - 'SHELL': '/bin/bash', 14:08:43 INFO - 'SHLVL': '1', 14:08:43 INFO - 'TERM': 'linux', 14:08:43 INFO - 'TMOUT': '86400', 14:08:43 INFO - 'USER': 'cltbld', 14:08:43 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1456608482.192647-1456463062', 14:08:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:43 INFO - '_': '/tools/buildbot/bin/python'} 14:08:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:43 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:08:43 INFO - Cleaning up... 14:08:43 INFO - Return code: 0 14:08:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f55ec546f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15af670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163e8c0>, '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 0x163f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x163fc50>, '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': 'c6927cf182745ad25b1d38b9000001fe-1456608482.192647-1456463062', '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:08:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 14:08:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:08:43 INFO - Using env: {'DISPLAY': ':0', 14:08:43 INFO - 'HOME': '/home/cltbld', 14:08:43 INFO - 'LANG': 'en_US.UTF-8', 14:08:43 INFO - 'LANGUAGE': 'en_US:en', 14:08:43 INFO - 'LOGNAME': 'cltbld', 14:08:43 INFO - 'MAIL': '/var/mail/cltbld', 14:08:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:43 INFO - 'MOZ_NO_REMOTE': '1', 14:08:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:43 INFO - 'NO_EM_RESTART': '1', 14:08:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:08:43 INFO - 'PWD': '/builds/slave/test-pgo', 14:08:43 INFO - 'SHELL': '/bin/bash', 14:08:43 INFO - 'SHLVL': '1', 14:08:43 INFO - 'TERM': 'linux', 14:08:43 INFO - 'TMOUT': '86400', 14:08:43 INFO - 'USER': 'cltbld', 14:08:43 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1456608482.192647-1456463062', 14:08:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:43 INFO - '_': '/tools/buildbot/bin/python'} 14:08:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:43 INFO - Downloading/unpacking psutil>=0.7.1 14:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:08:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:08:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:08:45 INFO - Installing collected packages: psutil 14:08:45 INFO - Running setup.py install for psutil 14:08:45 INFO - building 'psutil._psutil_linux' extension 14:08:45 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:08:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:08:45 INFO - building 'psutil._psutil_posix' extension 14:08:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:08:46 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:08:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:08:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:08:46 INFO - Successfully installed psutil 14:08:46 INFO - Cleaning up... 14:08:46 INFO - Return code: 0 14:08:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:08: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:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08: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:08:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:46 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 0x7f55ec546f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15af670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163e8c0>, '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 0x163f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x163fc50>, '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': 'c6927cf182745ad25b1d38b9000001fe-1456608482.192647-1456463062', '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:08:46 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:08:46 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:08:46 INFO - Using env: {'DISPLAY': ':0', 14:08:46 INFO - 'HOME': '/home/cltbld', 14:08:46 INFO - 'LANG': 'en_US.UTF-8', 14:08:46 INFO - 'LANGUAGE': 'en_US:en', 14:08:46 INFO - 'LOGNAME': 'cltbld', 14:08:46 INFO - 'MAIL': '/var/mail/cltbld', 14:08:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:46 INFO - 'MOZ_NO_REMOTE': '1', 14:08:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:46 INFO - 'NO_EM_RESTART': '1', 14:08:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:08:46 INFO - 'PWD': '/builds/slave/test-pgo', 14:08:46 INFO - 'SHELL': '/bin/bash', 14:08:46 INFO - 'SHLVL': '1', 14:08:46 INFO - 'TERM': 'linux', 14:08:46 INFO - 'TMOUT': '86400', 14:08:46 INFO - 'USER': 'cltbld', 14:08:46 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1456608482.192647-1456463062', 14:08:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:46 INFO - '_': '/tools/buildbot/bin/python'} 14:08:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:08:46 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:08:46 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:08:46 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:08:46 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:08:46 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:08:46 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:08:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:08:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:08:48 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:08:48 INFO - Installing collected packages: mozsystemmonitor 14:08:48 INFO - Running setup.py install for mozsystemmonitor 14:08:48 INFO - Successfully installed mozsystemmonitor 14:08:48 INFO - Cleaning up... 14:08:48 INFO - Return code: 0 14:08:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:08:48 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:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:48 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:08:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:48 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 0x7f55ec546f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15af670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163e8c0>, '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 0x163f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x163fc50>, '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': 'c6927cf182745ad25b1d38b9000001fe-1456608482.192647-1456463062', '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:08:48 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:08:48 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:08:48 INFO - Using env: {'DISPLAY': ':0', 14:08:48 INFO - 'HOME': '/home/cltbld', 14:08:48 INFO - 'LANG': 'en_US.UTF-8', 14:08:48 INFO - 'LANGUAGE': 'en_US:en', 14:08:48 INFO - 'LOGNAME': 'cltbld', 14:08:48 INFO - 'MAIL': '/var/mail/cltbld', 14:08:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:48 INFO - 'MOZ_NO_REMOTE': '1', 14:08:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:48 INFO - 'NO_EM_RESTART': '1', 14:08:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:08:48 INFO - 'PWD': '/builds/slave/test-pgo', 14:08:48 INFO - 'SHELL': '/bin/bash', 14:08:48 INFO - 'SHLVL': '1', 14:08:48 INFO - 'TERM': 'linux', 14:08:48 INFO - 'TMOUT': '86400', 14:08:48 INFO - 'USER': 'cltbld', 14:08:48 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1456608482.192647-1456463062', 14:08:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:48 INFO - '_': '/tools/buildbot/bin/python'} 14:08:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:48 INFO - Downloading/unpacking blobuploader==1.2.4 14:08:48 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:08:48 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:08:48 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:08:48 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:08:48 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:08:48 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:08:50 INFO - Downloading blobuploader-1.2.4.tar.gz 14:08:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:08:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:08:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:51 INFO - Downloading docopt-0.6.1.tar.gz 14:08:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:08:51 INFO - Installing collected packages: blobuploader, requests, docopt 14:08:51 INFO - Running setup.py install for blobuploader 14:08:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:08:51 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:08:51 INFO - Running setup.py install for requests 14:08:51 INFO - Running setup.py install for docopt 14:08:51 INFO - Successfully installed blobuploader requests docopt 14:08:51 INFO - Cleaning up... 14:08:51 INFO - Return code: 0 14:08:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:51 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 0x7f55ec546f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15af670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163e8c0>, '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 0x163f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x163fc50>, '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': 'c6927cf182745ad25b1d38b9000001fe-1456608482.192647-1456463062', '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:08:51 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:08:51 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:08:51 INFO - Using env: {'DISPLAY': ':0', 14:08:51 INFO - 'HOME': '/home/cltbld', 14:08:51 INFO - 'LANG': 'en_US.UTF-8', 14:08:51 INFO - 'LANGUAGE': 'en_US:en', 14:08:51 INFO - 'LOGNAME': 'cltbld', 14:08:51 INFO - 'MAIL': '/var/mail/cltbld', 14:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:51 INFO - 'MOZ_NO_REMOTE': '1', 14:08:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:51 INFO - 'NO_EM_RESTART': '1', 14:08:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:08:51 INFO - 'PWD': '/builds/slave/test-pgo', 14:08:51 INFO - 'SHELL': '/bin/bash', 14:08:51 INFO - 'SHLVL': '1', 14:08:51 INFO - 'TERM': 'linux', 14:08:51 INFO - 'TMOUT': '86400', 14:08:51 INFO - 'USER': 'cltbld', 14:08:51 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1456608482.192647-1456463062', 14:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:51 INFO - '_': '/tools/buildbot/bin/python'} 14:08:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:08:52 INFO - Running setup.py (path:/tmp/pip-0li3_Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:08:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:08:52 INFO - Running setup.py (path:/tmp/pip-XIFmoI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:08:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:08:52 INFO - Running setup.py (path:/tmp/pip-gtWMYS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:08:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:08:52 INFO - Running setup.py (path:/tmp/pip-Wr0fwW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:08:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:08:52 INFO - Running setup.py (path:/tmp/pip-cEQKnG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:08:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:08:52 INFO - Running setup.py (path:/tmp/pip-7a_w40-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:08:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:08:52 INFO - Running setup.py (path:/tmp/pip-dLXBi8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:08:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:08:52 INFO - Running setup.py (path:/tmp/pip-VUXLv3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:08:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:08:52 INFO - Running setup.py (path:/tmp/pip-xdKYlg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:08:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:08:52 INFO - Running setup.py (path:/tmp/pip-ovv9vx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:08:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:08:52 INFO - Running setup.py (path:/tmp/pip-8nTj_m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:08:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:08:52 INFO - Running setup.py (path:/tmp/pip-K6m4nt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:08:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:08:52 INFO - Running setup.py (path:/tmp/pip-6p8yoP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:08:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:08:52 INFO - Running setup.py (path:/tmp/pip-o5MFG7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:08:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:08:53 INFO - Running setup.py (path:/tmp/pip-YgDVjo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:08:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:08:53 INFO - Running setup.py (path:/tmp/pip-_rqeOz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:08:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:08:53 INFO - Running setup.py (path:/tmp/pip-W_MTc6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:08:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:08:53 INFO - Running setup.py install for manifestparser 14:08:53 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:08:53 INFO - Running setup.py install for mozcrash 14:08:53 INFO - Running setup.py install for mozdebug 14:08:53 INFO - Running setup.py install for mozdevice 14:08:53 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:08:53 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:08:53 INFO - Running setup.py install for mozfile 14:08:53 INFO - Running setup.py install for mozhttpd 14:08:53 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:08:53 INFO - Running setup.py install for mozinfo 14:08:53 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:08:53 INFO - Running setup.py install for mozInstall 14:08:54 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:08:54 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:08:54 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:08:54 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:08:54 INFO - Running setup.py install for mozleak 14:08:54 INFO - Running setup.py install for mozlog 14:08:54 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:08:54 INFO - Running setup.py install for moznetwork 14:08:54 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:08:54 INFO - Running setup.py install for mozprocess 14:08:54 INFO - Running setup.py install for mozprofile 14:08:54 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:08:54 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:08:54 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:08:54 INFO - Running setup.py install for mozrunner 14:08:54 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:08:54 INFO - Running setup.py install for mozscreenshot 14:08:54 INFO - Running setup.py install for moztest 14:08:54 INFO - Running setup.py install for mozversion 14:08:55 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:08:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:08:55 INFO - Cleaning up... 14:08:55 INFO - Return code: 0 14:08:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:55 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 0x7f55ec546f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15af670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163e8c0>, '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 0x163f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x163fc50>, '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': 'c6927cf182745ad25b1d38b9000001fe-1456608482.192647-1456463062', '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:08:55 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:08:55 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:08:55 INFO - Using env: {'DISPLAY': ':0', 14:08:55 INFO - 'HOME': '/home/cltbld', 14:08:55 INFO - 'LANG': 'en_US.UTF-8', 14:08:55 INFO - 'LANGUAGE': 'en_US:en', 14:08:55 INFO - 'LOGNAME': 'cltbld', 14:08:55 INFO - 'MAIL': '/var/mail/cltbld', 14:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:55 INFO - 'MOZ_NO_REMOTE': '1', 14:08:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:55 INFO - 'NO_EM_RESTART': '1', 14:08:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:08:55 INFO - 'PWD': '/builds/slave/test-pgo', 14:08:55 INFO - 'SHELL': '/bin/bash', 14:08:55 INFO - 'SHLVL': '1', 14:08:55 INFO - 'TERM': 'linux', 14:08:55 INFO - 'TMOUT': '86400', 14:08:55 INFO - 'USER': 'cltbld', 14:08:55 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1456608482.192647-1456463062', 14:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:55 INFO - '_': '/tools/buildbot/bin/python'} 14:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:08:55 INFO - Running setup.py (path:/tmp/pip-rOrbj_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:08:55 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:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:08:55 INFO - Running setup.py (path:/tmp/pip-otMmhr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:08:55 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:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:08:55 INFO - Running setup.py (path:/tmp/pip-muBU8i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:08:55 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:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:08:55 INFO - Running setup.py (path:/tmp/pip-BTX92G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:08:55 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:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:08:55 INFO - Running setup.py (path:/tmp/pip-CNEZid-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:08:55 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:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:08:55 INFO - Running setup.py (path:/tmp/pip-rz86w2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:08:55 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:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:08:55 INFO - Running setup.py (path:/tmp/pip-9OSVSL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:08:55 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:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:08:55 INFO - Running setup.py (path:/tmp/pip-4Gc7HL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:08:55 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:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:08:55 INFO - Running setup.py (path:/tmp/pip-Yq6rGo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:08:55 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:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:08:55 INFO - Running setup.py (path:/tmp/pip-26TXKX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:08:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:08:55 INFO - Running setup.py (path:/tmp/pip-h5eO6Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:08:56 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:08:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:08:56 INFO - Running setup.py (path:/tmp/pip-C0amKV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:08:56 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:08:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:08:56 INFO - Running setup.py (path:/tmp/pip-qOFuvh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:08:56 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:08:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:08:56 INFO - Running setup.py (path:/tmp/pip-LuPaMa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:08:56 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:08:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:08:56 INFO - Running setup.py (path:/tmp/pip-GY2SuB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:08:56 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:08:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:08:56 INFO - Running setup.py (path:/tmp/pip-0c2r7k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:08:56 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:08:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:08:56 INFO - Running setup.py (path:/tmp/pip-qUdbvN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:08:56 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:08:56 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:08:56 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:08:56 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:08:56 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:08:56 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:08:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:08:56 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:08:56 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:08:56 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:08:56 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:08:56 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:08:56 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:08:58 INFO - Downloading blessings-1.6.tar.gz 14:08:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:08:58 INFO - Installing collected packages: blessings 14:08:58 INFO - Running setup.py install for blessings 14:08:58 INFO - Successfully installed blessings 14:08:58 INFO - Cleaning up... 14:08:58 INFO - Return code: 0 14:08:58 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:08:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:08:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:08:58 INFO - Reading from file tmpfile_stdout 14:08:58 INFO - Current package versions: 14:08:58 INFO - argparse == 1.2.1 14:08:58 INFO - blessings == 1.6 14:08:58 INFO - blobuploader == 1.2.4 14:08:58 INFO - docopt == 0.6.1 14:08:58 INFO - manifestparser == 1.1 14:08:58 INFO - mozInstall == 1.12 14:08:58 INFO - mozcrash == 0.16 14:08:58 INFO - mozdebug == 0.1 14:08:58 INFO - mozdevice == 0.48 14:08:58 INFO - mozfile == 1.2 14:08:58 INFO - mozhttpd == 0.7 14:08:58 INFO - mozinfo == 0.9 14:08:58 INFO - mozleak == 0.1 14:08:58 INFO - mozlog == 3.1 14:08:58 INFO - moznetwork == 0.27 14:08:58 INFO - mozprocess == 0.22 14:08:58 INFO - mozprofile == 0.28 14:08:58 INFO - mozrunner == 6.11 14:08:58 INFO - mozscreenshot == 0.1 14:08:58 INFO - mozsystemmonitor == 0.0 14:08:58 INFO - moztest == 0.7 14:08:58 INFO - mozversion == 1.4 14:08:58 INFO - psutil == 3.1.1 14:08:58 INFO - requests == 1.2.3 14:08:58 INFO - wsgiref == 0.1.2 14:08:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:08: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:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08: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:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f55ec546f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15af670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163e8c0>, '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 0x163f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x163fc50>, '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': 'c6927cf182745ad25b1d38b9000001fe-1456608482.192647-1456463062', '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:08:58 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:08:58 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:08:58 INFO - Using env: {'DISPLAY': ':0', 14:08:58 INFO - 'HOME': '/home/cltbld', 14:08:58 INFO - 'LANG': 'en_US.UTF-8', 14:08:58 INFO - 'LANGUAGE': 'en_US:en', 14:08:58 INFO - 'LOGNAME': 'cltbld', 14:08:58 INFO - 'MAIL': '/var/mail/cltbld', 14:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:58 INFO - 'MOZ_NO_REMOTE': '1', 14:08:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:58 INFO - 'NO_EM_RESTART': '1', 14:08:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:08:58 INFO - 'PWD': '/builds/slave/test-pgo', 14:08:58 INFO - 'SHELL': '/bin/bash', 14:08:58 INFO - 'SHLVL': '1', 14:08:58 INFO - 'TERM': 'linux', 14:08:58 INFO - 'TMOUT': '86400', 14:08:58 INFO - 'USER': 'cltbld', 14:08:58 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1456608482.192647-1456463062', 14:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:58 INFO - '_': '/tools/buildbot/bin/python'} 14:08:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 14:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 14:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 14:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 14:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 14:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 14:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 14:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 14:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 14:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 14:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 14:08:58 INFO - Cleaning up... 14:08:58 INFO - Return code: 0 14:08:58 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:08: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:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08: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:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:08:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f55ec546f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15af670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163e8c0>, '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 0x163f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x163fc50>, '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': 'c6927cf182745ad25b1d38b9000001fe-1456608482.192647-1456463062', '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:08:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 14:08:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:08:58 INFO - Using env: {'DISPLAY': ':0', 14:08:58 INFO - 'HOME': '/home/cltbld', 14:08:58 INFO - 'LANG': 'en_US.UTF-8', 14:08:58 INFO - 'LANGUAGE': 'en_US:en', 14:08:58 INFO - 'LOGNAME': 'cltbld', 14:08:58 INFO - 'MAIL': '/var/mail/cltbld', 14:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:58 INFO - 'MOZ_NO_REMOTE': '1', 14:08:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:58 INFO - 'NO_EM_RESTART': '1', 14:08:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:08:58 INFO - 'PWD': '/builds/slave/test-pgo', 14:08:58 INFO - 'SHELL': '/bin/bash', 14:08:58 INFO - 'SHLVL': '1', 14:08:58 INFO - 'TERM': 'linux', 14:08:58 INFO - 'TMOUT': '86400', 14:08:58 INFO - 'USER': 'cltbld', 14:08:58 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1456608482.192647-1456463062', 14:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:58 INFO - '_': '/tools/buildbot/bin/python'} 14:08:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:59 INFO - Downloading/unpacking jsonschema 14:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:09:01 INFO - Downloading/unpacking functools32 (from jsonschema) 14:09: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:09: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:09: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:09: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:09: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:09: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:09:01 INFO - Downloading functools32-3.2.3-2.tar.gz 14:09:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:09:01 INFO - warning: no files found matching '*.txt' 14:09:01 INFO - no previously-included directories found matching 'build' 14:09:01 INFO - no previously-included directories found matching 'dist' 14:09:01 INFO - no previously-included directories found matching '.git*' 14:09:01 INFO - Installing collected packages: jsonschema, functools32 14:09:01 INFO - Running setup.py install for functools32 14:09:01 INFO - warning: no files found matching '*.txt' 14:09:01 INFO - no previously-included directories found matching 'build' 14:09:01 INFO - no previously-included directories found matching 'dist' 14:09:01 INFO - no previously-included directories found matching '.git*' 14:09:01 INFO - Successfully installed jsonschema functools32 14:09:01 INFO - Cleaning up... 14:09:01 INFO - Return code: 0 14:09:01 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:09:01 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:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:01 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:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:01 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 0x7f55ec546f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15af670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163e8c0>, '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 0x163f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x163fc50>, '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': 'c6927cf182745ad25b1d38b9000001fe-1456608482.192647-1456463062', '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:09:01 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:09:01 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:09:01 INFO - Using env: {'DISPLAY': ':0', 14:09:01 INFO - 'HOME': '/home/cltbld', 14:09:01 INFO - 'LANG': 'en_US.UTF-8', 14:09:01 INFO - 'LANGUAGE': 'en_US:en', 14:09:01 INFO - 'LOGNAME': 'cltbld', 14:09:01 INFO - 'MAIL': '/var/mail/cltbld', 14:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:01 INFO - 'MOZ_NO_REMOTE': '1', 14:09:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:01 INFO - 'NO_EM_RESTART': '1', 14:09:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:09:01 INFO - 'PWD': '/builds/slave/test-pgo', 14:09:01 INFO - 'SHELL': '/bin/bash', 14:09:01 INFO - 'SHLVL': '1', 14:09:01 INFO - 'TERM': 'linux', 14:09:01 INFO - 'TMOUT': '86400', 14:09:01 INFO - 'USER': 'cltbld', 14:09:01 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1456608482.192647-1456463062', 14:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:01 INFO - '_': '/tools/buildbot/bin/python'} 14:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:01 INFO - Downloading/unpacking flake8 14:09: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:09: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:09: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:09: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:09: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:09: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:09:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:09:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:09: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:09: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:09: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:09: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:09: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:09: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:09:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:09:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:09: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:09: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:09: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:09: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:09: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:09: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:09:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:09:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:09:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:09:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:09:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:09:04 INFO - no previously-included directories found matching 'docs/_build' 14:09:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:09:04 INFO - Running setup.py install for pep8 14:09:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:09:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:09:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:09:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:09:04 INFO - no previously-included directories found matching 'docs/_build' 14:09:04 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:09:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:09:04 INFO - Cleaning up... 14:09:04 INFO - Return code: 0 14:09:04 INFO - Running post-action listener: _resource_record_post_action 14:09:04 INFO - Running post-action listener: _start_resource_monitoring 14:09:04 INFO - Starting resource monitoring. 14:09:04 INFO - ##### 14:09:04 INFO - ##### Running install step. 14:09:04 INFO - ##### 14:09:04 INFO - Running pre-action listener: _resource_record_pre_action 14:09:04 INFO - Running main action method: install 14:09:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:09:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:09:04 INFO - Reading from file tmpfile_stdout 14:09:04 INFO - Detecting whether we're running mozinstall >=1.0... 14:09:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:09:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:09:04 INFO - Reading from file tmpfile_stdout 14:09:04 INFO - Output received: 14:09:04 INFO - Usage: mozinstall [options] installer 14:09:04 INFO - Options: 14:09:04 INFO - -h, --help show this help message and exit 14:09:04 INFO - -d DEST, --destination=DEST 14:09:04 INFO - Directory to install application into. [default: 14:09:04 INFO - "/builds/slave/test-pgo"] 14:09:04 INFO - --app=APP Application being installed. [default: firefox] 14:09:04 INFO - mkdir: /builds/slave/test-pgo/build/application 14:09:04 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:09:04 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:09:21 INFO - Reading from file tmpfile_stdout 14:09:21 INFO - Output received: 14:09:21 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:09:21 INFO - Running post-action listener: _resource_record_post_action 14:09:21 INFO - ##### 14:09:21 INFO - ##### Running run-tests step. 14:09:21 INFO - ##### 14:09:21 INFO - Running pre-action listener: _resource_record_pre_action 14:09:21 INFO - Running main action method: run_tests 14:09:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:09:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:09:21 INFO - Python 2.7.3 14:09:21 INFO - Return code: 0 14:09:21 INFO - grabbing minidump binary from tooltool 14:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:21 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 0x163e8c0>, '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 0x163f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x163fc50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:09:21 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:09:21 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:09:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:09:21 INFO - Return code: 0 14:09:21 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:09:21 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:09:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:09:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:09:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:09:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:09:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:09:22 INFO - Return code: 0 14:09:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dWH9HHW_Tu2lfCm26SRReQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 14:09:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dWH9HHW_Tu2lfCm26SRReQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 14:09:22 INFO - Using env: {'DISPLAY': ':0', 14:09:22 INFO - 'HOME': '/home/cltbld', 14:09:22 INFO - 'LANG': 'en_US.UTF-8', 14:09:22 INFO - 'LANGUAGE': 'en_US:en', 14:09:22 INFO - 'LOGNAME': 'cltbld', 14:09:22 INFO - 'MAIL': '/var/mail/cltbld', 14:09:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:09:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:22 INFO - 'MOZ_NO_REMOTE': '1', 14:09:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:09:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:22 INFO - 'NO_EM_RESTART': '1', 14:09:22 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:09:22 INFO - 'PWD': '/builds/slave/test-pgo', 14:09:22 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:09:22 INFO - 'SHELL': '/bin/bash', 14:09:22 INFO - 'SHLVL': '1', 14:09:22 INFO - 'TERM': 'linux', 14:09:22 INFO - 'TMOUT': '86400', 14:09:22 INFO - 'USER': 'cltbld', 14:09:22 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1456608482.192647-1456463062', 14:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:22 INFO - '_': '/tools/buildbot/bin/python'} 14:09:22 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dWH9HHW_Tu2lfCm26SRReQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:09:22 INFO - mozversion application_buildid: 20160227113018 14:09:22 INFO - mozversion application_changeset: aba2c94b1bf8d1b0423205a8b45e442c4b35252d 14:09:22 INFO - mozversion application_display_name: Nightly 14:09:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:09:22 INFO - mozversion application_name: Firefox 14:09:22 INFO - mozversion application_remotingname: firefox 14:09:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:09:22 INFO - mozversion application_vendor: Mozilla 14:09:22 INFO - mozversion application_version: 47.0a1 14:09:22 INFO - mozversion platform_buildid: 20160227113018 14:09:22 INFO - mozversion platform_changeset: aba2c94b1bf8d1b0423205a8b45e442c4b35252d 14:09:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:09:22 INFO - mozversion platform_version: 47.0a1 14:09:22 INFO - using testdate: 1456610962 14:09:22 INFO - actual date: 1456610962 14:09:22 INFO - starting webserver on 'localhost:59009' 14:09:22 INFO - SUITE-START | Running 2 tests 14:09:22 INFO - TEST-START | dromaeo_css 14:09:22 INFO - operating with platform_type : linux_ 14:09:22 INFO - Initialising browser for dromaeo_css test... 14:09:22 INFO - TEST-INFO | started process 24340 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5VK0JO/profile http://localhost:59009/getInfo.html) 14:09:26 INFO - PROCESS | 24340 | __metrics Screen width/height:1600/1200 14:09:26 INFO - PROCESS | 24340 | colorDepth:24 14:09:26 INFO - PROCESS | 24340 | Browser inner width/height: 1024/697 14:09:26 INFO - PROCESS | 24340 | __metrics 14:09:27 INFO - PROCESS | 24340 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:09:27 INFO - PROCESS | 24340 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:09:27 INFO - PROCESS | 24340 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:09:27 INFO - PROCESS | 24340 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:09:27 INFO - PROCESS | 24340 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:09:27 INFO - PROCESS | 24340 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:09:27 INFO - PROCESS | 24340 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:09:27 INFO - PROCESS | 24340 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:09:28 INFO - TEST-INFO | 24340: exit 0 14:09:28 INFO - Browser initialized. 14:09:28 INFO - Running cycle 1/1 for dromaeo_css test... 14:09:28 INFO - TEST-INFO | started process 24434 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5VK0JO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:09:40 INFO - PROCESS | 24434 | RSS: Main: 150392832 14:09:40 INFO - PROCESS | 24434 | 14:10:31 INFO - PROCESS | 24434 | 1456611031564 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:12:39 INFO - PROCESS | 24434 | Cycle 1(1): loaded http://localhost:59009/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59009/tests/dromaeo/cssquery-ext.html) 14:12:40 INFO - PROCESS | 24434 | RSS: Main: 278929408 14:12:40 INFO - PROCESS | 24434 | 14:15:43 INFO - PROCESS | 24434 | Cycle 1(1): loaded http://localhost:59009/tests/dromaeo/cssquery-ext.html (next: http://localhost:59009/tests/dromaeo/cssquery-jquery.html) 14:15:43 INFO - PROCESS | 24434 | RSS: Main: 244363264 14:15:43 INFO - PROCESS | 24434 | 14:18:45 INFO - PROCESS | 24434 | Cycle 1(1): loaded http://localhost:59009/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59009/tests/dromaeo/cssquery-mootools.html) 14:18:46 INFO - PROCESS | 24434 | RSS: Main: 237281280 14:18:46 INFO - PROCESS | 24434 | 14:21:48 INFO - PROCESS | 24434 | Cycle 1(1): loaded http://localhost:59009/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59009/tests/dromaeo/cssquery-prototype.html) 14:21:48 INFO - PROCESS | 24434 | RSS: Main: 199303168 14:21:48 INFO - PROCESS | 24434 | 14:24:51 INFO - PROCESS | 24434 | Cycle 1(1): loaded http://localhost:59009/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59009/tests/dromaeo/cssquery-yui.html) 14:24:51 INFO - PROCESS | 24434 | RSS: Main: 214999040 14:24:51 INFO - PROCESS | 24434 | 14:27:54 INFO - PROCESS | 24434 | Cycle 1(1): loaded http://localhost:59009/tests/dromaeo/cssquery-yui.html (next: http://localhost:59009/tests/dromaeo/cssquery-dojo.html) 14:27:54 INFO - PROCESS | 24434 | RSS: Main: 294367232 14:27:54 INFO - PROCESS | 24434 | 14:27:54 INFO - PROCESS | 24434 | __start_tp_report 14:27:54 INFO - PROCESS | 24434 | _x_x_mozilla_page_load 14:27:54 INFO - PROCESS | 24434 | _x_x_mozilla_page_load_details 14:27:54 INFO - PROCESS | 24434 | |i|pagename|runs| 14:27:54 INFO - PROCESS | 24434 | |0;dojo.html;3056.9082927512177;3111.9377612447765;3141.497360422333;3161.5731876196705;3179.9983005353306;4905.141600219965;4970.701757894524;4975.154223781957;5014.774335154918;5031.018951304497;5012.649114561982;5030.57240134589;5034.798608055673;5041.495850414956;5054.064997975377;4526.434195725535;4621.37611422457;4676.321933319667;4690.038542098861;4691.671582989192;4534.795934182953;4561.475430325505;4644.907101857961;4653.046125544272;4736.739479328636;4625.167469855424;4645.512221216757;4648.907021859578;4681.321208424793;4684.180268453007;4641.512641172662;4645.76771161444;4650.930236046462;4667.439907211123;4683.555062269079;4551.749653769041;4600.815967361302;4618.284165954283;4627.722336659811;4639;4839.782209800567;4843.128236917353;4859.781309841065;4865.70805751656;4924.3105965164905;5423.511883930465;5431.402545719968;5431.701256430894;5456.781728730846;5482.479164479368;5443.346798384219;5458.918116228259;5460.890782184374;5466.1527463243265;5469.124940009579;4979.278004689336;5065.1642478990925;5089.949100509021;5135.050015747099;5147.253648221024;5510.421405752419;5554.166874968787;5559.16612508127;5612.635178713453;5616.326040875121;5301.019311427398;5314.627976041717;5345.305110335631;5345.572354211654;5345.65253258537;5197.532222100029;5263.4473380295285;5294.708791016454;5347.598930080259;5389.8113566025;5252.737363131828;5254.527092561611;5264.184051472028;5267.341582302212;5269.868253293622;5281.60387970896;5283.6037297202865;5284.39229488606;5293.470652934753;5310.362756469249;4051.594840515984;4154.189932963043;4179.101493178981;4196.664266858644;4216.683748718859;3758.962410375861;3763;3763.040424691686;3763.8682646107804;3796.772193668389;4932.1861892788;5099.158638824552;5109.846704598868;5118.181091025493;5161.09680805865;5350.117230656898;5376.247325374451;5381.461853814587;5420.403755586883;5423.05096608092;4879.365682461328;4921.114199444063;4922.803087876517;4931.876703082452;4966.900661986812;4510.075434535912;4519.570640789119;4528.252838281646;4554.111948170075;4585.633149348044;5665.235193248941;5681.0910254359105;5695.458931401427;5695.971520142372;5744.023516002206;5394.649347792381;5410.242566040679;5412.458754124556;5419.2954915862265;5420.4850539198715;5501.559875210054;5643.7742490299925;5655.095184770417;5722.7710891563875;5732.684702341411;5292.364916210079;5312.707801070978;5316.973415132899;5318.521333080042;5367.543758780547;5403.243545903655;5405.648632838853;5407.270018547603;5413.648112872808;5452.263944367618;5122.359705036871;5257.658252213594;5265.60507961912;5337.306150200604;5350.491703288337;5242.397124330751;5242.501962313574;5249.763760630704;5261.237120617566;5277.920831187458;5202.713850738246;5202.869928251824;5205.167173252262;5206.140986737298;5241.764120614658;5068.873278167928;5103.77033033507;5241.659292145999;5326;5329.946700532945;5166.819161329336;5203.5576975955955;5203.635745497931;5210.036143313499;5242.239875218148 14:27:54 INFO - PROCESS | 24434 | |1;ext.html;521.9112750832361;531.1793279383354;536.0779459329952;546.6692650946178;547.1573776384369;36263.27473450529;36878.07804804878;36922.63077369229;37002.25995480089;37054.25891482169;40033.39949900754;40372.798136009354;40477.59522404775;40512.392314115314;40515.39226911599;8108.594570271493;8263.793405164859;8263.876041859377;8269.62786674601;8274.089850116483;8317;8532.14678532148;8533.914660853405;8815.338849586275;8819.603117859711;8807.911920880806;8891;8892.288616910664;8895.77760555988;8900;8661.393702440831;8769.079246679134;8785.824283514357;8790.56047197644;8790.736277911641;8548.529830859301;8679.826403471896;8680.435771674822;8683.913160868437;8687.913120868774;39821.402678959836;40275.798621007;40287;40340.59659403427;40399.7980010101;3381.5603971483797;3578.4632305154173;3819.2552452271816;3819.770813751156;4130.070734084807;30550.388992220254;30802.38395232083;31010.534841977387;31013.534796978063;32035.359292814013;3986.86045988389;4000.219957108336;4029.476168098158;4108.424820525129;4159.438475805758;268344;269286;270031;270099.999999998;270255;56341.43658563444;57332.426675732706;57521.137182942286;57587.42412575905;57590.712046440334;49979.50020499749;49982;50623;50969.49030509647;51069.48930510647;14462.132272063709;14634.926825365805;14722.779158312635;14751.852481475262;14796.112233266038;10692.091172250446;10738.8187299397;10859.099657559895;10925.617603383844;10954.671359859218;17273.205316506257;19286.35930738086;19419.33784837991;19515.580609243752;19556.119974601177;6030.396960304022;7138.143422789299;7314.378277846443;7430.219826918204;7592.126905405949;887.1128871128872;907.950062746542;1041.9270651054353;1105.9668209953713;1127.9154063445274;26388.08107019825;27963.161105166877;28523.857380712965;29076;29353;1030.9690709278734;1092.093562343253;1099.3568762273999;1102.685734565661;1122.1359553144196;14659.413623454942;15055.247237638074;15077.924610376878;15107.39570417171;15268.541943741706;302745;305433;306424;306893;308324;51650.48349516532;51908.48091519037;51942.8834269945;52022;52077.218841717404;1181.2440038375446;1349.27813619713;1361.0404664711355;1364.7611667958067;1447.2691290898028;24861.254162375157;26108.8694556526;26362.340941476617;26458.470830582897;28183.57724634173;39827;40198.79900600478;40268.39597405983;40350;41455.7927210362;195461;195818;196536;197297;197745;26584.867075664497;31119.68880311168;31685;31865.044048678577;31895.68104318927;37146.44280335851;37916.62083379241;38323.23353532858;38381.2323753529;38638.613613863505;31321.37357252888;31479.21301967469;32029.199270018435;32101.35797284088;32449.837750811093;31974;32107.357852842346;32163.35673286568;32760.344793104483;35261.82369088138;35199;35245.29509409746;35568.82215588906;35697.28605427825;36346;29197.562036569045;31532.211694706897;32157;32187.678123219404;32214.67785322117;23747.525049498567;24101.879490602434;24241.611138440552;24280;24490.755092448846 14:27:54 INFO - PROCESS | 24434 | |2;jquery.html;342.10198229647176;344.3165316846061;347.6575573060535;348.3329424152748;355.2202914602447;16704.248308826103;16934.15329233538;17145.828541714578;17216.91391543042;17689.734653980202;16369.345226190939;16699.74950375745;16964.236609352578;16965.32138714453;16979.83020169798;4636.392188925498;5322.973385133078;5452.672839629615;5486.039943009977;5503.257060296869;3922.4704664870164;5371.489708477708;5788.6816225107605;6032.66820324882;6074.331823499411;5993.520518358521;6007.038873780196;6007.939920600804;6008.459238668519;6012.639241645494;5791.420857914196;5868.2371291732015;5879.353271140171;5923.229980102559;5928.555358348098;3534.0811389038777;4994.2009278515625;5139.972005598858;5318.468153184689;5332.573394128461;19495.707564386546;19753.308634197878;19889.701654475193;21313.360599181895;21346;2416.4683769570665;2573.395252115751;2602.958816473407;2681.36987807865;2939.8677059532374;13372.197668139943;13382.93308533451;13806.93096534521;14016.71966560663;14107.365168567336;1950.570874407628;2037.7860324665844;2065.1945741160957;2069.4929742213253;2073.067119796098;58888.411115888724;61758.0736288956;68416.6579167106;71749;77689.99999999943;14692.926535367254;15249.847501525064;15315.693686126215;15429.845701542841;15453.38186472551;24523.141690040764;24743.649353311408;24772.504549909263;24869.12958046496;24871.50256994886;8176.182381761776;8430.072692003874;8625.741227763177;8797.692080777142;8874.467531948103;7281.381082607932;7328.96335518319;7355.080614923135;7436.144843342977;7437.995870557405;7834.569098699626;7916.247956444128;7969.442139050327;7981.800454988672;8032.558209298545;2533.569293220157;2960.2451374899265;2981.7625685340777;3022.1386904732485;3042.6348838139124;884.6063501741663;949.2785483032944;973.255459573427;982.832918403873;1076.2143635146388;15489.922550387177;15754.9212253938;15773.605659858595;15943.760843587355;16207.756883646754;937.4141161773891;973.454865275448;985.1084768284713;1004.5881188712593;1008.193445243802;8855.51294678786;9049.366544341832;9324.720258392259;9415.435073895589;9516.524173791282;408986;429155;430001;431593;433564;71022.64488677523;72646.63676681688;73440;73592;73845.26154738384;972.397113789455;984.296228196857;992.2260636703382;1000.6997900629782;1001.2140469731372;14254.714905702036;14524.419023238952;14601.415943362146;14648.560543183721;14862.851371486579;32575.348493029534;33860.49209261814;34072.31855362929;34434.65565344415;35407;43887.56112438963;44095;44225.33661995137;44590.3311450335;45144.32283515816;7826.295633393022;7930.484518506279;7933.206679332021;7953.801154971172;8088.9595552021865;8073.717419890276;11277.548898044315;11749.823752643546;12464.937675311565;12725.55460558876;8541.444806087584;10034.695489586307;10119.494025298558;10165.135963442894;10459.68620941373;6470.967645161744;8321.710134929095;10719.624813131502;10944.616938407118;10986.340819550853;5802.129680547782;8380.287675547646;10251.231157663056;10805.51375188134;11208.27146235492;7542.509736867086;7929.881051784112;7954.920450795649;8097.676092956216;8107.797305067184;8200.302974247255;9429.905700942903;9896.851547226654;9974.102330790263;10157.593696252066 14:27:54 INFO - PROCESS | 24434 | |3;mootools.html;1333.8866196373308;1435.2608406670568;1451.3831621560842;1606.6465377616921;1789.5973405983664;6477.35226477352;7000.19497757758;7151.249118842518;7159.4988350815465;7162.247963963787;7095.574265544071;7265.927340726591;7267.563946163234;7268.200497945222;7273.16358618759;1924.980750192501;2138.9893050534724;2188.627933251351;2209;2236.2396785093065;2179.891005449721;2204.4488877780555;2216.0692509146115;2216.6896634471104;2218.389942765736;2171.413718296059;2174.7825217478203;2177.8693278403266;2179.498715295483;2179.8365122615787;2130.6164890319737;2162.7296587926508;2163.621366260898;2164.534625055605;2167.5014746608213;2135.519508110678;2144.431725592719;2145.0240140735928;2146.0450099705636;2209.9558008839895;7411.814704632374;7466.365358944497;7479.663415146331;7489.063867016623;7491.51305165168;4449.888752781174;4525.524819893897;4546.181687296285;4572.359869618223;4579.496255411902;2884.668263149744;2963.199936017285;2997.370552184044;3001.774866884992;3011.3073992981517;956.8038552096804;959.5058544849409;972.4165500699523;992.7518120469882;998.5057396588735;10078;10105.595776169019;10128.442935638537;10151.94924025375;10161.33951293171;3869.5163104611925;3977.900552486211;4012.678985681197;4024.7383920045104;4042.737222080614;8653;8680.218780309802;8685.739427817176;8704.216620504185;8704.695335663222;4050.7569545826755;4352.521222665504;4546.840860569931;4553.772311384418;4568.040711450632;3999.960000399959;4005.879823605238;4041.0907545802547;4046.2312160689376;4059.4519739835337;3412.351653185887;3468.8612455502002;3472.340255351475;3493.179102910814;3505.1938054247667;1104.13877175803;1109.14595761265;1112.955481780736;1120.5237773946203;1137.3573930729276;1310.967225819362;1330.846952600444;1330.966725831862;1332.7068045030078;1348.2719331561043;6985.301469852974;7044.577325360495;7113.146422429239;7120.821979450555;7131.643417829192;495.3906694765459;498.24018371982294;500.314569040417;502.412177752031;512.6488355476511;5426.728663566806;5485.780568777284;5486.341639003345;5500.3949565547755;5528.668279903219;8268.09051004389;8442.788930276669;8445.704400345958;8470.915290847013;8536.957315213383;8428;8442.155784421631;8442.704505342406;8463.661453541912;8465.238128568459;6555.704993275314;6640.900386494206;6712.2952090031795;6986.301369863075;7201.747938822221;6858.691358888762;6917.688704008231;6917.688704008432;6927.618980956096;7012.544184627983;7663.1570527243075;7944;7992.84014319722;8065.153158918229;8067.273945344712;7940.245676660708;8086.9191308086165;8222.876656850272;8226.958865205635;8245.587720613825;5728.312602487728;6190.907136392868;6339.587926784744;6342.270638876588;6440.5491615588335;6799.694013769294;6803;6827.453803695792;6828.692708828015;6845.178578570603;6142.508599312134;6324.620522768649;6370.872582548416;6412.487001039999;6415.647139407378;6207.751689932352;6236.688165591793;6262.1546091278915;6350.206224221973;6365.872682546231;6630.005499175162;6630.1049358336;6659.167604049494;6667.566608170453;6675.03212034262;5954.46409823118;5986.700664966647;6005.939940600538;6013.879722405615;6015.6691381974415;6249.843753906189;6280.403361680633;6287.811365659038;6289.7484100635465;6328.778492752916 14:27:54 INFO - PROCESS | 24434 | |4;prototype.html;298.4091498832312;301.8370080156715;306.73467450655176;312.11048511741524;312.8529591092186;5697.572682048847;5775.566832487564;5791.681457519835;5859.150423188635;5922.496587790043;5728.914066289009;5761.539076873851;5792.971035144829;5830.3586605473365;5862.9739795535825;4200.201961627296;4307.978460107695;4399.340098985146;4407.845725399612;4421.933670994921;4403.207422663919;4407;4413.977930110345;4425.24770788965;4435.955640443586;4362.8036738346855;4378.343248512717;4382.649388048964;4384.386185933972;4392.692511524195;4127.2570937231285;4238.5761423857675;4306.590873866978;4315.935260971088;4348.9782551087355;3717.312297225022;3717.5724791649036;3718.4980027696183;3724.8137593120505;3728.422094575318;5531.059719847635;5563.805266815642;5563.860903477445;5572.944270557324;5578.525825304813;5019.498050194988;5019.774110165052;5031.52200540948;5031.597472202215;5033.672811267256;6103.755849766004;6104.053871649857;6111.480524155452;6113.633182009094;6115.174451449042;4010.7794071326066;4123.8969025774295;4126.628603425706;4130.669546436308;4137.689673274486;6249.218847644044;6313.684315784192;6372.776952806629;6377.139086223347;6398.584092034003;4233.7671428071135;4234.9576504234565;4235.449391579075;4238.19474299882;4239.59723826236;4280.700350975402;4285.142971405731;4287.627959053073;4290.82836686529;4294.398784170218;5030.4215015272985;5034.773435195425;5035.0685123252315;5035.269885866602;5042.067217564762;6152.107944348045;6157.014877619559;6161.7227224775;6162.198914141222;6167.136600875881;1455.5269537400388;1501.06183635228;1501.4444655477325;1502.5417247739545;1508.3287936868207;935.6958988328685;960.1646567486192;963.1668606655193;980.9509524523745;985.2462865907586;5734.541236701054;5744.942550574524;5748.5688573357165;5785.190073389729;5786.218860453869;6273.0904018917;6334.334894835976;6337.207849018872;6341.460975817107;6349.142865713162;5803.622764520293;5831.037878750044;5833.358330583633;5834.591578589543;5838.854028649318;3355.681210285019;3386.4412371958842;3386.5936087669143;3389.8983030509125;3392.423288041039;6407.615543067431;6507.837304067436;6604.537682362188;6615.536912416181;6617.933820661828;6393.9360606394275;6420.293767685551;6424.068510066014;6426.1003459515705;6442.098106265126;6575.112359831362;6576.901346479806;6586.143801305895;6591.802245932629;6596.472282217411;6249.437550620466;6250.4687101595055;6257.843553911189;6261.405166509175;6273.059041143865;6137.41694539018;6197.411245931629;6202.906956395567;6205.541697701127;6210.627362358273;6732.629705366252;6776.186857577122;6795.524313298021;6795.660216989229;6817.352351526597;4207.347861081537;4225.852095176777;4228.70399072062;4234.5342012378;4235.4282171907635;6304.432601065926;6344;6356.936430635819;6358.332375100548;6364.809055728336;6154.5384096192065;6162.691865406801;6164.753409863555;6164.938350616437;6167.1366008759705;5992.0712289595185;6158.353372895961;6170.629762214281;6198.256209254918;6201.007838745779;6050.485708714633;6068.423499767515;6071.848203794941;6079.1793107931635;6084.330723620486;6207.255129384503;6209.0686397039;6209.130721699056;6209.813705588839;6214.751409943552;5789.652620842763;5935.228420305332;6065.272167339947;6078.908816367846;6080.939190608037 14:27:54 INFO - PROCESS | 24434 | |5;yui.html;720.2149656874008;745.1095940351275;761.5887420792773;769.9615019249038;828.3952714518398;12200.572979945704;12375.50497980082;12401.56594519192;12425.627231183067;12431;12944.935275323634;13543.322833858318;13690.794638080437;13691.657708557292;13707.72584548311;673.760814910707;680.5338343234876;812.8171161488663;813.9552324622143;821.36344333142;826.1449399871135;828.1097819843662;829.3738227638124;829.5976451421086;829.7552222094466;860.4966094834498;863.3481721300409;863.7279257034046;864.9654013839439;865.8354912566624;703.3283214530137;832.7210384521223;850.0776657326746;856.7258477287271;858.1289990659485;628.673089993201;628.6887990444714;628.8679377330766;629.5939119268046;630.2814791138106;12626.873731262662;12645.810312845315;12647.62057138278;12650.873491265062;12687.429065692066;12591.37043147839;12950.352482375938;13061.216327020315;13296.135751176143;13325.666858328523;10396;10655.893441065567;10688.358698478116;11360.829587556193;11606;3684.5394325709285;3718.4980027696183;3724.2923844469465;3744.4196149596855;3860.0542866997484;46556.5344346559;46561.53438465606;47438;48211.276830847564;48319.51680483221;9546.379485333431;9728.270379721549;9793.167580755573;9925.404475731335;10360;17987.550311242325;18110.185041673158;18132.365367212085;18132.818671813377;18167.545811354557;7668.003159589218;7693.269139431857;7762.92237077622;7763.340116090083;7960.1243863175005;4280.914381712349;4309.41822853917;4344.608985191285;4434.246178149722;4441.378207051015;3120.0171945836987;3147;3171.9682803172136;3177.3645270945904;3187.3784612000436;533.8852146788381;577.6101131736061;591.3672370563456;597.4981015946626;619.1208483952798;551.4375337156079;636.6752955992478;657.7090132878997;668.80938932405;670.4502308107403;7886.211378862068;8111.837763244702;8477.481999016036;8542.658293668308;8625;649.2760571962323;660.9867802644017;683.1392445518683;687.6974131382276;692.4045321023915;3871.5741268460447;3968.6229808168177;4106.958930410718;4208;4291.742495450283;58682.41317586855;58869;58887.41112588905;59059.70470147622;60581;51249.74375128175;52270.73864630653;53326.7333663337;53935.46064539383;54519.45480545144;45880.541194588295;47154.292685609056;47224.05551888943;47266.76366618145;47539.762301188275;8009.399295053011;8062.193780621891;8096.514209147234;8102.5948702563455;8272.751817445485;33607.495887562196;34166.974990750314;34366.48450273198;35464.29071418506;35475.467867982516;38720.419193711554;39498;44130;44351.77824110859;45304;11287.266327688674;11310.660680179608;11375.943120284346;11740.354280514654;12045;11579.189456737948;11771.176017678681;11878.168528203289;11895.702607434883;13022;11380.94309528447;11681.88318116808;11761.117916156152;11776.941115294369;12006.63980080599;11391.259568128045;11645.184837061324;11733.647990560297;11816.70458238551;12082.879171208175;11961.222520536137;12024.093759597214;12059.57791477294;12140.39298035077;12474.688132796753;10033.297669163088;10283.177345812466;10346;10517.15862730995;10651.733706657396;9289.442633442015;9370.531473426438;9800.558974846292;9821.312508124363;10040.69877903664 14:27:54 INFO - PROCESS | 24434 | __end_tp_report 14:27:54 INFO - PROCESS | 24434 | __start_cc_report 14:27:54 INFO - PROCESS | 24434 | _x_x_mozilla_cycle_collect,1098 14:27:54 INFO - PROCESS | 24434 | __end_cc_report 14:27:54 INFO - PROCESS | 24434 | __startTimestamp1456612074782__endTimestamp 14:27:54 INFO - PROCESS | 24434 | 14:27:54 INFO - PROCESS | 24434 | ------- Summary: start ------- 14:27:54 INFO - PROCESS | 24434 | Number of tests: 6 14:27:54 INFO - PROCESS | 24434 | 14:27:54 INFO - PROCESS | 24434 | [#0] dojo.html Cycles:165 Average:5013.86 Median:5203.56 stddev:539.53 (10.4%) stddev-sans-first:518.89 14:27:54 INFO - PROCESS | 24434 | Values: 3056.9 3111.9 3141.5 3161.6 3180.0 4905.1 4970.7 4975.2 5014.8 5031.0 5012.6 5030.6 5034.8 5041.5 5054.1 4526.4 4621.4 4676.3 4690.0 4691.7 4534.8 4561.5 4644.9 4653.0 4736.7 4625.2 4645.5 4648.9 4681.3 4684.2 4641.5 4645.8 4650.9 4667.4 4683.6 4551.7 4600.8 4618.3 4627.7 4639.0 4839.8 4843.1 4859.8 4865.7 4924.3 5423.5 5431.4 5431.7 5456.8 5482.5 5443.3 5458.9 5460.9 5466.2 5469.1 4979.3 5065.2 5089.9 5135.1 5147.3 5510.4 5554.2 5559.2 5612.6 5616.3 5301.0 5314.6 5345.3 5345.6 5345.7 5197.5 5263.4 5294.7 5347.6 5389.8 5252.7 5254.5 5264.2 5267.3 5269.9 5281.6 5283.6 5284.4 5293.5 5310.4 4051.6 4154.2 4179.1 4196.7 4216.7 3759.0 3763.0 3763.0 3763.9 3796.8 4932.2 5099.2 5109.8 5118.2 5161.1 5350.1 5376.2 5381.5 5420.4 5423.1 4879.4 4921.1 4922.8 4931.9 4966.9 4510.1 4519.6 4528.3 4554.1 4585.6 5665.2 5681.1 5695.5 5696.0 5744.0 5394.6 5410.2 5412.5 5419.3 5420.5 5501.6 5643.8 5655.1 5722.8 5732.7 5292.4 5312.7 5317.0 5318.5 5367.5 5403.2 5405.6 5407.3 5413.6 5452.3 5122.4 5257.7 5265.6 5337.3 5350.5 5242.4 5242.5 5249.8 5261.2 5277.9 5202.7 5202.9 5205.2 5206.1 5241.8 5068.9 5103.8 5241.7 5326.0 5329.9 5166.8 5203.6 5203.6 5210.0 5242.2 14:27:54 INFO - PROCESS | 24434 | 14:27:54 INFO - PROCESS | 24434 | [#1] ext.html Cycles:180 Average:42269.40 Median:35415.32 stddev:68211.03 (192.6%) stddev-sans-first:68330.35 14:27:54 INFO - PROCESS | 24434 | Values: 521.9 531.2 536.1 546.7 547.2 36263.3 36878.1 36922.6 37002.3 37054.3 40033.4 40372.8 40477.6 40512.4 40515.4 8108.6 8263.8 8263.9 8269.6 8274.1 8317.0 8532.1 8533.9 8815.3 8819.6 8807.9 8891.0 8892.3 8895.8 8900.0 8661.4 8769.1 8785.8 8790.6 8790.7 8548.5 8679.8 8680.4 8683.9 8687.9 39821.4 40275.8 40287.0 40340.6 40399.8 3381.6 3578.5 3819.3 3819.8 4130.1 30550.4 30802.4 31010.5 31013.5 32035.4 3986.9 4000.2 4029.5 4108.4 4159.4 268344.0 269286.0 270031.0 270100.0 270255.0 56341.4 57332.4 57521.1 57587.4 57590.7 49979.5 49982.0 50623.0 50969.5 51069.5 14462.1 14634.9 14722.8 14751.9 14796.1 10692.1 10738.8 10859.1 10925.6 10954.7 17273.2 19286.4 19419.3 19515.6 19556.1 6030.4 7138.1 7314.4 7430.2 7592.1 887.1 908.0 1041.9 1106.0 1127.9 26388.1 27963.2 28523.9 29076.0 29353.0 1031.0 1092.1 1099.4 1102.7 1122.1 14659.4 15055.2 15077.9 15107.4 15268.5 302745.0 305433.0 306424.0 306893.0 308324.0 51650.5 51908.5 51942.9 52022.0 52077.2 1181.2 1349.3 1361.0 1364.8 1447.3 24861.3 26108.9 26362.3 26458.5 28183.6 39827.0 40198.8 40268.4 40350.0 41455.8 195461.0 195818.0 196536.0 197297.0 197745.0 26584.9 31119.7 31685.0 31865.0 31895.7 37146.4 37916.6 38323.2 38381.2 38638.6 31321.4 31479.2 32029.2 32101.4 32449.8 31974.0 32107.4 32163.4 32760.3 35261.8 35199.0 35245.3 35568.8 35697.3 36346.0 29197.6 31532.2 32157.0 32187.7 32214.7 23747.5 24101.9 24241.6 24280.0 24490.8 14:27:54 INFO - PROCESS | 24434 | 14:27:54 INFO - PROCESS | 24434 | [#2] jquery.html Cycles:180 Average:25581.60 Median:432578.50 stddev:69957.40 (16.2%) stddev-sans-first:70127.98 14:27:54 INFO - PROCESS | 24434 | Values: 342.1 344.3 347.7 348.3 355.2 16704.2 16934.2 17145.8 17216.9 17689.7 16369.3 16699.7 16964.2 16965.3 16979.8 4636.4 5323.0 5452.7 5486.0 5503.3 3922.5 5371.5 5788.7 6032.7 6074.3 5993.5 6007.0 6007.9 6008.5 6012.6 5791.4 5868.2 5879.4 5923.2 5928.6 3534.1 4994.2 5140.0 5318.5 5332.6 19495.7 19753.3 19889.7 21313.4 21346.0 2416.5 2573.4 2603.0 2681.4 2939.9 13372.2 13382.9 13806.9 14016.7 14107.4 1950.6 2037.8 2065.2 2069.5 2073.1 58888.4 61758.1 68416.7 71749.0 77690.0 14692.9 15249.8 15315.7 15429.8 15453.4 24523.1 24743.6 24772.5 24869.1 24871.5 8176.2 8430.1 8625.7 8797.7 8874.5 7281.4 7329.0 7355.1 7436.1 7438.0 7834.6 7916.2 7969.4 7981.8 8032.6 2533.6 2960.2 2981.8 3022.1 3042.6 884.6 949.3 973.3 982.8 1076.2 15489.9 15754.9 15773.6 15943.8 16207.8 937.4 973.5 985.1 1004.6 1008.2 8855.5 9049.4 9324.7 9415.4 9516.5 408986.0 429155.0 430001.0 431593.0 433564.0 71022.6 72646.6 73440.0 73592.0 73845.3 972.4 984.3 992.2 1000.7 1001.2 14254.7 14524.4 14601.4 14648.6 14862.9 32575.3 33860.5 34072.3 34434.7 35407.0 43887.6 44095.0 44225.3 44590.3 45144.3 7826.3 7930.5 7933.2 7953.8 8089.0 8073.7 11277.5 11749.8 12464.9 12725.6 8541.4 10034.7 10119.5 10165.1 10459.7 6471.0 8321.7 10719.6 10944.6 10986.3 5802.1 8380.3 10251.2 10805.5 11208.3 7542.5 7929.9 7954.9 8097.7 8107.8 8200.3 9429.9 9896.9 9974.1 10157.6 14:27:54 INFO - PROCESS | 24434 | 14:27:54 INFO - PROCESS | 24434 | [#3] mootools.html Cycles:180 Average:5112.80 Median:6079.09 stddev:2633.85 (43.3%) stddev-sans-first:2625.92 14:27:54 INFO - PROCESS | 24434 | Values: 1333.9 1435.3 1451.4 1606.6 1789.6 6477.4 7000.2 7151.2 7159.5 7162.2 7095.6 7265.9 7267.6 7268.2 7273.2 1925.0 2139.0 2188.6 2209.0 2236.2 2179.9 2204.4 2216.1 2216.7 2218.4 2171.4 2174.8 2177.9 2179.5 2179.8 2130.6 2162.7 2163.6 2164.5 2167.5 2135.5 2144.4 2145.0 2146.0 2210.0 7411.8 7466.4 7479.7 7489.1 7491.5 4449.9 4525.5 4546.2 4572.4 4579.5 2884.7 2963.2 2997.4 3001.8 3011.3 956.8 959.5 972.4 992.8 998.5 10078.0 10105.6 10128.4 10151.9 10161.3 3869.5 3977.9 4012.7 4024.7 4042.7 8653.0 8680.2 8685.7 8704.2 8704.7 4050.8 4352.5 4546.8 4553.8 4568.0 4000.0 4005.9 4041.1 4046.2 4059.5 3412.4 3468.9 3472.3 3493.2 3505.2 1104.1 1109.1 1113.0 1120.5 1137.4 1311.0 1330.8 1331.0 1332.7 1348.3 6985.3 7044.6 7113.1 7120.8 7131.6 495.4 498.2 500.3 502.4 512.6 5426.7 5485.8 5486.3 5500.4 5528.7 8268.1 8442.8 8445.7 8470.9 8537.0 8428.0 8442.2 8442.7 8463.7 8465.2 6555.7 6640.9 6712.3 6986.3 7201.7 6858.7 6917.7 6917.7 6927.6 7012.5 7663.2 7944.0 7992.8 8065.2 8067.3 7940.2 8086.9 8222.9 8227.0 8245.6 5728.3 6190.9 6339.6 6342.3 6440.5 6799.7 6803.0 6827.5 6828.7 6845.2 6142.5 6324.6 6370.9 6412.5 6415.6 6207.8 6236.7 6262.2 6350.2 6365.9 6630.0 6630.1 6659.2 6667.6 6675.0 5954.5 5986.7 6005.9 6013.9 6015.7 6249.8 6280.4 6287.8 6289.7 6328.8 14:27:54 INFO - PROCESS | 24434 | 14:27:54 INFO - PROCESS | 24434 | [#4] prototype.html Cycles:180 Average:5100.20 Median:5833.97 stddev:1576.00 (27.0%) stddev-sans-first:1538.66 14:27:54 INFO - PROCESS | 24434 | Values: 298.4 301.8 306.7 312.1 312.9 5697.6 5775.6 5791.7 5859.2 5922.5 5728.9 5761.5 5793.0 5830.4 5863.0 4200.2 4308.0 4399.3 4407.8 4421.9 4403.2 4407.0 4414.0 4425.2 4436.0 4362.8 4378.3 4382.6 4384.4 4392.7 4127.3 4238.6 4306.6 4315.9 4349.0 3717.3 3717.6 3718.5 3724.8 3728.4 5531.1 5563.8 5563.9 5572.9 5578.5 5019.5 5019.8 5031.5 5031.6 5033.7 6103.8 6104.1 6111.5 6113.6 6115.2 4010.8 4123.9 4126.6 4130.7 4137.7 6249.2 6313.7 6372.8 6377.1 6398.6 4233.8 4235.0 4235.4 4238.2 4239.6 4280.7 4285.1 4287.6 4290.8 4294.4 5030.4 5034.8 5035.1 5035.3 5042.1 6152.1 6157.0 6161.7 6162.2 6167.1 1455.5 1501.1 1501.4 1502.5 1508.3 935.7 960.2 963.2 981.0 985.2 5734.5 5744.9 5748.6 5785.2 5786.2 6273.1 6334.3 6337.2 6341.5 6349.1 5803.6 5831.0 5833.4 5834.6 5838.9 3355.7 3386.4 3386.6 3389.9 3392.4 6407.6 6507.8 6604.5 6615.5 6617.9 6393.9 6420.3 6424.1 6426.1 6442.1 6575.1 6576.9 6586.1 6591.8 6596.5 6249.4 6250.5 6257.8 6261.4 6273.1 6137.4 6197.4 6202.9 6205.5 6210.6 6732.6 6776.2 6795.5 6795.7 6817.4 4207.3 4225.9 4228.7 4234.5 4235.4 6304.4 6344.0 6356.9 6358.3 6364.8 6154.5 6162.7 6164.8 6164.9 6167.1 5992.1 6158.4 6170.6 6198.3 6201.0 6050.5 6068.4 6071.8 6079.2 6084.3 6207.3 6209.1 6209.1 6209.8 6214.8 5789.7 5935.2 6065.3 6078.9 6080.9 14:27:54 INFO - PROCESS | 24434 | 14:27:54 INFO - PROCESS | 24434 | [#5] yui.html Cycles:180 Average:13876.35 Median:24872.69 stddev:16055.89 (64.6%) stddev-sans-first:16070.54 14:27:54 INFO - PROCESS | 24434 | Values: 720.2 745.1 761.6 770.0 828.4 12200.6 12375.5 12401.6 12425.6 12431.0 12944.9 13543.3 13690.8 13691.7 13707.7 673.8 680.5 812.8 814.0 821.4 826.1 828.1 829.4 829.6 829.8 860.5 863.3 863.7 865.0 865.8 703.3 832.7 850.1 856.7 858.1 628.7 628.7 628.9 629.6 630.3 12626.9 12645.8 12647.6 12650.9 12687.4 12591.4 12950.4 13061.2 13296.1 13325.7 10396.0 10655.9 10688.4 11360.8 11606.0 3684.5 3718.5 3724.3 3744.4 3860.1 46556.5 46561.5 47438.0 48211.3 48319.5 9546.4 9728.3 9793.2 9925.4 10360.0 17987.6 18110.2 18132.4 18132.8 18167.5 7668.0 7693.3 7762.9 7763.3 7960.1 4280.9 4309.4 4344.6 4434.2 4441.4 3120.0 3147.0 3172.0 3177.4 3187.4 533.9 577.6 591.4 597.5 619.1 551.4 636.7 657.7 668.8 670.5 7886.2 8111.8 8477.5 8542.7 8625.0 649.3 661.0 683.1 687.7 692.4 3871.6 3968.6 4107.0 4208.0 4291.7 58682.4 58869.0 58887.4 59059.7 60581.0 51249.7 52270.7 53326.7 53935.5 54519.5 45880.5 47154.3 47224.1 47266.8 47539.8 8009.4 8062.2 8096.5 8102.6 8272.8 33607.5 34167.0 34366.5 35464.3 35475.5 38720.4 39498.0 44130.0 44351.8 45304.0 11287.3 11310.7 11375.9 11740.4 12045.0 11579.2 11771.2 11878.2 11895.7 13022.0 11380.9 11681.9 11761.1 11776.9 12006.6 11391.3 11645.2 11733.6 11816.7 12082.9 11961.2 12024.1 12059.6 12140.4 12474.7 10033.3 10283.2 10346.0 10517.2 10651.7 9289.4 9370.5 9800.6 9821.3 10040.7 14:27:54 INFO - PROCESS | 24434 | -------- Summary: end -------- 14:27:54 INFO - PROCESS | 24434 | 14:27:54 INFO - PROCESS | 24434 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:27:54 INFO - PROCESS | 24434 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:27:54 INFO - PROCESS | 24434 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:27:54 INFO - PROCESS | 24434 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:27:54 INFO - PROCESS | 24434 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:27:54 INFO - PROCESS | 24434 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:27:54 INFO - PROCESS | 24434 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:27:55 INFO - TEST-INFO | 24434: exit 0 14:27:55 INFO - TEST-OK | dromaeo_css | took 1113055ms 14:27:55 INFO - TEST-START | kraken 14:27:55 INFO - operating with platform_type : linux_ 14:27:55 INFO - Initialising browser for kraken test... 14:27:55 INFO - TEST-INFO | started process 24619 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjo95af/profile http://localhost:59009/getInfo.html) 14:27:59 INFO - PROCESS | 24619 | __metrics Screen width/height:1600/1200 14:27:59 INFO - PROCESS | 24619 | colorDepth:24 14:27:59 INFO - PROCESS | 24619 | Browser inner width/height: 1024/697 14:27:59 INFO - PROCESS | 24619 | __metrics 14:28:00 INFO - PROCESS | 24619 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:28:00 INFO - PROCESS | 24619 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:28:00 INFO - PROCESS | 24619 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:28:00 INFO - PROCESS | 24619 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:28:00 INFO - PROCESS | 24619 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:28:00 INFO - PROCESS | 24619 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:28:00 INFO - PROCESS | 24619 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:28:00 INFO - PROCESS | 24619 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:28:01 INFO - TEST-INFO | 24619: exit 0 14:28:01 INFO - Browser initialized. 14:28:01 INFO - Running cycle 1/1 for kraken test... 14:28:01 INFO - TEST-INFO | started process 24704 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjo95af/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:28:13 INFO - PROCESS | 24704 | RSS: Main: 150142976 14:28:13 INFO - PROCESS | 24704 | 14:28:15 INFO - PROCESS | 24704 | Cycle 1(1): loaded http://localhost:59009/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59009/tests/kraken/driver.html?testName=audio-beat-detection) 14:28:16 INFO - PROCESS | 24704 | RSS: Main: 193945600 14:28:16 INFO - PROCESS | 24704 | 14:28:19 INFO - PROCESS | 24704 | Cycle 1(1): loaded http://localhost:59009/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59009/tests/kraken/driver.html?testName=audio-dft) 14:28:19 INFO - PROCESS | 24704 | RSS: Main: 183607296 14:28:19 INFO - PROCESS | 24704 | 14:28:22 INFO - PROCESS | 24704 | Cycle 1(1): loaded http://localhost:59009/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59009/tests/kraken/driver.html?testName=audio-fft) 14:28:23 INFO - PROCESS | 24704 | RSS: Main: 166588416 14:28:23 INFO - PROCESS | 24704 | 14:28:25 INFO - PROCESS | 24704 | Cycle 1(1): loaded http://localhost:59009/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59009/tests/kraken/driver.html?testName=audio-oscillator) 14:28:25 INFO - PROCESS | 24704 | RSS: Main: 170500096 14:28:25 INFO - PROCESS | 24704 | 14:28:27 INFO - PROCESS | 24704 | Cycle 1(1): loaded http://localhost:59009/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59009/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:28:28 INFO - PROCESS | 24704 | RSS: Main: 172830720 14:28:28 INFO - PROCESS | 24704 | 14:28:31 INFO - PROCESS | 24704 | Cycle 1(1): loaded http://localhost:59009/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59009/tests/kraken/driver.html?testName=imaging-darkroom) 14:28:32 INFO - PROCESS | 24704 | RSS: Main: 172466176 14:28:32 INFO - PROCESS | 24704 | 14:28:35 INFO - PROCESS | 24704 | Cycle 1(1): loaded http://localhost:59009/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59009/tests/kraken/driver.html?testName=imaging-desaturate) 14:28:36 INFO - PROCESS | 24704 | RSS: Main: 172859392 14:28:36 INFO - PROCESS | 24704 | 14:28:38 INFO - PROCESS | 24704 | Cycle 1(1): loaded http://localhost:59009/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59009/tests/kraken/driver.html?testName=json-parse-financial) 14:28:39 INFO - PROCESS | 24704 | RSS: Main: 171892736 14:28:39 INFO - PROCESS | 24704 | 14:28:40 INFO - PROCESS | 24704 | Cycle 1(1): loaded http://localhost:59009/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59009/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:28:41 INFO - PROCESS | 24704 | RSS: Main: 183459840 14:28:41 INFO - PROCESS | 24704 | 14:28:43 INFO - PROCESS | 24704 | Cycle 1(1): loaded http://localhost:59009/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59009/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:28:43 INFO - PROCESS | 24704 | RSS: Main: 181157888 14:28:43 INFO - PROCESS | 24704 | 14:28:46 INFO - PROCESS | 24704 | Cycle 1(1): loaded http://localhost:59009/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59009/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:28:46 INFO - PROCESS | 24704 | RSS: Main: 191377408 14:28:46 INFO - PROCESS | 24704 | 14:28:49 INFO - PROCESS | 24704 | Cycle 1(1): loaded http://localhost:59009/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59009/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:28:49 INFO - PROCESS | 24704 | RSS: Main: 195842048 14:28:49 INFO - PROCESS | 24704 | 14:28:52 INFO - PROCESS | 24704 | Cycle 1(1): loaded http://localhost:59009/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59009/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:28:52 INFO - PROCESS | 24704 | RSS: Main: 194191360 14:28:52 INFO - PROCESS | 24704 | 14:28:54 INFO - PROCESS | 24704 | Cycle 1(1): loaded http://localhost:59009/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59009/tests/kraken/driver.html?testName=ai-astar) 14:28:54 INFO - PROCESS | 24704 | RSS: Main: 255750144 14:28:54 INFO - PROCESS | 24704 | 14:28:54 INFO - PROCESS | 24704 | __start_tp_report 14:28:54 INFO - PROCESS | 24704 | _x_x_mozilla_page_load 14:28:54 INFO - PROCESS | 24704 | _x_x_mozilla_page_load_details 14:28:54 INFO - PROCESS | 24704 | |i|pagename|runs| 14:28:54 INFO - PROCESS | 24704 | |0;ai-astar;110;112;106;109;112;111;101;111;111;111 14:28:54 INFO - PROCESS | 24704 | |1;audio-beat-detection;150;128;151;164;126;156;154;126;168;126 14:28:54 INFO - PROCESS | 24704 | |2;audio-dft;161;161;163;162;160;163;161;165;163;162 14:28:54 INFO - PROCESS | 24704 | |3;audio-fft;72;74;106;97;73;74;73;130;97;75 14:28:54 INFO - PROCESS | 24704 | |4;audio-oscillator;96;96;156;96;95;96;150;96;96;148 14:28:54 INFO - PROCESS | 24704 | |5;imaging-gaussian-blur;120;115;115;114;114;115;114;115;115;115 14:28:54 INFO - PROCESS | 24704 | |6;imaging-darkroom;146;145;146;146;146;145;146;146;145;146 14:28:54 INFO - PROCESS | 24704 | |7;imaging-desaturate;95;95;96;97;96;96;96;96;95;97 14:28:54 INFO - PROCESS | 24704 | |8;json-parse-financial;55;57;56;56;55;57;57;67;54;55 14:28:54 INFO - PROCESS | 24704 | |9;json-stringify-tinderbox;69;69;68;69;68;69;69;67;68;68 14:28:54 INFO - PROCESS | 24704 | |10;stanford-crypto-aes;81;83;84;83;82;91;84;82;83;83 14:28:54 INFO - PROCESS | 24704 | |11;stanford-crypto-ccm;124;115;114;115;116;116;116;123;115;124 14:28:54 INFO - PROCESS | 24704 | |12;stanford-crypto-pbkdf2;155;143;152;149;157;138;158;149;148;151 14:28:54 INFO - PROCESS | 24704 | |13;stanford-crypto-sha256-iterative;71;68;69;69;67;69;67;67;68;68 14:28:54 INFO - PROCESS | 24704 | __end_tp_report 14:28:54 INFO - PROCESS | 24704 | __start_cc_report 14:28:54 INFO - PROCESS | 24704 | _x_x_mozilla_cycle_collect,1091 14:28:54 INFO - PROCESS | 24704 | __end_cc_report 14:28:54 INFO - PROCESS | 24704 | __startTimestamp1456612134743__endTimestamp 14:28:54 INFO - PROCESS | 24704 | 14:28:54 INFO - PROCESS | 24704 | ------- Summary: start ------- 14:28:54 INFO - PROCESS | 24704 | Number of tests: 14 14:28:54 INFO - PROCESS | 24704 | 14:28:54 INFO - PROCESS | 24704 | [#0] ai-astar Cycles:10 Average:109.40 Median:111.00 stddev:3.44 (3.1%) stddev-sans-first:3.64 14:28:54 INFO - PROCESS | 24704 | Values: 110.0 112.0 106.0 109.0 112.0 111.0 101.0 111.0 111.0 111.0 14:28:54 INFO - PROCESS | 24704 | 14:28:54 INFO - PROCESS | 24704 | [#1] audio-beat-detection Cycles:10 Average:144.90 Median:152.50 stddev:16.75 (11.0%) stddev-sans-first:17.66 14:28:54 INFO - PROCESS | 24704 | Values: 150.0 128.0 151.0 164.0 126.0 156.0 154.0 126.0 168.0 126.0 14:28:54 INFO - PROCESS | 24704 | 14:28:54 INFO - PROCESS | 24704 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.50 stddev:1.45 (0.9%) stddev-sans-first:1.48 14:28:54 INFO - PROCESS | 24704 | Values: 161.0 161.0 163.0 162.0 160.0 163.0 161.0 165.0 163.0 162.0 14:28:54 INFO - PROCESS | 24704 | 14:28:54 INFO - PROCESS | 24704 | [#3] audio-fft Cycles:10 Average:87.10 Median:74.00 stddev:19.75 (26.7%) stddev-sans-first:20.17 14:28:54 INFO - PROCESS | 24704 | Values: 72.0 74.0 106.0 97.0 73.0 74.0 73.0 130.0 97.0 75.0 14:28:54 INFO - PROCESS | 24704 | 14:28:54 INFO - PROCESS | 24704 | [#4] audio-oscillator Cycles:10 Average:112.50 Median:96.00 stddev:26.87 (28.0%) stddev-sans-first:27.83 14:28:54 INFO - PROCESS | 24704 | Values: 96.0 96.0 156.0 96.0 95.0 96.0 150.0 96.0 96.0 148.0 14:28:54 INFO - PROCESS | 24704 | 14:28:54 INFO - PROCESS | 24704 | [#5] imaging-gaussian-blur Cycles:10 Average:115.20 Median:115.00 stddev:1.75 (1.5%) stddev-sans-first:0.50 14:28:54 INFO - PROCESS | 24704 | Values: 120.0 115.0 115.0 114.0 114.0 115.0 114.0 115.0 115.0 115.0 14:28:54 INFO - PROCESS | 24704 | 14:28:54 INFO - PROCESS | 24704 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 14:28:54 INFO - PROCESS | 24704 | Values: 146.0 145.0 146.0 146.0 146.0 145.0 146.0 146.0 145.0 146.0 14:28:54 INFO - PROCESS | 24704 | 14:28:54 INFO - PROCESS | 24704 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 14:28:54 INFO - PROCESS | 24704 | Values: 95.0 95.0 96.0 97.0 96.0 96.0 96.0 96.0 95.0 97.0 14:28:54 INFO - PROCESS | 24704 | 14:28:54 INFO - PROCESS | 24704 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:56.50 stddev:3.70 (6.5%) stddev-sans-first:3.86 14:28:54 INFO - PROCESS | 24704 | Values: 55.0 57.0 56.0 56.0 55.0 57.0 57.0 67.0 54.0 55.0 14:28:54 INFO - PROCESS | 24704 | 14:28:54 INFO - PROCESS | 24704 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:69.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 14:28:54 INFO - PROCESS | 24704 | Values: 69.0 69.0 68.0 69.0 68.0 69.0 69.0 67.0 68.0 68.0 14:28:54 INFO - PROCESS | 24704 | 14:28:54 INFO - PROCESS | 24704 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:83.00 stddev:2.76 (3.3%) stddev-sans-first:2.76 14:28:54 INFO - PROCESS | 24704 | Values: 81.0 83.0 84.0 83.0 82.0 91.0 84.0 82.0 83.0 83.0 14:28:54 INFO - PROCESS | 24704 | 14:28:54 INFO - PROCESS | 24704 | [#11] stanford-crypto-ccm Cycles:10 Average:117.80 Median:116.00 stddev:4.10 (3.5%) stddev-sans-first:3.69 14:28:54 INFO - PROCESS | 24704 | Values: 124.0 115.0 114.0 115.0 116.0 116.0 116.0 123.0 115.0 124.0 14:28:54 INFO - PROCESS | 24704 | 14:28:54 INFO - PROCESS | 24704 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.00 Median:151.50 stddev:6.16 (4.1%) stddev-sans-first:6.27 14:28:54 INFO - PROCESS | 24704 | Values: 155.0 143.0 152.0 149.0 157.0 138.0 158.0 149.0 148.0 151.0 14:28:54 INFO - PROCESS | 24704 | 14:28:54 INFO - PROCESS | 24704 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:1.25 (1.8%) stddev-sans-first:0.87 14:28:54 INFO - PROCESS | 24704 | Values: 71.0 68.0 69.0 69.0 67.0 69.0 67.0 67.0 68.0 68.0 14:28:54 INFO - PROCESS | 24704 | -------- Summary: end -------- 14:28:54 INFO - PROCESS | 24704 | 14:28:54 INFO - PROCESS | 24704 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:28:54 INFO - PROCESS | 24704 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:28:54 INFO - PROCESS | 24704 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:28:54 INFO - PROCESS | 24704 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:28:54 INFO - PROCESS | 24704 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 14:28:55 INFO - TEST-INFO | 24704: exit 0 14:28:55 INFO - TEST-OK | kraken | took 60105ms 14:28:55 INFO - SUITE-END | took 1173s 14:28:55 INFO - Completed test suite (00:19:33) 14:28:55 INFO - Working with test: dromaeo_css 14:28:55 INFO - Generating results file: dromaeo_css 14:28:55 INFO - Working with test: kraken 14:28:55 INFO - Generating results file: kraken 14:28:55 INFO - javascript benchmark 14:28:55 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:28:56 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 14:28:56 INFO - process_Request line: dromaeo_css 6755.84 graph.html#tests=[[72,64,35]] 14:28:56 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:28:56 INFO - process_Request line: kraken 1517.80 graph.html#tests=[[232,64,35]] 14:28:56 INFO - RETURN: dromaeo_css: 6755.84 14:28:56 INFO - RETURN: kraken: 1517.80 14:28:56 INFO - javascript benchmark 14:28:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3056.9082927512177, 3111.9377612447765, 3141.497360422333, 3161.5731876196705, 3179.9983005353306, 4905.141600219965, 4970.701757894524, 4975.154223781957, 5014.774335154918, 5031.018951304497, 5012.649114561982, 5030.57240134589, 5034.798608055673, 5041.495850414956, 5054.064997975377, 4526.434195725535, 4621.37611422457, 4676.321933319667, 4690.038542098861, 4691.671582989192, 4534.795934182953, 4561.475430325505, 4644.907101857961, 4653.046125544272, 4736.739479328636, 4625.167469855424, 4645.512221216757, 4648.907021859578, 4681.321208424793, 4684.180268453007, 4641.512641172662, 4645.76771161444, 4650.930236046462, 4667.439907211123, 4683.555062269079, 4551.749653769041, 4600.815967361302, 4618.284165954283, 4627.722336659811, 4639.0, 4839.782209800567, 4843.128236917353, 4859.781309841065, 4865.70805751656, 4924.3105965164905, 5423.511883930465, 5431.402545719968, 5431.701256430894, 5456.781728730846, 5482.479164479368, 5443.346798384219, 5458.918116228259, 5460.890782184374, 5466.1527463243265, 5469.124940009579, 4979.278004689336, 5065.1642478990925, 5089.949100509021, 5135.050015747099, 5147.253648221024, 5510.421405752419, 5554.166874968787, 5559.16612508127, 5612.635178713453, 5616.326040875121, 5301.019311427398, 5314.627976041717, 5345.305110335631, 5345.572354211654, 5345.65253258537, 5197.532222100029, 5263.4473380295285, 5294.708791016454, 5347.598930080259, 5389.8113566025, 5252.737363131828, 5254.527092561611, 5264.184051472028, 5267.341582302212, 5269.868253293622, 5281.60387970896, 5283.6037297202865, 5284.39229488606, 5293.470652934753, 5310.362756469249, 4051.594840515984, 4154.189932963043, 4179.101493178981, 4196.664266858644, 4216.683748718859, 3758.962410375861, 3763.0, 3763.040424691686, 3763.8682646107804, 3796.772193668389, 4932.1861892788, 5099.158638824552, 5109.846704598868, 5118.181091025493, 5161.09680805865, 5350.117230656898, 5376.247325374451, 5381.461853814587, 5420.403755586883, 5423.05096608092, 4879.365682461328, 4921.114199444063, 4922.803087876517, 4931.876703082452, 4966.900661986812, 4510.075434535912, 4519.570640789119, 4528.252838281646, 4554.111948170075, 4585.633149348044, 5665.235193248941, 5681.0910254359105, 5695.458931401427, 5695.971520142372, 5744.023516002206, 5394.649347792381, 5410.242566040679, 5412.458754124556, 5419.2954915862265, 5420.4850539198715, 5501.559875210054, 5643.7742490299925, 5655.095184770417, 5722.7710891563875, 5732.684702341411, 5292.364916210079, 5312.707801070978, 5316.973415132899, 5318.521333080042, 5367.543758780547, 5403.243545903655, 5405.648632838853, 5407.270018547603, 5413.648112872808, 5452.263944367618, 5122.359705036871, 5257.658252213594, 5265.60507961912, 5337.306150200604, 5350.491703288337, 5242.397124330751, 5242.501962313574, 5249.763760630704, 5261.237120617566, 5277.920831187458, 5202.713850738246, 5202.869928251824, 5205.167173252262, 5206.140986737298, 5241.764120614658, 5068.873278167928, 5103.77033033507, 5241.659292145999, 5326.0, 5329.946700532945, 5166.819161329336, 5203.5576975955955, 5203.635745497931, 5210.036143313499, 5242.239875218148], "unit": "score", "name": "dojo.html", "value": 4980.626427715885}, {"lowerIsBetter": false, "replicates": [521.9112750832361, 531.1793279383354, 536.0779459329952, 546.6692650946178, 547.1573776384369, 36263.27473450529, 36878.07804804878, 36922.63077369229, 37002.25995480089, 37054.25891482169, 40033.39949900754, 40372.798136009354, 40477.59522404775, 40512.392314115314, 40515.39226911599, 8108.594570271493, 8263.793405164859, 8263.876041859377, 8269.62786674601, 8274.089850116483, 8317.0, 8532.14678532148, 8533.914660853405, 8815.338849586275, 8819.603117859711, 8807.911920880806, 8891.0, 8892.288616910664, 8895.77760555988, 8900.0, 8661.393702440831, 8769.079246679134, 8785.824283514357, 8790.56047197644, 8790.736277911641, 8548.529830859301, 8679.826403471896, 8680.435771674822, 8683.913160868437, 8687.913120868774, 39821.402678959836, 40275.798621007, 40287.0, 40340.59659403427, 40399.7980010101, 3381.5603971483797, 3578.4632305154173, 3819.2552452271816, 3819.770813751156, 4130.070734084807, 30550.388992220254, 30802.38395232083, 31010.534841977387, 31013.534796978063, 32035.359292814013, 3986.86045988389, 4000.219957108336, 4029.476168098158, 4108.424820525129, 4159.438475805758, 268344.0, 269286.0, 270031.0, 270099.999999998, 270255.0, 56341.43658563444, 57332.426675732706, 57521.137182942286, 57587.42412575905, 57590.712046440334, 49979.50020499749, 49982.0, 50623.0, 50969.49030509647, 51069.48930510647, 14462.132272063709, 14634.926825365805, 14722.779158312635, 14751.852481475262, 14796.112233266038, 10692.091172250446, 10738.8187299397, 10859.099657559895, 10925.617603383844, 10954.671359859218, 17273.205316506257, 19286.35930738086, 19419.33784837991, 19515.580609243752, 19556.119974601177, 6030.396960304022, 7138.143422789299, 7314.378277846443, 7430.219826918204, 7592.126905405949, 887.1128871128872, 907.950062746542, 1041.9270651054353, 1105.9668209953713, 1127.9154063445274, 26388.08107019825, 27963.161105166877, 28523.857380712965, 29076.0, 29353.0, 1030.9690709278734, 1092.093562343253, 1099.3568762273999, 1102.685734565661, 1122.1359553144196, 14659.413623454942, 15055.247237638074, 15077.924610376878, 15107.39570417171, 15268.541943741706, 302745.0, 305433.0, 306424.0, 306893.0, 308324.0, 51650.48349516532, 51908.48091519037, 51942.8834269945, 52022.0, 52077.218841717404, 1181.2440038375446, 1349.27813619713, 1361.0404664711355, 1364.7611667958067, 1447.2691290898028, 24861.254162375157, 26108.8694556526, 26362.340941476617, 26458.470830582897, 28183.57724634173, 39827.0, 40198.79900600478, 40268.39597405983, 40350.0, 41455.7927210362, 195461.0, 195818.0, 196536.0, 197297.0, 197745.0, 26584.867075664497, 31119.68880311168, 31685.0, 31865.044048678577, 31895.68104318927, 37146.44280335851, 37916.62083379241, 38323.23353532858, 38381.2323753529, 38638.613613863505, 31321.37357252888, 31479.21301967469, 32029.199270018435, 32101.35797284088, 32449.837750811093, 31974.0, 32107.357852842346, 32163.35673286568, 32760.344793104483, 35261.82369088138, 35199.0, 35245.29509409746, 35568.82215588906, 35697.28605427825, 36346.0, 29197.562036569045, 31532.211694706897, 32157.0, 32187.678123219404, 32214.67785322117, 23747.525049498567, 24101.879490602434, 24241.611138440552, 24280.0, 24490.755092448846], "unit": "score", "name": "ext.html", "value": 17698.910167002377}, {"lowerIsBetter": false, "replicates": [342.10198229647176, 344.3165316846061, 347.6575573060535, 348.3329424152748, 355.2202914602447, 16704.248308826103, 16934.15329233538, 17145.828541714578, 17216.91391543042, 17689.734653980202, 16369.345226190939, 16699.74950375745, 16964.236609352578, 16965.32138714453, 16979.83020169798, 4636.392188925498, 5322.973385133078, 5452.672839629615, 5486.039943009977, 5503.257060296869, 3922.4704664870164, 5371.489708477708, 5788.6816225107605, 6032.66820324882, 6074.331823499411, 5993.520518358521, 6007.038873780196, 6007.939920600804, 6008.459238668519, 6012.639241645494, 5791.420857914196, 5868.2371291732015, 5879.353271140171, 5923.229980102559, 5928.555358348098, 3534.0811389038777, 4994.2009278515625, 5139.972005598858, 5318.468153184689, 5332.573394128461, 19495.707564386546, 19753.308634197878, 19889.701654475193, 21313.360599181895, 21346.0, 2416.4683769570665, 2573.395252115751, 2602.958816473407, 2681.36987807865, 2939.8677059532374, 13372.197668139943, 13382.93308533451, 13806.93096534521, 14016.71966560663, 14107.365168567336, 1950.570874407628, 2037.7860324665844, 2065.1945741160957, 2069.4929742213253, 2073.067119796098, 58888.411115888724, 61758.0736288956, 68416.6579167106, 71749.0, 77689.99999999943, 14692.926535367254, 15249.847501525064, 15315.693686126215, 15429.845701542841, 15453.38186472551, 24523.141690040764, 24743.649353311408, 24772.504549909263, 24869.12958046496, 24871.50256994886, 8176.182381761776, 8430.072692003874, 8625.741227763177, 8797.692080777142, 8874.467531948103, 7281.381082607932, 7328.96335518319, 7355.080614923135, 7436.144843342977, 7437.995870557405, 7834.569098699626, 7916.247956444128, 7969.442139050327, 7981.800454988672, 8032.558209298545, 2533.569293220157, 2960.2451374899265, 2981.7625685340777, 3022.1386904732485, 3042.6348838139124, 884.6063501741663, 949.2785483032944, 973.255459573427, 982.832918403873, 1076.2143635146388, 15489.922550387177, 15754.9212253938, 15773.605659858595, 15943.760843587355, 16207.756883646754, 937.4141161773891, 973.454865275448, 985.1084768284713, 1004.5881188712593, 1008.193445243802, 8855.51294678786, 9049.366544341832, 9324.720258392259, 9415.435073895589, 9516.524173791282, 408986.0, 429155.0, 430001.0, 431593.0, 433564.0, 71022.64488677523, 72646.63676681688, 73440.0, 73592.0, 73845.26154738384, 972.397113789455, 984.296228196857, 992.2260636703382, 1000.6997900629782, 1001.2140469731372, 14254.714905702036, 14524.419023238952, 14601.415943362146, 14648.560543183721, 14862.851371486579, 32575.348493029534, 33860.49209261814, 34072.31855362929, 34434.65565344415, 35407.0, 43887.56112438963, 44095.0, 44225.33661995137, 44590.3311450335, 45144.32283515816, 7826.295633393022, 7930.484518506279, 7933.206679332021, 7953.801154971172, 8088.9595552021865, 8073.717419890276, 11277.548898044315, 11749.823752643546, 12464.937675311565, 12725.55460558876, 8541.444806087584, 10034.695489586307, 10119.494025298558, 10165.135963442894, 10459.68620941373, 6470.967645161744, 8321.710134929095, 10719.624813131502, 10944.616938407118, 10986.340819550853, 5802.129680547782, 8380.287675547646, 10251.231157663056, 10805.51375188134, 11208.27146235492, 7542.509736867086, 7929.881051784112, 7954.920450795649, 8097.676092956216, 8107.797305067184, 8200.302974247255, 9429.905700942903, 9896.851547226654, 9974.102330790263, 10157.593696252066], "unit": "score", "name": "jquery.html", "value": 8907.710615601554}, {"lowerIsBetter": false, "replicates": [1333.8866196373308, 1435.2608406670568, 1451.3831621560842, 1606.6465377616921, 1789.5973405983664, 6477.35226477352, 7000.19497757758, 7151.249118842518, 7159.4988350815465, 7162.247963963787, 7095.574265544071, 7265.927340726591, 7267.563946163234, 7268.200497945222, 7273.16358618759, 1924.980750192501, 2138.9893050534724, 2188.627933251351, 2209.0, 2236.2396785093065, 2179.891005449721, 2204.4488877780555, 2216.0692509146115, 2216.6896634471104, 2218.389942765736, 2171.413718296059, 2174.7825217478203, 2177.8693278403266, 2179.498715295483, 2179.8365122615787, 2130.6164890319737, 2162.7296587926508, 2163.621366260898, 2164.534625055605, 2167.5014746608213, 2135.519508110678, 2144.431725592719, 2145.0240140735928, 2146.0450099705636, 2209.9558008839895, 7411.814704632374, 7466.365358944497, 7479.663415146331, 7489.063867016623, 7491.51305165168, 4449.888752781174, 4525.524819893897, 4546.181687296285, 4572.359869618223, 4579.496255411902, 2884.668263149744, 2963.199936017285, 2997.370552184044, 3001.774866884992, 3011.3073992981517, 956.8038552096804, 959.5058544849409, 972.4165500699523, 992.7518120469882, 998.5057396588735, 10078.0, 10105.595776169019, 10128.442935638537, 10151.94924025375, 10161.33951293171, 3869.5163104611925, 3977.900552486211, 4012.678985681197, 4024.7383920045104, 4042.737222080614, 8653.0, 8680.218780309802, 8685.739427817176, 8704.216620504185, 8704.695335663222, 4050.7569545826755, 4352.521222665504, 4546.840860569931, 4553.772311384418, 4568.040711450632, 3999.960000399959, 4005.879823605238, 4041.0907545802547, 4046.2312160689376, 4059.4519739835337, 3412.351653185887, 3468.8612455502002, 3472.340255351475, 3493.179102910814, 3505.1938054247667, 1104.13877175803, 1109.14595761265, 1112.955481780736, 1120.5237773946203, 1137.3573930729276, 1310.967225819362, 1330.846952600444, 1330.966725831862, 1332.7068045030078, 1348.2719331561043, 6985.301469852974, 7044.577325360495, 7113.146422429239, 7120.821979450555, 7131.643417829192, 495.3906694765459, 498.24018371982294, 500.314569040417, 502.412177752031, 512.6488355476511, 5426.728663566806, 5485.780568777284, 5486.341639003345, 5500.3949565547755, 5528.668279903219, 8268.09051004389, 8442.788930276669, 8445.704400345958, 8470.915290847013, 8536.957315213383, 8428.0, 8442.155784421631, 8442.704505342406, 8463.661453541912, 8465.238128568459, 6555.704993275314, 6640.900386494206, 6712.2952090031795, 6986.301369863075, 7201.747938822221, 6858.691358888762, 6917.688704008231, 6917.688704008432, 6927.618980956096, 7012.544184627983, 7663.1570527243075, 7944.0, 7992.84014319722, 8065.153158918229, 8067.273945344712, 7940.245676660708, 8086.9191308086165, 8222.876656850272, 8226.958865205635, 8245.587720613825, 5728.312602487728, 6190.907136392868, 6339.587926784744, 6342.270638876588, 6440.5491615588335, 6799.694013769294, 6803.0, 6827.453803695792, 6828.692708828015, 6845.178578570603, 6142.508599312134, 6324.620522768649, 6370.872582548416, 6412.487001039999, 6415.647139407378, 6207.751689932352, 6236.688165591793, 6262.1546091278915, 6350.206224221973, 6365.872682546231, 6630.005499175162, 6630.1049358336, 6659.167604049494, 6667.566608170453, 6675.03212034262, 5954.46409823118, 5986.700664966647, 6005.939940600538, 6013.879722405615, 6015.6691381974415, 6249.843753906189, 6280.403361680633, 6287.811365659038, 6289.7484100635465, 6328.778492752916], "unit": "score", "name": "mootools.html", "value": 4168.987766845533}, {"lowerIsBetter": false, "replicates": [298.4091498832312, 301.8370080156715, 306.73467450655176, 312.11048511741524, 312.8529591092186, 5697.572682048847, 5775.566832487564, 5791.681457519835, 5859.150423188635, 5922.496587790043, 5728.914066289009, 5761.539076873851, 5792.971035144829, 5830.3586605473365, 5862.9739795535825, 4200.201961627296, 4307.978460107695, 4399.340098985146, 4407.845725399612, 4421.933670994921, 4403.207422663919, 4407.0, 4413.977930110345, 4425.24770788965, 4435.955640443586, 4362.8036738346855, 4378.343248512717, 4382.649388048964, 4384.386185933972, 4392.692511524195, 4127.2570937231285, 4238.5761423857675, 4306.590873866978, 4315.935260971088, 4348.9782551087355, 3717.312297225022, 3717.5724791649036, 3718.4980027696183, 3724.8137593120505, 3728.422094575318, 5531.059719847635, 5563.805266815642, 5563.860903477445, 5572.944270557324, 5578.525825304813, 5019.498050194988, 5019.774110165052, 5031.52200540948, 5031.597472202215, 5033.672811267256, 6103.755849766004, 6104.053871649857, 6111.480524155452, 6113.633182009094, 6115.174451449042, 4010.7794071326066, 4123.8969025774295, 4126.628603425706, 4130.669546436308, 4137.689673274486, 6249.218847644044, 6313.684315784192, 6372.776952806629, 6377.139086223347, 6398.584092034003, 4233.7671428071135, 4234.9576504234565, 4235.449391579075, 4238.19474299882, 4239.59723826236, 4280.700350975402, 4285.142971405731, 4287.627959053073, 4290.82836686529, 4294.398784170218, 5030.4215015272985, 5034.773435195425, 5035.0685123252315, 5035.269885866602, 5042.067217564762, 6152.107944348045, 6157.014877619559, 6161.7227224775, 6162.198914141222, 6167.136600875881, 1455.5269537400388, 1501.06183635228, 1501.4444655477325, 1502.5417247739545, 1508.3287936868207, 935.6958988328685, 960.1646567486192, 963.1668606655193, 980.9509524523745, 985.2462865907586, 5734.541236701054, 5744.942550574524, 5748.5688573357165, 5785.190073389729, 5786.218860453869, 6273.0904018917, 6334.334894835976, 6337.207849018872, 6341.460975817107, 6349.142865713162, 5803.622764520293, 5831.037878750044, 5833.358330583633, 5834.591578589543, 5838.854028649318, 3355.681210285019, 3386.4412371958842, 3386.5936087669143, 3389.8983030509125, 3392.423288041039, 6407.615543067431, 6507.837304067436, 6604.537682362188, 6615.536912416181, 6617.933820661828, 6393.9360606394275, 6420.293767685551, 6424.068510066014, 6426.1003459515705, 6442.098106265126, 6575.112359831362, 6576.901346479806, 6586.143801305895, 6591.802245932629, 6596.472282217411, 6249.437550620466, 6250.4687101595055, 6257.843553911189, 6261.405166509175, 6273.059041143865, 6137.41694539018, 6197.411245931629, 6202.906956395567, 6205.541697701127, 6210.627362358273, 6732.629705366252, 6776.186857577122, 6795.524313298021, 6795.660216989229, 6817.352351526597, 4207.347861081537, 4225.852095176777, 4228.70399072062, 4234.5342012378, 4235.4282171907635, 6304.432601065926, 6344.0, 6356.936430635819, 6358.332375100548, 6364.809055728336, 6154.5384096192065, 6162.691865406801, 6164.753409863555, 6164.938350616437, 6167.1366008759705, 5992.0712289595185, 6158.353372895961, 6170.629762214281, 6198.256209254918, 6201.007838745779, 6050.485708714633, 6068.423499767515, 6071.848203794941, 6079.1793107931635, 6084.330723620486, 6207.255129384503, 6209.0686397039, 6209.130721699056, 6209.813705588839, 6214.751409943552, 5789.652620842763, 5935.228420305332, 6065.272167339947, 6078.908816367846, 6080.939190608037], "unit": "score", "name": "prototype.html", "value": 4576.010692673867}, {"lowerIsBetter": false, "replicates": [720.2149656874008, 745.1095940351275, 761.5887420792773, 769.9615019249038, 828.3952714518398, 12200.572979945704, 12375.50497980082, 12401.56594519192, 12425.627231183067, 12431.0, 12944.935275323634, 13543.322833858318, 13690.794638080437, 13691.657708557292, 13707.72584548311, 673.760814910707, 680.5338343234876, 812.8171161488663, 813.9552324622143, 821.36344333142, 826.1449399871135, 828.1097819843662, 829.3738227638124, 829.5976451421086, 829.7552222094466, 860.4966094834498, 863.3481721300409, 863.7279257034046, 864.9654013839439, 865.8354912566624, 703.3283214530137, 832.7210384521223, 850.0776657326746, 856.7258477287271, 858.1289990659485, 628.673089993201, 628.6887990444714, 628.8679377330766, 629.5939119268046, 630.2814791138106, 12626.873731262662, 12645.810312845315, 12647.62057138278, 12650.873491265062, 12687.429065692066, 12591.37043147839, 12950.352482375938, 13061.216327020315, 13296.135751176143, 13325.666858328523, 10396.0, 10655.893441065567, 10688.358698478116, 11360.829587556193, 11606.0, 3684.5394325709285, 3718.4980027696183, 3724.2923844469465, 3744.4196149596855, 3860.0542866997484, 46556.5344346559, 46561.53438465606, 47438.0, 48211.276830847564, 48319.51680483221, 9546.379485333431, 9728.270379721549, 9793.167580755573, 9925.404475731335, 10360.0, 17987.550311242325, 18110.185041673158, 18132.365367212085, 18132.818671813377, 18167.545811354557, 7668.003159589218, 7693.269139431857, 7762.92237077622, 7763.340116090083, 7960.1243863175005, 4280.914381712349, 4309.41822853917, 4344.608985191285, 4434.246178149722, 4441.378207051015, 3120.0171945836987, 3147.0, 3171.9682803172136, 3177.3645270945904, 3187.3784612000436, 533.8852146788381, 577.6101131736061, 591.3672370563456, 597.4981015946626, 619.1208483952798, 551.4375337156079, 636.6752955992478, 657.7090132878997, 668.80938932405, 670.4502308107403, 7886.211378862068, 8111.837763244702, 8477.481999016036, 8542.658293668308, 8625.0, 649.2760571962323, 660.9867802644017, 683.1392445518683, 687.6974131382276, 692.4045321023915, 3871.5741268460447, 3968.6229808168177, 4106.958930410718, 4208.0, 4291.742495450283, 58682.41317586855, 58869.0, 58887.41112588905, 59059.70470147622, 60581.0, 51249.74375128175, 52270.73864630653, 53326.7333663337, 53935.46064539383, 54519.45480545144, 45880.541194588295, 47154.292685609056, 47224.05551888943, 47266.76366618145, 47539.762301188275, 8009.399295053011, 8062.193780621891, 8096.514209147234, 8102.5948702563455, 8272.751817445485, 33607.495887562196, 34166.974990750314, 34366.48450273198, 35464.29071418506, 35475.467867982516, 38720.419193711554, 39498.0, 44130.0, 44351.77824110859, 45304.0, 11287.266327688674, 11310.660680179608, 11375.943120284346, 11740.354280514654, 12045.0, 11579.189456737948, 11771.176017678681, 11878.168528203289, 11895.702607434883, 13022.0, 11380.94309528447, 11681.88318116808, 11761.117916156152, 11776.941115294369, 12006.63980080599, 11391.259568128045, 11645.184837061324, 11733.647990560297, 11816.70458238551, 12082.879171208175, 11961.222520536137, 12024.093759597214, 12059.57791477294, 12140.39298035077, 12474.688132796753, 10033.297669163088, 10283.177345812466, 10346.0, 10517.15862730995, 10651.733706657396, 9289.442633442015, 9370.531473426438, 9800.558974846292, 9821.312508124363, 10040.69877903664], "unit": "score", "name": "yui.html", "value": 6346.262448251613}], "name": "dromaeo_css", "value": 6755.835913765059}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 106.0, 109.0, 112.0, 111.0, 101.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.4}, {"lowerIsBetter": true, "replicates": [150.0, 128.0, 151.0, 164.0, 126.0, 156.0, 154.0, 126.0, 168.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 144.9}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 163.0, 162.0, 160.0, 163.0, 161.0, 165.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.1}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 106.0, 97.0, 73.0, 74.0, 73.0, 130.0, 97.0, 75.0], "unit": "score", "name": "audio-fft", "value": 87.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 156.0, 96.0, 95.0, 96.0, 150.0, 96.0, 96.0, 148.0], "unit": "score", "name": "audio-oscillator", "value": 112.5}, {"lowerIsBetter": true, "replicates": [120.0, 115.0, 115.0, 114.0, 114.0, 115.0, 114.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.2}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 95.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [55.0, 57.0, 56.0, 56.0, 55.0, 57.0, 57.0, 67.0, 54.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.9}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 69.0, 68.0, 69.0, 69.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [81.0, 83.0, 84.0, 83.0, 82.0, 91.0, 84.0, 82.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.6}, {"lowerIsBetter": true, "replicates": [124.0, 115.0, 114.0, 115.0, 116.0, 116.0, 116.0, 123.0, 115.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.8}, {"lowerIsBetter": true, "replicates": [155.0, 143.0, 152.0, 149.0, 157.0, 138.0, 158.0, 149.0, 148.0, 151.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.0}, {"lowerIsBetter": true, "replicates": [71.0, 68.0, 69.0, 69.0, 67.0, 69.0, 67.0, 67.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.3}], "name": "kraken", "value": 1517.8}]} 14:28:56 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1517.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6755.84"}}} 14:28:56 INFO - Return code: 0 14:28:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:28:56 INFO - # TBPL SUCCESS # 14:28:56 INFO - Running post-action listener: _resource_record_post_action 14:28:56 INFO - Running post-run listener: _resource_record_post_run 14:28:57 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 16384; Write bytes: 539373568; Read time: 28; Write time: 691008 14:28:57 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 241004544; Read time: 0; Write time: 425704 14:28:57 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 16384; Write bytes: 298369024; Read time: 28; Write time: 265304 14:28:57 INFO - Running post-run listener: _upload_blobber_files 14:28:57 INFO - Blob upload gear active. 14:28:57 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:28:57 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:28:57 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:28:57 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:28:57 INFO - (blobuploader) - INFO - Open directory for files ... 14:28:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:28:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:28:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:28:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:28:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:28:58 INFO - (blobuploader) - INFO - Done attempting. 14:28:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 14:28:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:28:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:28:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:28:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:28:59 INFO - (blobuploader) - INFO - Done attempting. 14:28:59 INFO - (blobuploader) - INFO - Iteration through files over. 14:28:59 INFO - Return code: 0 14:28:59 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:28:59 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:28:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f68edc4ccac848d7902775368eddb182f82ccdfe94f0fa88a2c277d5054357cb51a7a1c45b609492a9da0c617b8e422e8503262a95c27c007b34825676434001", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ef69790a301ac9677cc9bcf6a0cdfd3d1ce0213d1c8c92a254f3e6cc752d0e367c960158c02294d1655c29fa2c537e0705df22b4ee671d725d0bb1cee53a384"} 14:28:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:28:59 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:28:59 INFO - Contents: 14:28:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f68edc4ccac848d7902775368eddb182f82ccdfe94f0fa88a2c277d5054357cb51a7a1c45b609492a9da0c617b8e422e8503262a95c27c007b34825676434001", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ef69790a301ac9677cc9bcf6a0cdfd3d1ce0213d1c8c92a254f3e6cc752d0e367c960158c02294d1655c29fa2c537e0705df22b4ee671d725d0bb1cee53a384"} 14:28:59 INFO - Running post-run listener: copy_logs_to_upload_dir 14:28:59 INFO - Copying logs to upload dir... 14:28:59 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 14:28:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.015950 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-02-27 14:28:58.660284) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-27 14:28:58.663559) ========= 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=c6927cf182745ad25b1d38b9000001fe-1456608482.192647-1456463062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f68edc4ccac848d7902775368eddb182f82ccdfe94f0fa88a2c277d5054357cb51a7a1c45b609492a9da0c617b8e422e8503262a95c27c007b34825676434001", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ef69790a301ac9677cc9bcf6a0cdfd3d1ce0213d1c8c92a254f3e6cc752d0e367c960158c02294d1655c29fa2c537e0705df22b4ee671d725d0bb1cee53a384"} build_url:https://queue.taskcluster.net/v1/task/dWH9HHW_Tu2lfCm26SRReQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011363 build_url: 'https://queue.taskcluster.net/v1/task/dWH9HHW_Tu2lfCm26SRReQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f68edc4ccac848d7902775368eddb182f82ccdfe94f0fa88a2c277d5054357cb51a7a1c45b609492a9da0c617b8e422e8503262a95c27c007b34825676434001", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ef69790a301ac9677cc9bcf6a0cdfd3d1ce0213d1c8c92a254f3e6cc752d0e367c960158c02294d1655c29fa2c537e0705df22b4ee671d725d0bb1cee53a384"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-27 14:28:58.687217) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 14:28:58.687504) ========= 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=c6927cf182745ad25b1d38b9000001fe-1456608482.192647-1456463062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004562 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 14:28:58.769894) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-27 14:28:58.770203) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-27 14:28:58.770474) ========= ========= Total master_lag: 0.31 =========