builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-069 starttime: 1455584366.05 results: success (0) buildid: 20160215143005 builduid: f1729d3c40474524a3f9d707fd6e8824 revision: 8bd1a25ac261cf03eb383264f69fb8606cabb470 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-15 16:59:26.045357) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-15 16:59:26.045759) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-15 16:59:26.046061) ========= 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=1861a34ebfea852630dec091000001fa-1455583826.755046-327662611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006456 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-15 16:59:26.079996) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-15 16:59:26.080267) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-15 16:59:26.133519) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 16:59:26.133780) ========= 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=1861a34ebfea852630dec091000001fa-1455583826.755046-327662611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004559 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 16:59:26.196465) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-15 16:59:26.196746) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-15 16:59:26.197103) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 16:59:26.197431) ========= 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=1861a34ebfea852630dec091000001fa-1455583826.755046-327662611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-15 16:59:29-- 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% 66.1M=0s 2016-02-15 16:59:29 (66.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.174107 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 16:59:26.385483) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 16:59:26.385765) ========= 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=1861a34ebfea852630dec091000001fa-1455583826.755046-327662611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019539 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 16:59:26.470876) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-15 16:59:26.471218) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8bd1a25ac261cf03eb383264f69fb8606cabb470 --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 8bd1a25ac261cf03eb383264f69fb8606cabb470 --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=1861a34ebfea852630dec091000001fa-1455583826.755046-327662611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-15 16:59:29,359 truncating revision to first 12 chars 2016-02-15 16:59:29,359 Setting DEBUG logging. 2016-02-15 16:59:29,359 attempt 1/10 2016-02-15 16:59:29,359 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8bd1a25ac261?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-15 16:59:30,508 unpacking tar archive at: fx-team-8bd1a25ac261/testing/mozharness/ program finished with exit code 0 elapsedTime=1.459530 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-15 16:59:27.943702) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-15 16:59:27.944058) ========= echo 8bd1a25ac261cf03eb383264f69fb8606cabb470 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8bd1a25ac261cf03eb383264f69fb8606cabb470'] 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=1861a34ebfea852630dec091000001fa-1455583826.755046-327662611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 8bd1a25ac261cf03eb383264f69fb8606cabb470 program finished with exit code 0 elapsedTime=0.003749 script_repo_revision: '8bd1a25ac261cf03eb383264f69fb8606cabb470' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-15 16:59:27.991825) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-15 16:59:27.992111) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-15 16:59:28.003504) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-02-15 16:59:28.003812) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1861a34ebfea852630dec091000001fa-1455583826.755046-327662611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:59:30 INFO - MultiFileLogger online at 20160215 16:59:30 in /builds/slave/test-pgo 16:59:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:59:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:59:30 INFO - {'append_to_log': False, 16:59:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:59:30 INFO - 'blob_upload_branch': 'Fx-Team', 16:59:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:59:30 INFO - 'branch': 'Fx-Team', 16:59:30 INFO - 'buildbot_json_path': 'buildprops.json', 16:59:30 INFO - 'config_files': ('talos/linux_config.py',), 16:59:30 INFO - 'default_actions': ('clobber', 16:59:30 INFO - 'read-buildbot-config', 16:59:30 INFO - 'download-and-extract', 16:59:30 INFO - 'populate-webroot', 16:59:30 INFO - 'create-virtualenv', 16:59:30 INFO - 'install', 16:59:30 INFO - 'run-tests'), 16:59:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:59:30 INFO - 'download_minidump_stackwalk': True, 16:59:30 INFO - 'download_symbols': 'ondemand', 16:59:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:59:30 INFO - 'tooltool.py': '/tools/tooltool.py', 16:59:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:59:30 INFO - '/tools/misc-python/virtualenv.py')}, 16:59:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:59:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:59:30 INFO - 'installer_path': 'installer.exe', 16:59:30 INFO - 'log_level': 'info', 16:59:30 INFO - 'log_name': 'talos', 16:59:30 INFO - 'log_to_console': True, 16:59:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:59:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:59:30 INFO - 'opt_config_files': (), 16:59:30 INFO - 'pip_index': False, 16:59:30 INFO - 'sps_profile': False, 16:59:30 INFO - 'sps_profile_interval': 0, 16:59:30 INFO - 'suite': 'dromaeojs-e10s', 16:59:30 INFO - 'system_bits': '32', 16:59:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:59:30 INFO - 'title': 'talos-linux64-ix-069', 16:59:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:59:30 INFO - 'use_talos_json': True, 16:59:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:59:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:59:30 INFO - 'work_dir': 'build'} 16:59:30 INFO - ##### 16:59:30 INFO - ##### Running clobber step. 16:59:30 INFO - ##### 16:59:30 INFO - Running pre-action listener: _resource_record_pre_action 16:59:30 INFO - Running main action method: clobber 16:59:30 INFO - rmtree: /builds/slave/test-pgo/build 16:59:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:59:31 INFO - Running post-action listener: _resource_record_post_action 16:59:31 INFO - ##### 16:59:31 INFO - ##### Running read-buildbot-config step. 16:59:31 INFO - ##### 16:59:31 INFO - Running pre-action listener: _resource_record_pre_action 16:59:31 INFO - Running main action method: read_buildbot_config 16:59:31 INFO - Using buildbot properties: 16:59:31 INFO - { 16:59:31 INFO - "project": "", 16:59:31 INFO - "product": "firefox", 16:59:31 INFO - "script_repo_revision": "production", 16:59:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 16:59:31 INFO - "repository": "", 16:59:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 16:59:31 INFO - "buildid": "20160215143005", 16:59:31 INFO - "pgo_build": "True", 16:59:31 INFO - "basedir": "/builds/slave/test-pgo", 16:59:31 INFO - "buildnumber": 496, 16:59:31 INFO - "slavename": "talos-linux64-ix-069", 16:59:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:59:31 INFO - "platform": "ubuntu64_hw", 16:59:31 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 16:59:31 INFO - "branch": "fx-team", 16:59:31 INFO - "repo_path": "integration/fx-team", 16:59:31 INFO - "revision": "8bd1a25ac261cf03eb383264f69fb8606cabb470", 16:59:31 INFO - "stage_platform": "linux64-pgo", 16:59:31 INFO - "builduid": "f1729d3c40474524a3f9d707fd6e8824", 16:59:31 INFO - "slavebuilddir": "test" 16:59:31 INFO - } 16:59:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/XQYnj-hQTTyWB6rqA1cY0A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 16:59:31 INFO - Running post-action listener: _resource_record_post_action 16:59:31 INFO - ##### 16:59:31 INFO - ##### Running download-and-extract step. 16:59:31 INFO - ##### 16:59:31 INFO - Running pre-action listener: _resource_record_pre_action 16:59:31 INFO - Running main action method: download_and_extract 16:59:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:59: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')]} 16:59:31 INFO - https://queue.taskcluster.net/v1/task/XQYnj-hQTTyWB6rqA1cY0A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:59:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQYnj-hQTTyWB6rqA1cY0A/artifacts/public/build/test_packages.json 16:59:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQYnj-hQTTyWB6rqA1cY0A/artifacts/public/build/test_packages.json 16:59:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQYnj-hQTTyWB6rqA1cY0A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:59:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQYnj-hQTTyWB6rqA1cY0A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:59:37 INFO - Downloaded 1448 bytes. 16:59:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:59:37 INFO - Using the following test package requirements: 16:59:37 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 16:59:37 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:37 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:59:37 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:37 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:59:37 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:37 INFO - u'jsshell-linux-x86_64.zip'], 16:59:37 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:37 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:59:37 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 16:59:37 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:37 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:59:37 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:37 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:59:37 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:37 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:59:37 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 16:59:37 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:59:37 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:59:37 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:59: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')]} 16:59:37 INFO - https://queue.taskcluster.net/v1/task/XQYnj-hQTTyWB6rqA1cY0A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:59:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQYnj-hQTTyWB6rqA1cY0A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:59:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQYnj-hQTTyWB6rqA1cY0A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:59:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQYnj-hQTTyWB6rqA1cY0A/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 16:59:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQYnj-hQTTyWB6rqA1cY0A/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 16:59:46 INFO - Downloaded 23298647 bytes. 16:59:46 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'] 16:59:46 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 16:59:47 INFO - Return code: 0 16:59:47 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 16:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:47 INFO - https://queue.taskcluster.net/v1/task/XQYnj-hQTTyWB6rqA1cY0A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:59:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQYnj-hQTTyWB6rqA1cY0A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:59:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQYnj-hQTTyWB6rqA1cY0A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:59:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQYnj-hQTTyWB6rqA1cY0A/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 16:59:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQYnj-hQTTyWB6rqA1cY0A/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 16:59:52 INFO - Downloaded 23298647 bytes. 16:59:52 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'] 16:59:52 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 16:59:53 INFO - Return code: 0 16:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:53 INFO - https://queue.taskcluster.net/v1/task/XQYnj-hQTTyWB6rqA1cY0A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:59:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQYnj-hQTTyWB6rqA1cY0A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 16:59:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQYnj-hQTTyWB6rqA1cY0A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 16:59:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQYnj-hQTTyWB6rqA1cY0A/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 16:59:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQYnj-hQTTyWB6rqA1cY0A/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 16:59:54 INFO - Downloaded 10707070 bytes. 16:59:54 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'] 16:59:54 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 16:59:54 INFO - Return code: 0 16:59:54 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')]} 16:59:54 INFO - https://queue.taskcluster.net/v1/task/XQYnj-hQTTyWB6rqA1cY0A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:59:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQYnj-hQTTyWB6rqA1cY0A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:59:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQYnj-hQTTyWB6rqA1cY0A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:59:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQYnj-hQTTyWB6rqA1cY0A/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 16:59:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XQYnj-hQTTyWB6rqA1cY0A/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 16:59:56 INFO - Downloaded 56541173 bytes. 16:59:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XQYnj-hQTTyWB6rqA1cY0A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:59:56 INFO - mkdir: /builds/slave/test-pgo/properties 16:59:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:59:56 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:59:56 INFO - Contents: 16:59:56 INFO - build_url:https://queue.taskcluster.net/v1/task/XQYnj-hQTTyWB6rqA1cY0A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:59:56 INFO - Running post-action listener: _resource_record_post_action 16:59:56 INFO - Running post-action listener: set_extra_try_arguments 16:59:56 INFO - ##### 16:59:56 INFO - ##### Running populate-webroot step. 16:59:56 INFO - ##### 16:59:56 INFO - Running pre-action listener: _resource_record_pre_action 16:59:56 INFO - Running main action method: populate_webroot 16:59:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:59:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:59:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:59:56 INFO - '--tppagecycles', 16:59:56 INFO - '7'], 16:59:56 INFO - 'tests': ['tsvgm']}}, 16:59:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:59:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:59:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:59:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:59:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:59:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:59:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:59:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:56 INFO - 'talos_options': ['--e10s'], 16:59:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:59:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:56 INFO - 'tests': ['damp', 'tps']}, 16:59:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:56 INFO - 'talos_options': ['--e10s'], 16:59:56 INFO - 'tests': ['damp', 'tps']}, 16:59:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:59:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:59:56 INFO - 'other': {'tests': ['a11yr', 16:59:56 INFO - 'ts_paint', 16:59:56 INFO - 'tpaint', 16:59:56 INFO - 'sessionrestore', 16:59:56 INFO - 'sessionrestore_no_auto_restore']}, 16:59:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:59:56 INFO - 'tests': ['a11yr', 16:59:56 INFO - 'ts_paint', 16:59:56 INFO - 'tpaint', 16:59:56 INFO - 'sessionrestore', 16:59:56 INFO - 'sessionrestore_no_auto_restore']}, 16:59:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:59:56 INFO - 'tests': ['a11yr', 16:59:56 INFO - 'ts_paint', 16:59:56 INFO - 'tpaint', 16:59:56 INFO - 'sessionrestore', 16:59:56 INFO - 'sessionrestore_no_auto_restore']}, 16:59:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:59:56 INFO - 'tests': ['a11yr', 16:59:56 INFO - 'ts_paint', 16:59:56 INFO - 'tpaint', 16:59:56 INFO - 'sessionrestore', 16:59:56 INFO - 'sessionrestore_no_auto_restore']}, 16:59:56 INFO - 'other_l64': {'tests': ['a11yr', 16:59:56 INFO - 'ts_paint', 16:59:56 INFO - 'tpaint', 16:59:56 INFO - 'sessionrestore', 16:59:56 INFO - 'sessionrestore_no_auto_restore']}, 16:59:56 INFO - 'other_nol64': {'tests': ['a11yr', 16:59:56 INFO - 'ts_paint', 16:59:56 INFO - 'tpaint', 16:59:56 INFO - 'sessionrestore', 16:59:56 INFO - 'sessionrestore_no_auto_restore']}, 16:59:56 INFO - 'svgr': {'tests': ['tsvgx', 16:59:56 INFO - 'tsvgr_opacity', 16:59:56 INFO - 'tart', 16:59:56 INFO - 'tscrollx', 16:59:56 INFO - 'cart']}, 16:59:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:59:56 INFO - 'tests': ['tsvgx', 16:59:56 INFO - 'tsvgr_opacity', 16:59:56 INFO - 'tart', 16:59:56 INFO - 'tscrollx', 16:59:56 INFO - 'cart']}, 16:59:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:56 INFO - 'tests': ['tp5o']}, 16:59:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:56 INFO - 'talos_options': ['--e10s'], 16:59:56 INFO - 'tests': ['tp5o']}, 16:59:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:56 INFO - 'talos_options': ['--xperf_path', 16:59:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:59:56 INFO - 'tests': ['tp5n']}, 16:59:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:59:56 INFO - 'talos_options': ['--e10s', 16:59:56 INFO - '--xperf_path', 16:59:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:59:56 INFO - 'tests': ['tp5n']}}, 16:59:56 INFO - 'talos.zip': {'path': '', 16:59:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:59:56 INFO - Running post-action listener: _resource_record_post_action 16:59:56 INFO - ##### 16:59:56 INFO - ##### Running create-virtualenv step. 16:59:56 INFO - ##### 16:59:56 INFO - Running pre-action listener: _resource_record_pre_action 16:59:56 INFO - Running main action method: create_virtualenv 16:59:56 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:59:56 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 16:59:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:59:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:59:56 INFO - Using real prefix '/usr' 16:59:56 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:59:57 INFO - Installing distribute.............................................................................................................................................................................................done. 16:59:59 INFO - Installing pip.................done. 16:59:59 INFO - Return code: 0 16:59:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:59 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 0x7f2997d73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde2670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe718c0>, '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 0xe727c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe72c50>, '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': '1861a34ebfea852630dec091000001fa-1455583826.755046-327662611', '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 16:59:59 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 16:59:59 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 16:59:59 INFO - Using env: {'DISPLAY': ':0', 16:59:59 INFO - 'HOME': '/home/cltbld', 16:59:59 INFO - 'LANG': 'en_US.UTF-8', 16:59:59 INFO - 'LANGUAGE': 'en_US:en', 16:59:59 INFO - 'LOGNAME': 'cltbld', 16:59:59 INFO - 'MAIL': '/var/mail/cltbld', 16:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:59 INFO - 'MOZ_NO_REMOTE': '1', 16:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:59 INFO - 'NO_EM_RESTART': '1', 16:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:59:59 INFO - 'PWD': '/builds/slave/test-pgo', 16:59:59 INFO - 'SHELL': '/bin/bash', 16:59:59 INFO - 'SHLVL': '1', 16:59:59 INFO - 'TERM': 'linux', 16:59:59 INFO - 'TMOUT': '86400', 16:59:59 INFO - 'USER': 'cltbld', 16:59:59 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1455583826.755046-327662611', 16:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:59 INFO - '_': '/tools/buildbot/bin/python'} 16:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:59 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 16:59:59 INFO - Cleaning up... 16:59:59 INFO - Return code: 0 16:59:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:59 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 0x7f2997d73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde2670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe718c0>, '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 0xe727c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe72c50>, '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': '1861a34ebfea852630dec091000001fa-1455583826.755046-327662611', '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 16:59:59 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 16:59:59 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 16:59:59 INFO - Using env: {'DISPLAY': ':0', 16:59:59 INFO - 'HOME': '/home/cltbld', 16:59:59 INFO - 'LANG': 'en_US.UTF-8', 16:59:59 INFO - 'LANGUAGE': 'en_US:en', 16:59:59 INFO - 'LOGNAME': 'cltbld', 16:59:59 INFO - 'MAIL': '/var/mail/cltbld', 16:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:59 INFO - 'MOZ_NO_REMOTE': '1', 16:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:59 INFO - 'NO_EM_RESTART': '1', 16:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:59:59 INFO - 'PWD': '/builds/slave/test-pgo', 16:59:59 INFO - 'SHELL': '/bin/bash', 16:59:59 INFO - 'SHLVL': '1', 16:59:59 INFO - 'TERM': 'linux', 16:59:59 INFO - 'TMOUT': '86400', 16:59:59 INFO - 'USER': 'cltbld', 16:59:59 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1455583826.755046-327662611', 16:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:59 INFO - '_': '/tools/buildbot/bin/python'} 16:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:59 INFO - Downloading/unpacking psutil>=0.7.1 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 16:59: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 17:00:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 17:00:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:00:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:00:01 INFO - Installing collected packages: psutil 17:00:01 INFO - Running setup.py install for psutil 17:00:01 INFO - building 'psutil._psutil_linux' extension 17:00:01 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 17:00:02 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 17:00:02 INFO - building 'psutil._psutil_posix' extension 17:00:02 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 17:00:02 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 17:00:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:00:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:00:02 INFO - Successfully installed psutil 17:00:02 INFO - Cleaning up... 17:00:02 INFO - Return code: 0 17:00:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 17:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2997d73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde2670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe718c0>, '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 0xe727c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe72c50>, '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': '1861a34ebfea852630dec091000001fa-1455583826.755046-327662611', '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 17:00:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 17:00:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:00:02 INFO - Using env: {'DISPLAY': ':0', 17:00:02 INFO - 'HOME': '/home/cltbld', 17:00:02 INFO - 'LANG': 'en_US.UTF-8', 17:00:02 INFO - 'LANGUAGE': 'en_US:en', 17:00:02 INFO - 'LOGNAME': 'cltbld', 17:00:02 INFO - 'MAIL': '/var/mail/cltbld', 17:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:02 INFO - 'MOZ_NO_REMOTE': '1', 17:00:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:02 INFO - 'NO_EM_RESTART': '1', 17:00:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:00:02 INFO - 'PWD': '/builds/slave/test-pgo', 17:00:02 INFO - 'SHELL': '/bin/bash', 17:00:02 INFO - 'SHLVL': '1', 17:00:02 INFO - 'TERM': 'linux', 17:00:02 INFO - 'TMOUT': '86400', 17:00:02 INFO - 'USER': 'cltbld', 17:00:02 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1455583826.755046-327662611', 17:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:02 INFO - '_': '/tools/buildbot/bin/python'} 17:00:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:00:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:00:04 INFO - Installing collected packages: mozsystemmonitor 17:00:04 INFO - Running setup.py install for mozsystemmonitor 17:00:04 INFO - Successfully installed mozsystemmonitor 17:00:04 INFO - Cleaning up... 17:00:04 INFO - Return code: 0 17:00:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 17:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2997d73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde2670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe718c0>, '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 0xe727c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe72c50>, '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': '1861a34ebfea852630dec091000001fa-1455583826.755046-327662611', '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 17:00:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 17:00:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:00:04 INFO - Using env: {'DISPLAY': ':0', 17:00:04 INFO - 'HOME': '/home/cltbld', 17:00:04 INFO - 'LANG': 'en_US.UTF-8', 17:00:04 INFO - 'LANGUAGE': 'en_US:en', 17:00:04 INFO - 'LOGNAME': 'cltbld', 17:00:04 INFO - 'MAIL': '/var/mail/cltbld', 17:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:04 INFO - 'MOZ_NO_REMOTE': '1', 17:00:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:04 INFO - 'NO_EM_RESTART': '1', 17:00:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:00:04 INFO - 'PWD': '/builds/slave/test-pgo', 17:00:04 INFO - 'SHELL': '/bin/bash', 17:00:04 INFO - 'SHLVL': '1', 17:00:04 INFO - 'TERM': 'linux', 17:00:04 INFO - 'TMOUT': '86400', 17:00:04 INFO - 'USER': 'cltbld', 17:00:04 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1455583826.755046-327662611', 17:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:04 INFO - '_': '/tools/buildbot/bin/python'} 17:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:04 INFO - Downloading/unpacking blobuploader==1.2.4 17:00: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 17:00: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 17:00: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 17:00: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 17:00: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 17:00: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 17:00:06 INFO - Downloading blobuploader-1.2.4.tar.gz 17:00:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:00:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 17:00:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:07 INFO - Downloading docopt-0.6.1.tar.gz 17:00:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 17:00:07 INFO - Installing collected packages: blobuploader, requests, docopt 17:00:07 INFO - Running setup.py install for blobuploader 17:00:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:00:07 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 17:00:07 INFO - Running setup.py install for requests 17:00:07 INFO - Running setup.py install for docopt 17:00:07 INFO - Successfully installed blobuploader requests docopt 17:00:07 INFO - Cleaning up... 17:00:08 INFO - Return code: 0 17:00:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:00:08 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')]} 17:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:08 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')]} 17:00:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:08 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 0x7f2997d73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde2670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe718c0>, '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 0xe727c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe72c50>, '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': '1861a34ebfea852630dec091000001fa-1455583826.755046-327662611', '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 17:00:08 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 17:00:08 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 17:00:08 INFO - Using env: {'DISPLAY': ':0', 17:00:08 INFO - 'HOME': '/home/cltbld', 17:00:08 INFO - 'LANG': 'en_US.UTF-8', 17:00:08 INFO - 'LANGUAGE': 'en_US:en', 17:00:08 INFO - 'LOGNAME': 'cltbld', 17:00:08 INFO - 'MAIL': '/var/mail/cltbld', 17:00:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:08 INFO - 'MOZ_NO_REMOTE': '1', 17:00:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:08 INFO - 'NO_EM_RESTART': '1', 17:00:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:00:08 INFO - 'PWD': '/builds/slave/test-pgo', 17:00:08 INFO - 'SHELL': '/bin/bash', 17:00:08 INFO - 'SHLVL': '1', 17:00:08 INFO - 'TERM': 'linux', 17:00:08 INFO - 'TMOUT': '86400', 17:00:08 INFO - 'USER': 'cltbld', 17:00:08 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1455583826.755046-327662611', 17:00:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:08 INFO - '_': '/tools/buildbot/bin/python'} 17:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:00:08 INFO - Running setup.py (path:/tmp/pip-lL_dcL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:00:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:00:08 INFO - Running setup.py (path:/tmp/pip-rE3fup-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:00:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:00:08 INFO - Running setup.py (path:/tmp/pip-WE4ZIT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:00:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:00:08 INFO - Running setup.py (path:/tmp/pip-8pRJ99-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:00:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:00:08 INFO - Running setup.py (path:/tmp/pip-xSBqKu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:00:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:00:08 INFO - Running setup.py (path:/tmp/pip-5JzQ4k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:00:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:00:08 INFO - Running setup.py (path:/tmp/pip-Mbh2oP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:00:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:00:08 INFO - Running setup.py (path:/tmp/pip-VfBrQY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:00:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:00:08 INFO - Running setup.py (path:/tmp/pip-38WNzF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:00:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:00:08 INFO - Running setup.py (path:/tmp/pip-OeOUYJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:00:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:00:09 INFO - Running setup.py (path:/tmp/pip-ea7efB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:00:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:00:09 INFO - Running setup.py (path:/tmp/pip-VoanbF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:00:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:00:09 INFO - Running setup.py (path:/tmp/pip-d4DjDi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:00:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:00:09 INFO - Running setup.py (path:/tmp/pip-QpcZWl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:00:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:00:09 INFO - Running setup.py (path:/tmp/pip-WC9o2E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:00:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:00:09 INFO - Running setup.py (path:/tmp/pip-OaIh3p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:00:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:00:09 INFO - Running setup.py (path:/tmp/pip-pG7LKJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:00:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:00:09 INFO - Running setup.py install for manifestparser 17:00:09 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 17:00:09 INFO - Running setup.py install for mozcrash 17:00:09 INFO - Running setup.py install for mozdebug 17:00:09 INFO - Running setup.py install for mozdevice 17:00:09 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 17:00:09 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 17:00:09 INFO - Running setup.py install for mozfile 17:00:10 INFO - Running setup.py install for mozhttpd 17:00:10 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 17:00:10 INFO - Running setup.py install for mozinfo 17:00:10 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 17:00:10 INFO - Running setup.py install for mozInstall 17:00:10 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 17:00:10 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 17:00:10 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 17:00:10 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 17:00:10 INFO - Running setup.py install for mozleak 17:00:10 INFO - Running setup.py install for mozlog 17:00:10 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 17:00:10 INFO - Running setup.py install for moznetwork 17:00:10 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 17:00:10 INFO - Running setup.py install for mozprocess 17:00:10 INFO - Running setup.py install for mozprofile 17:00:10 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 17:00:10 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 17:00:10 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 17:00:10 INFO - Running setup.py install for mozrunner 17:00:11 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 17:00:11 INFO - Running setup.py install for mozscreenshot 17:00:11 INFO - Running setup.py install for moztest 17:00:11 INFO - Running setup.py install for mozversion 17:00:11 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 17:00:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:00:11 INFO - Cleaning up... 17:00:11 INFO - Return code: 0 17:00:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:00:11 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')]} 17:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:11 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')]} 17:00:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:11 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 0x7f2997d73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde2670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe718c0>, '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 0xe727c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe72c50>, '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': '1861a34ebfea852630dec091000001fa-1455583826.755046-327662611', '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 17:00:11 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 17:00:11 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 17:00:11 INFO - Using env: {'DISPLAY': ':0', 17:00:11 INFO - 'HOME': '/home/cltbld', 17:00:11 INFO - 'LANG': 'en_US.UTF-8', 17:00:11 INFO - 'LANGUAGE': 'en_US:en', 17:00:11 INFO - 'LOGNAME': 'cltbld', 17:00:11 INFO - 'MAIL': '/var/mail/cltbld', 17:00:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:11 INFO - 'MOZ_NO_REMOTE': '1', 17:00:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:11 INFO - 'NO_EM_RESTART': '1', 17:00:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:00:11 INFO - 'PWD': '/builds/slave/test-pgo', 17:00:11 INFO - 'SHELL': '/bin/bash', 17:00:11 INFO - 'SHLVL': '1', 17:00:11 INFO - 'TERM': 'linux', 17:00:11 INFO - 'TMOUT': '86400', 17:00:11 INFO - 'USER': 'cltbld', 17:00:11 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1455583826.755046-327662611', 17:00:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:11 INFO - '_': '/tools/buildbot/bin/python'} 17:00:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:00:11 INFO - Running setup.py (path:/tmp/pip-rpTSc7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:00:11 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)) 17:00:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:00:11 INFO - Running setup.py (path:/tmp/pip-vf6_f2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:00:11 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)) 17:00:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:00:11 INFO - Running setup.py (path:/tmp/pip-Wy1lOf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:00:11 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)) 17:00:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:00:11 INFO - Running setup.py (path:/tmp/pip-rGrdnc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:00:11 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)) 17:00:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:00:11 INFO - Running setup.py (path:/tmp/pip-m8Tk3M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:00:11 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)) 17:00:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:00:11 INFO - Running setup.py (path:/tmp/pip-28HCzG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:00:11 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)) 17:00:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:00:11 INFO - Running setup.py (path:/tmp/pip-ULMRHp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:00:12 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)) 17:00:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:00:12 INFO - Running setup.py (path:/tmp/pip-YwZ1UQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:00:12 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)) 17:00:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:00:12 INFO - Running setup.py (path:/tmp/pip-jeM6ku-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:00:12 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)) 17:00:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:00:12 INFO - Running setup.py (path:/tmp/pip-Gf0WLk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:00:12 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)) 17:00:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:00:12 INFO - Running setup.py (path:/tmp/pip-29T08J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:00:12 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)) 17:00:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:00:12 INFO - Running setup.py (path:/tmp/pip-yv7n5p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:00:12 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)) 17:00:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:00:12 INFO - Running setup.py (path:/tmp/pip-auUmE5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:00:12 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)) 17:00:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:00:12 INFO - Running setup.py (path:/tmp/pip-1UzaHF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:00:12 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)) 17:00:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:00:12 INFO - Running setup.py (path:/tmp/pip-5g3oI8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:00:12 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)) 17:00:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:00:12 INFO - Running setup.py (path:/tmp/pip-xNFueJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:00:12 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)) 17:00:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:00:12 INFO - Running setup.py (path:/tmp/pip-73ILc_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:00:12 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)) 17:00:12 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)) 17:00:12 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)) 17:00:12 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)) 17:00:12 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)) 17:00:12 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)) 17:00:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:00:12 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 17:00:12 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 17:00:12 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 17:00:12 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 17:00:12 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 17:00:12 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 17:00:14 INFO - Downloading blessings-1.6.tar.gz 17:00:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 17:00:14 INFO - Installing collected packages: blessings 17:00:14 INFO - Running setup.py install for blessings 17:00:14 INFO - Successfully installed blessings 17:00:14 INFO - Cleaning up... 17:00:14 INFO - Return code: 0 17:00:14 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 17:00:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:00:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:00:15 INFO - Reading from file tmpfile_stdout 17:00:15 INFO - Current package versions: 17:00:15 INFO - argparse == 1.2.1 17:00:15 INFO - blessings == 1.6 17:00:15 INFO - blobuploader == 1.2.4 17:00:15 INFO - docopt == 0.6.1 17:00:15 INFO - manifestparser == 1.1 17:00:15 INFO - mozInstall == 1.12 17:00:15 INFO - mozcrash == 0.16 17:00:15 INFO - mozdebug == 0.1 17:00:15 INFO - mozdevice == 0.48 17:00:15 INFO - mozfile == 1.2 17:00:15 INFO - mozhttpd == 0.7 17:00:15 INFO - mozinfo == 0.9 17:00:15 INFO - mozleak == 0.1 17:00:15 INFO - mozlog == 3.1 17:00:15 INFO - moznetwork == 0.27 17:00:15 INFO - mozprocess == 0.22 17:00:15 INFO - mozprofile == 0.28 17:00:15 INFO - mozrunner == 6.11 17:00:15 INFO - mozscreenshot == 0.1 17:00:15 INFO - mozsystemmonitor == 0.0 17:00:15 INFO - moztest == 0.7 17:00:15 INFO - mozversion == 1.4 17:00:15 INFO - psutil == 3.1.1 17:00:15 INFO - requests == 1.2.3 17:00:15 INFO - wsgiref == 0.1.2 17:00:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:15 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 0x7f2997d73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde2670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe718c0>, '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 0xe727c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe72c50>, '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': '1861a34ebfea852630dec091000001fa-1455583826.755046-327662611', '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 17:00:15 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 17:00:15 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 17:00:15 INFO - Using env: {'DISPLAY': ':0', 17:00:15 INFO - 'HOME': '/home/cltbld', 17:00:15 INFO - 'LANG': 'en_US.UTF-8', 17:00:15 INFO - 'LANGUAGE': 'en_US:en', 17:00:15 INFO - 'LOGNAME': 'cltbld', 17:00:15 INFO - 'MAIL': '/var/mail/cltbld', 17:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:15 INFO - 'MOZ_NO_REMOTE': '1', 17:00:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:15 INFO - 'NO_EM_RESTART': '1', 17:00:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:00:15 INFO - 'PWD': '/builds/slave/test-pgo', 17:00:15 INFO - 'SHELL': '/bin/bash', 17:00:15 INFO - 'SHLVL': '1', 17:00:15 INFO - 'TERM': 'linux', 17:00:15 INFO - 'TMOUT': '86400', 17:00:15 INFO - 'USER': 'cltbld', 17:00:15 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1455583826.755046-327662611', 17:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:15 INFO - '_': '/tools/buildbot/bin/python'} 17:00:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:15 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)) 17:00:15 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)) 17:00:15 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)) 17:00:15 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)) 17:00:15 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)) 17:00:15 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)) 17:00:15 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)) 17:00:15 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)) 17:00:15 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)) 17:00:15 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)) 17:00:15 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)) 17:00:15 INFO - Cleaning up... 17:00:15 INFO - Return code: 0 17:00:15 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 17:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:00:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:15 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 0x7f2997d73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde2670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe718c0>, '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 0xe727c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe72c50>, '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': '1861a34ebfea852630dec091000001fa-1455583826.755046-327662611', '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 17:00:15 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 17:00:15 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 17:00:15 INFO - Using env: {'DISPLAY': ':0', 17:00:15 INFO - 'HOME': '/home/cltbld', 17:00:15 INFO - 'LANG': 'en_US.UTF-8', 17:00:15 INFO - 'LANGUAGE': 'en_US:en', 17:00:15 INFO - 'LOGNAME': 'cltbld', 17:00:15 INFO - 'MAIL': '/var/mail/cltbld', 17:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:15 INFO - 'MOZ_NO_REMOTE': '1', 17:00:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:15 INFO - 'NO_EM_RESTART': '1', 17:00:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:00:15 INFO - 'PWD': '/builds/slave/test-pgo', 17:00:15 INFO - 'SHELL': '/bin/bash', 17:00:15 INFO - 'SHLVL': '1', 17:00:15 INFO - 'TERM': 'linux', 17:00:15 INFO - 'TMOUT': '86400', 17:00:15 INFO - 'USER': 'cltbld', 17:00:15 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1455583826.755046-327662611', 17:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:15 INFO - '_': '/tools/buildbot/bin/python'} 17:00:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:15 INFO - Downloading/unpacking jsonschema 17:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:00:17 INFO - Downloading/unpacking functools32 (from jsonschema) 17:00:17 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 17:00:17 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 17:00:17 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 17:00:17 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 17:00:17 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 17:00:17 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 17:00:17 INFO - Downloading functools32-3.2.3-2.tar.gz 17:00:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 17:00:17 INFO - warning: no files found matching '*.txt' 17:00:17 INFO - no previously-included directories found matching 'build' 17:00:17 INFO - no previously-included directories found matching 'dist' 17:00:17 INFO - no previously-included directories found matching '.git*' 17:00:17 INFO - Installing collected packages: jsonschema, functools32 17:00:17 INFO - Running setup.py install for functools32 17:00:17 INFO - warning: no files found matching '*.txt' 17:00:17 INFO - no previously-included directories found matching 'build' 17:00:17 INFO - no previously-included directories found matching 'dist' 17:00:17 INFO - no previously-included directories found matching '.git*' 17:00:17 INFO - Successfully installed jsonschema functools32 17:00:17 INFO - Cleaning up... 17:00:17 INFO - Return code: 0 17:00:17 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 17:00:17 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')]} 17:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:00:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:17 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')]} 17:00:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:00:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:00:17 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 0x7f2997d73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xde2670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe718c0>, '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 0xe727c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe72c50>, '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': '1861a34ebfea852630dec091000001fa-1455583826.755046-327662611', '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 17:00:17 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 17:00:17 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 17:00:17 INFO - Using env: {'DISPLAY': ':0', 17:00:17 INFO - 'HOME': '/home/cltbld', 17:00:17 INFO - 'LANG': 'en_US.UTF-8', 17:00:17 INFO - 'LANGUAGE': 'en_US:en', 17:00:17 INFO - 'LOGNAME': 'cltbld', 17:00:17 INFO - 'MAIL': '/var/mail/cltbld', 17:00:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:17 INFO - 'MOZ_NO_REMOTE': '1', 17:00:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:17 INFO - 'NO_EM_RESTART': '1', 17:00:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:00:17 INFO - 'PWD': '/builds/slave/test-pgo', 17:00:17 INFO - 'SHELL': '/bin/bash', 17:00:17 INFO - 'SHLVL': '1', 17:00:17 INFO - 'TERM': 'linux', 17:00:17 INFO - 'TMOUT': '86400', 17:00:17 INFO - 'USER': 'cltbld', 17:00:17 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1455583826.755046-327662611', 17:00:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:17 INFO - '_': '/tools/buildbot/bin/python'} 17:00:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:00:18 INFO - Downloading/unpacking flake8 17:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:00:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:00:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:00:19 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 17:00:19 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 17:00:19 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 17:00:19 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 17:00:19 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 17:00:19 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 17:00:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:00:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:00:20 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 17:00:20 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 17:00:20 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 17:00:20 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 17:00:20 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 17:00:20 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 17:00:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:00:20 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 17:00:20 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 17:00:20 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 17:00:20 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 17:00:20 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 17:00:20 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 17:00:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 17:00:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:00:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:00:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:00:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:00:20 INFO - no previously-included directories found matching 'docs/_build' 17:00:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:00:20 INFO - Running setup.py install for pep8 17:00:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:00:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:00:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:00:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:00:20 INFO - no previously-included directories found matching 'docs/_build' 17:00:20 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 17:00:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:00:20 INFO - Cleaning up... 17:00:20 INFO - Return code: 0 17:00:20 INFO - Running post-action listener: _resource_record_post_action 17:00:20 INFO - Running post-action listener: _start_resource_monitoring 17:00:20 INFO - Starting resource monitoring. 17:00:20 INFO - ##### 17:00:20 INFO - ##### Running install step. 17:00:20 INFO - ##### 17:00:20 INFO - Running pre-action listener: _resource_record_pre_action 17:00:20 INFO - Running main action method: install 17:00:20 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:00:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:00:21 INFO - Reading from file tmpfile_stdout 17:00:21 INFO - Detecting whether we're running mozinstall >=1.0... 17:00:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 17:00:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 17:00:21 INFO - Reading from file tmpfile_stdout 17:00:21 INFO - Output received: 17:00:21 INFO - Usage: mozinstall [options] installer 17:00:21 INFO - Options: 17:00:21 INFO - -h, --help show this help message and exit 17:00:21 INFO - -d DEST, --destination=DEST 17:00:21 INFO - Directory to install application into. [default: 17:00:21 INFO - "/builds/slave/test-pgo"] 17:00:21 INFO - --app=APP Application being installed. [default: firefox] 17:00:21 INFO - mkdir: /builds/slave/test-pgo/build/application 17:00:21 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'] 17:00:21 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 17:00:37 INFO - Reading from file tmpfile_stdout 17:00:37 INFO - Output received: 17:00:37 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 17:00:37 INFO - Running post-action listener: _resource_record_post_action 17:00:37 INFO - ##### 17:00:37 INFO - ##### Running run-tests step. 17:00:37 INFO - ##### 17:00:37 INFO - Running pre-action listener: _resource_record_pre_action 17:00:37 INFO - Running main action method: run_tests 17:00:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 17:00:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 17:00:37 INFO - Python 2.7.3 17:00:37 INFO - Return code: 0 17:00:37 INFO - grabbing minidump binary from tooltool 17:00: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')]} 17:00:37 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 0xe718c0>, '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 0xe727c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe72c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 17:00:37 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 17:00:37 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 17:00:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:00:37 INFO - Return code: 0 17:00:37 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 17:00:37 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 17:00:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 17:00:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 17:00:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 17:00:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 17:00:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 17:00:38 INFO - Return code: 0 17:00:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XQYnj-hQTTyWB6rqA1cY0A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 17:00:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XQYnj-hQTTyWB6rqA1cY0A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:00:38 INFO - Using env: {'DISPLAY': ':0', 17:00:38 INFO - 'HOME': '/home/cltbld', 17:00:38 INFO - 'LANG': 'en_US.UTF-8', 17:00:38 INFO - 'LANGUAGE': 'en_US:en', 17:00:38 INFO - 'LOGNAME': 'cltbld', 17:00:38 INFO - 'MAIL': '/var/mail/cltbld', 17:00:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:00:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 17:00:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:00:38 INFO - 'MOZ_NO_REMOTE': '1', 17:00:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:00:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:00:38 INFO - 'NO_EM_RESTART': '1', 17:00:38 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:00:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:00:38 INFO - 'PWD': '/builds/slave/test-pgo', 17:00:38 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 17:00:38 INFO - 'SHELL': '/bin/bash', 17:00:38 INFO - 'SHLVL': '1', 17:00:38 INFO - 'TERM': 'linux', 17:00:38 INFO - 'TMOUT': '86400', 17:00:38 INFO - 'USER': 'cltbld', 17:00:38 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1455583826.755046-327662611', 17:00:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:00:38 INFO - '_': '/tools/buildbot/bin/python'} 17:00:38 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XQYnj-hQTTyWB6rqA1cY0A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:00:38 INFO - mozversion application_buildid: 20160215143005 17:00:38 INFO - mozversion application_changeset: 8bd1a25ac261cf03eb383264f69fb8606cabb470 17:00:38 INFO - mozversion application_display_name: Nightly 17:00:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:00:38 INFO - mozversion application_name: Firefox 17:00:38 INFO - mozversion application_remotingname: firefox 17:00:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:00:38 INFO - mozversion application_vendor: Mozilla 17:00:38 INFO - mozversion application_version: 47.0a1 17:00:38 INFO - mozversion platform_buildid: 20160215143005 17:00:38 INFO - mozversion platform_changeset: 8bd1a25ac261cf03eb383264f69fb8606cabb470 17:00:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:00:38 INFO - mozversion platform_version: 47.0a1 17:00:38 INFO - using testdate: 1455584438 17:00:38 INFO - actual date: 1455584438 17:00:38 INFO - starting webserver on 'localhost:48675' 17:00:38 INFO - SUITE-START | Running 2 tests 17:00:38 INFO - TEST-START | dromaeo_css 17:00:38 INFO - operating with platform_type : linux_ 17:00:38 INFO - Initialising browser for dromaeo_css test... 17:00:38 INFO - TEST-INFO | started process 11802 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSsBrVp/profile http://localhost:48675/getInfo.html) 17:00:43 INFO - PROCESS | 11802 | 17:00:43 INFO - PROCESS | 11802 | (process:11885): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:00:44 INFO - PROCESS | 11802 | __metrics Screen width/height:1600/1200 17:00:44 INFO - PROCESS | 11802 | colorDepth:24 17:00:44 INFO - PROCESS | 11802 | Browser inner width/height: 1024/697 17:00:44 INFO - PROCESS | 11802 | __metrics 17:00:45 INFO - TEST-INFO | 11802: exit 0 17:00:45 INFO - Browser initialized. 17:00:45 INFO - Running cycle 1/1 for dromaeo_css test... 17:00:45 INFO - TEST-INFO | started process 11936 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSsBrVp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:00:47 INFO - PROCESS | 11936 | 17:00:47 INFO - PROCESS | 11936 | (process:11997): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:00:57 INFO - PROCESS | 11936 | RSS: Main: 157065216 17:00:57 INFO - PROCESS | 11936 | 17:01:47 INFO - PROCESS | 11936 | 1455584507447 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] 17:03:56 INFO - PROCESS | 11936 | Cycle 1(1): loaded http://localhost:48675/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48675/tests/dromaeo/cssquery-ext.html) 17:03:57 INFO - PROCESS | 11936 | RSS: Main: 164958208 17:03:57 INFO - PROCESS | 11936 | 17:06:59 INFO - PROCESS | 11936 | Cycle 1(1): loaded http://localhost:48675/tests/dromaeo/cssquery-ext.html (next: http://localhost:48675/tests/dromaeo/cssquery-jquery.html) 17:06:59 INFO - PROCESS | 11936 | RSS: Main: 162496512 17:06:59 INFO - PROCESS | 11936 | 17:10:01 INFO - PROCESS | 11936 | Cycle 1(1): loaded http://localhost:48675/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48675/tests/dromaeo/cssquery-mootools.html) 17:10:02 INFO - PROCESS | 11936 | RSS: Main: 160878592 17:10:02 INFO - PROCESS | 11936 | 17:13:03 INFO - PROCESS | 11936 | Cycle 1(1): loaded http://localhost:48675/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48675/tests/dromaeo/cssquery-prototype.html) 17:13:04 INFO - PROCESS | 11936 | RSS: Main: 158953472 17:13:04 INFO - PROCESS | 11936 | 17:16:06 INFO - PROCESS | 11936 | Cycle 1(1): loaded http://localhost:48675/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48675/tests/dromaeo/cssquery-yui.html) 17:16:07 INFO - PROCESS | 11936 | RSS: Main: 158916608 17:16:07 INFO - PROCESS | 11936 | 17:19:10 INFO - PROCESS | 11936 | Cycle 1(1): loaded http://localhost:48675/tests/dromaeo/cssquery-yui.html (next: http://localhost:48675/tests/dromaeo/cssquery-dojo.html) 17:19:10 INFO - PROCESS | 11936 | RSS: Main: 162668544 17:19:10 INFO - PROCESS | 11936 | 17:19:10 INFO - PROCESS | 11936 | __start_tp_report 17:19:10 INFO - PROCESS | 11936 | _x_x_mozilla_page_load 17:19:10 INFO - PROCESS | 11936 | _x_x_mozilla_page_load_details 17:19:10 INFO - PROCESS | 11936 | |i|pagename|runs| 17:19:10 INFO - PROCESS | 11936 | |0;dojo.html;3194.472911969525;3210.0369889033286;3241.0924941016524;3264.6408895021546;3268.82021488818;5082.79668813247;5383.515483606475;5390.51485366317;5397.433269506704;5398.811041613544;5369.62412631116;5411.756470958807;5424.9186262206;5430.619856610039;5438.809641662542;4870.70775753455;4875.8781030474165;4931.778069986859;5010.549050585447;5079.161938280179;4781.330613714083;4890.951090489103;4975.925361119586;4977.328060711812;4998.875028124289;4826.662133650646;4851.320815085873;4864.854054378375;4868.269759536062;4913.582345500637;4827.806887724487;4840.9515904840855;4850.175470170079;4852.8544143675745;4879.63402744792;4767.1419144553965;4841.298011788306;4843.58829499493;4896.387951506062;4979.8008079676765;5119.206522988943;5125.974370128126;5162.819301324435;5175.870603234912;5209.53114219722;5662.320521537442;5680.3467601225975;5684;5685.431456854323;5688.573356998241;5766.740496677659;5797.449242321973;5805.187273781674;5817.883642327172;5859.560532960045;5363.6245462817615;5426.484483974016;5428.4300148484235;5434.130539113723;5447.319085114361;5622.325320961429;5847.502962248256;5882.647041177543;5897.115432685132;5951.553633477506;5521.254630624894;5529.447055294519;5539.279893613804;5541.944580554224;5577.609567330248;5586.497215250647;5605.747741351649;5607.80372686954;5622.91565626516;5641.548676105984;5516.089845175581;5593.812375249501;5614;5764.942350576524;5862.237909071793;5662.490375866192;5666.2350582670815;5669.121286200645;5672.716364181774;5676.262085928803;4363.38912552243;4364.41080454141;4369.497507786582;4395.604395604347;4418.6023257906945;3854.113553882623;3939.4484772131923;3949.8025098744947;3981.980090099531;4010.979945100314;5339.546138578265;5349.625526213128;5361.249425080492;5365.0342938270705;5378.7041712705395;5484.972575137099;5699.401562835926;5700.885982280414;5709.8287051388525;5716.28546431696;5288.2596436498925;5320.388155362106;5320.733963301819;5349.331333583302;5373.838784836461;4733.290006499053;4737.336772851803;4750.883542367541;4783.784729687172;4792.688475249098;5684.63049901755;5785.450382213683;5789.102689083199;5804.4775970162045;5823.359430462646;5645.971770141123;5671.602987790815;5688.345840228261;5696.829095127153;5749.310082789924;5828.6211396259105;5838.12428135783;5838.241028666246;5904.468597826216;5910.290765108214;5369.973150134224;5619.80330688424;5655.915161272502;5762.106873434456;5852.7658893643775;5716.256886604715;5742.483176514133;5765.279340082489;5765.94234057654;5767.826965191051;5580.1629755537;5612.017896868113;5615.6630602164005;5627.52166065889;5630.7466164023535;5363.436839131835;5375.704336261543;5389.75746091419;5415.918761218663;5417.864553386197;5369.892602148013;5575.8606034847835;5606.131049687305;5612.242347283228;5633.577481688808;5664.575156863334;5689.203511508309;5702.8289151325525;5703.7433315500075;5712.257406537124;5399.460053994726;5528;5563.666180029049;5564.777408903598;5586.636868603528 17:19:10 INFO - PROCESS | 11936 | |1;ext.html;571.3458090486396;572.1989215098862;593.2762030323007;595.3302534648519;606.1513880567205;35328.2934341313;35730.46404303938;35761.82119089401;35774.105647358796;35845.2830943381;35815.10462238445;36564.451533227024;36573.63426365735;36697;36860.63139368605;8142.633581488847;8230.176982301751;8283.130271321515;8287.212714792115;8330.6251218695;8082.474639148437;8366.414350995432;8401.621927013299;8411.915880841205;8416.537090460022;8265.95867020664;8414.83170336596;8449.155084491564;8460.153984601522;8463.492190468562;8374.120717324655;8410.243078122967;8428.157184281585;8436.325093992466;8457.830843383097;8446.704365347183;8537.615807288686;8582.313414926792;8585.957070214608;8604.870926936039;37238.813805931066;37816.24367512662;37906.81046594777;37941.24117517634;37945.81027094847;3015.9547606785914;3236.9838150809096;3250.772445928786;3551.804650744208;3975.8608448704445;26671.333216669544;27178.72821271782;27226.31934201641;27467.811158798468;27931;3826.540815102178;3905.882823515299;3952.3873799561115;3988.441618173458;4000.5199376074765;203761;203964.98017509966;205352;205448;205772;52531.21203181955;54787.80848766005;58552.707236463546;60293.39706602878;61523.07715384273;54815.72592137093;55338.72330638321;55472.72263638656;55687.72156139193;55832.72083639556;14977.475788347574;15128.621784455476;15222.771658425132;15263.389464421522;15275.770863437057;12446.502139914483;12615.053870959531;12625.116241863165;12636.178648387826;12676.112672112864;20265.29071482491;20588.176472941213;20741.377758666964;20770.02684744947;20773.792262077488;8105.716299929474;8245.299149572234;8296.253337199681;8312.584370781437;8345.207205315486;917.2982668258787;972.4943029624698;1004.7689031522791;1102.1788767368362;1132.326265871805;28271.29321766972;29118.85440572826;29185.124446266647;29301.85349073241;29348.413031739245;1056.5615269663158;1067.2422579968309;1080.2978064258295;1087.7498175419698;1117.5753213778873;14934.25328733559;15046.924765376103;15054.096754194783;15085.773713394308;15174.696506069817;345961;356017;358462;359022;359758;55039;55040.44959550353;55224.09698787652;55322.17016744752;55441.168382474294;1409.901306908527;1410.6332353587936;1417.7235439089484;1436.5690292912293;1440.7478691228994;28587.857060714563;29236;29466.263343416587;29692.554611681273;29849.403011939205;46067.76966115148;47008.764956175;47223.29165062458;47288.29067564058;47310.76344618255;273493;274512;275033;275548;276159;33161;43688;43711.34432983444;44561;44634.3304850434;39117;39287.41068883912;39756;40047;40281.19437611173;33384.66615333913;33505.49741753827;33861.49207761935;34139.82930085334;34370.82814585911;33188;34077.65922340745;34522.30955380928;34695.479567805996;34920;37562.24875502529;38115;38136.42795358016;38465;39012.2197556053;29327.549236627754;29631.407371852874;31435.685643143275;32536.51195232026;34122.65877341294;25916.35209119787;25954.22137335883;25990;26082.73917260879;26104.34739131537 17:19:10 INFO - PROCESS | 11936 | |2;jquery.html;357.49057592930075;360.0781998084903;367.05483380295726;368.4510079980828;375.86656736858396;16055.598610034755;16960.151992400362;17241.48275551734;17784;18303.99999999998;9545;9834.164096051827;9838.950805245982;9868;10039.29724919256;4804.183288840897;4828.203346447832;4933.777979990909;4951.108800415924;4962.677425967318;4813.518648135194;4938.160512712848;4945.950540494585;4975.776090075955;4984.501549845023;4931.186354251544;4962.578180854632;5102.38771347437;5360.061989151903;5360.195970604402;5301;5316.229146773716;5336.9733151334185;5735.311762588474;6196.566240363177;5475.534579560742;5499.532539734128;5502;5502.9174562381595;5508.862278443071;16333.83666163347;19966.90016549908;20280.391588252376;20419.79580204209;20517.281895133747;1968.22255209193;2041.7345745053196;2061.4846288427893;2100.203181525354;2337.2754446121758;8988.32587555936;9919.640370768158;10745.19411044167;12059.879401206052;12991.285479298635;1800.621869407413;1834.8990805505691;1843.0876716025518;1850.8982005989665;1894.1003023563835;58176.418235817524;58604;59963.1005534913;61354;61805.38194618041;9418.717438476857;9640.807183856283;9662.56518456671;9776.071273229032;9832.115109640166;12296.323702196287;12399.628011159679;12413.193142445713;12416;12494.125411221126;7426.5915374654915;7524.908888211179;7536.057992750906;7559.773206803805;7569.091708994846;7528.736494222676;7546.924530754732;7554.395648348119;7569.810754731176;7583.886241706379;4032.91934161321;4034.636882680573;4044.9191016180102;4051.1290072634524;4061.431399604058;1743.1894169211123;1743.5815404302875;1767.8939263644222;1773.0957211822063;1784.161444121261;901.4591245252927;943.698016634684;949.9525023748785;985.5959056786683;988.3625061835077;15882.76175857363;16313.836861631231;16449.6710065798;16748.24632891523;16828.831711682727;892.8392889279992;894.6510860764307;896.0815164456484;934.1499235695485;975.6536429567543;9315.534223288809;9625;9674.75813104678;9707.271954603433;9769;368961;377468;378633;381468;520625;62379;67183.66408167928;70595.2940470599;74117.6294118526;75745.6212718933;1114.6990312615549;1117.463617463622;1207.7741092790825;1226.1539537719123;1251.0367017396554;10263.224942673905;14789.482368117064;15091.2271932017;15155.545333639568;15278.77081843751;30950.22624434407;33980.32039359248;34943.475847861795;35744.463833042006;35861.462078068325;42449;42483;45365;45751.313730293405;45846.54153458423;10255.94872025635;10509.264351495322;10735.516901739284;10857.83713244286;11026.724331891446;8067.919320806717;8849.867251991096;8984.55077246122;9149.405288656217;12908.741825163632;7804.219578042151;7824.726134585262;8121.5533145677555;8124.187581241828;8198.959005204935;7976.453421549661;8070.1122876484715;8111.229433203836;8120.796980075309;8133.268005879263;7790.844183116419;7894.460580187038;8048.114707382067;8062.798430039296;8228.670853166046;10601.257911946399;10657.57369705203;10774.946125269324;10811.297265677706;11020.228583999044;7235.204127546071;7338.266173382619;7562.697492100255;7619.276168763959;10288.2798204125 17:19:10 INFO - PROCESS | 11936 | |3;mootools.html;1435.8994870359077;1444.3933547909876;1610.1385758619142;1769.3984045424554;1785.053921421647;6596.142501474814;7420.591867447289;7773.650185741648;7962.721304754335;7965.920340796591;7563.508371955819;7630.732924347649;7674.577898215596;7728;7734.5745983970855;2302.9424264393397;2325.6511523271474;2327.7788610082016;2331;2341.5785158671433;2305.804006659436;2308.6306191009444;2309.1917828759883;2342.824288178385;2350.7296660883962;2026.0477575539546;2273.8294627902974;2284.3832165315357;2300.723913130418;2326.8254880883915;2299.218265789623;2300.493891343902;2332.5917964356254;2333.649952507129;2338.649202619604;2338.0647740903605;2359.256834097271;2370.383700237933;2370.9051637934635;2380.155044959032;7725.6137193140685;7744.419168562324;7805.843883122306;7810.960945195295;7811.960940195319;4741.336212930192;4889.3888263967;4916.606671466274;4921.261810728383;4934.753262336869;3058.6023816903885;3063.0351439296774;3158.873645054195;3161.4309424303615;3187.123541026236;970.5741817313075;976.4483067067084;1055.155875299757;1083.1659622090947;1913.722510236022;10234.6417875374;10333.689989300334;10411.271211015232;10460.947695261551;10474.371537707686;4354.194474022316;4388.166248412791;4447.132809102194;4471.664625153061;4498.212812757754;8358.205970432798;8408.075111737704;8460.703875364332;8493.193146651058;8500.192481714228;4734.95265047352;4747.477777444478;4762.9523704763205;4774.641901857374;4797.904041919142;4388.626966707801;4408.58118478744;4429.601335879786;4442.666799990014;4451.577100175478;3532.894013179609;3540.451230059345;3561.44797556374;3607.909802254912;3622.2574372253625;1089.6077412131626;1116.2744216259496;1121.7532142928542;1127.1321082766387;1169.0355456748216;1278.1691900264902;1288.6327396691897;1313.6453157647381;1317.762802695524;1323.2259128409987;7174.390176835028;7218.205997340288;7286.089238845145;7302.342789149002;7314.780556583311;1105.4196546812987;1105.7346236903086;1118.1557923767502;1118.7370967822555;1126.8535090438354;5664.037113690682;5731.426857314235;5734.598578099493;5777.94222057774;5830.096335068071;8888.244499217639;9102.408343457653;9288.953555232181;9382.437053776795;9411.811763764686;9209.079092090737;9235.76910577241;9246.676366327147;9277.257819374434;9285.48929808867;7251.202367739545;7307.159676637149;7383.372413344926;7387.409007279405;7403.22266162056;7078.787636370917;7134.714611415693;7135.571865688075;7139.892901606376;7184.425245980414;8256.380771442045;8446.197611226924;8492.405531612727;8521.53131577769;8524.806527086088;8664.566771661266;8726.258268047288;8755.124487551195;8773.692920747742;8801.47191168532;6482.611043337415;6626.734930602722;6661.83345416349;6671.532992690465;6673;7479.850402992019;7528.849423011399;7566.432517561315;7570.470067095251;7573.2048134945035;6326.652034137983;6781.6270105144695;6948.235694073749;7134.32223938725;7291.30732580404;6685;6701.061851340719;6786.355296246848;6831.316868313129;6858.862822743617;6547.803565893031;6600;6613.834654133685;6617.2721000688925;6625.536212465081;6146.323904370605;6247.2815626201755;6277.089821975879;6290.150829637941;6313.589616674902;6366.808995730135;6380.330065343072;6401.455876250571;6476.028595710681;6480.481561474976 17:19:10 INFO - PROCESS | 11936 | |4;prototype.html;327.1738859380066;327.4694994109543;330.57686161713013;334.48322341981634;337.4314280437463;6278.874422511547;6282.497400207983;6305.779297724586;6372.522060845437;6510.5442619016685;6300.05499175124;6310.337414571472;6328.892443822324;6349.650769207692;6364.045393191023;4780.9760951195285;4784.234522476405;4786.736729479877;4787.880302992418;4800.351952486422;4745.833895813647;4771.355866957951;4785.545373189541;4791.496892826255;4803.087413391444;4652.860414187563;4717.292406139072;4733.124371991175;4733.59764420023;4736.526347365253;4702.647301452388;4710.693804902705;4721.315409265671;4723.763811809413;4733.408323959505;4077.3883917412327;4084.1014976705374;4089.161721847044;4092.6112019358116;4104.220198162339;5982.790602328898;5992.280926288873;6002.729877155539;6014;6027.276726792769;5364.436734142898;5459.69971651559;5468.7539060742365;5512.448755124496;5513.9448605513835;6659.234188068337;6673.499487538454;6695.866082678319;6697.866042679168;6761.628110453923;4477.731336119843;4483;4486.259767138418;4489.079738653568;4498.977505112486;6816.4546836252985;6901.240863505011;6995.545289556214;7001.509894307401;7016.368526832559;4524.8416305429155;4566.315052742115;4582.106489234634;4585.72485650862;4595.885102872455;4602.171609110393;4609.700369475973;4621.1219868224925;4623.791929363187;4643.86068417948;5429.212764149255;5431.293931788842;5431.34823821144;5437.13005919051;5439.945600544023;6532.934670653328;6721.059051732761;6733.494987875929;6745.156855393076;6757.358050985148;1534.6393597504577;1587.7221486240094;1588.1900230882334;1614.8304428034887;1616.2403670274953;1055.8574592430077;1062.5377960587016;1071.3786004117594;1071.5178169823455;1085.0722632149398;6267.6866156691985;6291.307956124822;6313.463355614732;6323.20959880015;6352.205974253218;6730.966345168243;6833.829154271084;6838.897416538756;6839.452843772586;6844.589324640538;6152.384761523901;6297.960836462024;6302.747890084345;6304.716287767062;6308.400701933309;3668.486411902336;3687.2994131115;3703.759255648374;3710.443433484999;3719.0330514066536;7059.7529086482755;7121.750738724223;7127;7133.108361454818;7136.143662760502;6799.694013769392;6949.339812717783;7023.473239506955;7053.506254562234;7054.541454805421;7125.82185445368;7130.572165670076;7133.286671332929;7135.429165666734;7141.607211603412;6722.193336799615;6722.193336799615;6734.696938637871;6736;6759.966200168968;6634.900476492953;6681.198256209286;6694.933050669431;6720.663966801738;6722.1261236039;7071.540349877448;7105.857882842418;7128.465365097535;7134.750283740044;7135.179454362815;4501.054778496552;4502.887427814331;4505.842295519641;4516.796744146455;4519.728816271035;6535.738570457129;6761.966190169018;6799.524033317621;6817.8636427270185;6868.107146070979;6713.597184168965;6744.730210791709;6755.4257888080065;6786.491013174131;6793.490488213502;6659.300773418915;6699.464042876656;6755.8177318968;6755.864882702417;6758.594484330956;6524.282328943717;6641.800745977628;6641.933580664131;6647.966760166361;6665.700043497957;6738.090357801634;6778.762743303961;6782.626955517494;6787.796366109024;6793.966030169818;6583.341665833378;6587.110740050223;6587.901181482186;6590.275069742229;6605.867882642417 17:19:10 INFO - PROCESS | 11936 | |5;yui.html;722.0829546475976;726.654838951498;744.9292317229863;756.7313603670693;812.6993012585336;13253.536126235584;13554.118982266158;13615.25116118613;13690.863091369083;13739.931300343484;12962.611121666365;12971.481140754382;13059.934700326508;13066.673333166676;13093.67265818355;672.9831754206135;817.5462618246886;819.4345901328095;830.5515021888173;831.2975535672347;819.5041999590252;820.6307161777195;821.1337039423406;821.6795449774593;822.9259366657;866.9913300866974;869.76516340588;870.2515836380708;870.6691457246237;872.7250915961483;860.1914200651368;863.2360361080426;865.5845194306705;866.5970323799432;870.3124531620012;623.6476390839161;629.1443636654146;629.4177885455981;631.8009826904511;633.6388258692547;13494.797578036338;13495.59513214605;13510.797338039938;13642.317884105854;13655.180689158682;12781.233126012376;12805.935970320183;12905.2902090385;13335.333233338295;13611.727765444635;10280.537375818107;10313.587456501731;10394.79210415795;10398.168146548258;10454.581816727321;3547.6984456321243;3636.0364503406618;3640.0899775056237;3650.908727281813;3699.019759763638;46850.531494685296;46865.765671171765;46912.530874691496;46971;46992.7650361746;9299;9500.382475139231;9695.321327507148;9852.507374631383;9882.258830587734;18577.25690972373;18697.81302186988;18713.90643046776;18745.437636870916;18763.90618046901;7559.886601700869;7610.124835643861;7670.386369090459;7702.268284512962;7940.722074727357;4271.67962402821;4341.218580655449;4409.625181859577;4421.778911054499;4511.932321015187;3206.64726880043;3254.2189874429964;3258.234314935988;3258.4297747894025;3265.804051756902;609.4819403506983;624.753222477119;627.6673363117555;638.3903372279462;644.1143427786793;584.6550535184261;651.840299126717;659.8284446044063;663.9900401493982;668.5320275806857;7983.880241796378;8181.3863960203225;8301.335893128657;8352.457090289112;8457.830843383097;515.2734644151728;641.5060403489288;689.9344562266576;701.1165930926967;726.96728647211;4079.1841631673783;4253.361995700608;4320.1143765527995;4328.761918094472;4522.954770452319;51253.7437312811;51557;51657;51801.48198518042;52111.739441302554;48222;48223.27665085027;48545;48768.26847597289;49632;43500.56499435029;43792.343114853305;44172.55827441684;44327.113457730666;44681.55318446774;8542.701005464778;8639.827203456021;8748.256398206224;8848.380613357262;8873.245774109273;30383;30444.238894027825;30953.380932381675;30961.380772383975;31592.36815263728;37262.44106338461;37460;37854;40395.59604404036;40418.39372409475;10864.293820901616;11073.833892491459;11247.437628118398;11350.262232954832;11382.658520244406;12051.33717645538;12054.698632534257;12150;12170.417845680005;12276.815847762113;10374;10521.736956576147;10560.735981600521;10708.89291107079;10879.129669626569;11699.649010529698;11714.88285117138;11898.940505297418;12021.158518903592;12413.565525206574;10570.735731606464;10584.841227381441;10679.46602669848;10961.232713709964;11058.060064894575;9363.719088427359;9446.811063778548;9585.664501742405;9701.223902087675;9706.272029597949;8772;9256.25949924018;9547.665831695856;9601.32790704672;9676.70969870905 17:19:10 INFO - PROCESS | 11936 | __end_tp_report 17:19:10 INFO - PROCESS | 11936 | __start_cc_report 17:19:10 INFO - PROCESS | 11936 | _x_x_mozilla_cycle_collect,322 17:19:10 INFO - PROCESS | 11936 | __end_cc_report 17:19:10 INFO - PROCESS | 11936 | __startTimestamp1455585550250__endTimestamp 17:19:10 INFO - PROCESS | 11936 | 17:19:10 INFO - PROCESS | 11936 | ------- Summary: start ------- 17:19:10 INFO - PROCESS | 11936 | Number of tests: 6 17:19:10 INFO - PROCESS | 11936 | 17:19:10 INFO - PROCESS | 11936 | [#0] dojo.html Cycles:165 Average:5297.22 Median:5447.32 stddev:576.77 (10.6%) stddev-sans-first:554.45 17:19:10 INFO - PROCESS | 11936 | Values: 3194.5 3210.0 3241.1 3264.6 3268.8 5082.8 5383.5 5390.5 5397.4 5398.8 5369.6 5411.8 5424.9 5430.6 5438.8 4870.7 4875.9 4931.8 5010.5 5079.2 4781.3 4891.0 4975.9 4977.3 4998.9 4826.7 4851.3 4864.9 4868.3 4913.6 4827.8 4841.0 4850.2 4852.9 4879.6 4767.1 4841.3 4843.6 4896.4 4979.8 5119.2 5126.0 5162.8 5175.9 5209.5 5662.3 5680.3 5684.0 5685.4 5688.6 5766.7 5797.4 5805.2 5817.9 5859.6 5363.6 5426.5 5428.4 5434.1 5447.3 5622.3 5847.5 5882.6 5897.1 5951.6 5521.3 5529.4 5539.3 5541.9 5577.6 5586.5 5605.7 5607.8 5622.9 5641.5 5516.1 5593.8 5614.0 5764.9 5862.2 5662.5 5666.2 5669.1 5672.7 5676.3 4363.4 4364.4 4369.5 4395.6 4418.6 3854.1 3939.4 3949.8 3982.0 4011.0 5339.5 5349.6 5361.2 5365.0 5378.7 5485.0 5699.4 5700.9 5709.8 5716.3 5288.3 5320.4 5320.7 5349.3 5373.8 4733.3 4737.3 4750.9 4783.8 4792.7 5684.6 5785.5 5789.1 5804.5 5823.4 5646.0 5671.6 5688.3 5696.8 5749.3 5828.6 5838.1 5838.2 5904.5 5910.3 5370.0 5619.8 5655.9 5762.1 5852.8 5716.3 5742.5 5765.3 5765.9 5767.8 5580.2 5612.0 5615.7 5627.5 5630.7 5363.4 5375.7 5389.8 5415.9 5417.9 5369.9 5575.9 5606.1 5612.2 5633.6 5664.6 5689.2 5702.8 5703.7 5712.3 5399.5 5528.0 5563.7 5564.8 5586.6 17:19:10 INFO - PROCESS | 11936 | 17:19:10 INFO - PROCESS | 11936 | [#1] ext.html Cycles:180 Average:44919.30 Median:197153.64 stddev:74746.15 (37.9%) stddev-sans-first:74881.67 17:19:10 INFO - PROCESS | 11936 | Values: 571.3 572.2 593.3 595.3 606.2 35328.3 35730.5 35761.8 35774.1 35845.3 35815.1 36564.5 36573.6 36697.0 36860.6 8142.6 8230.2 8283.1 8287.2 8330.6 8082.5 8366.4 8401.6 8411.9 8416.5 8266.0 8414.8 8449.2 8460.2 8463.5 8374.1 8410.2 8428.2 8436.3 8457.8 8446.7 8537.6 8582.3 8586.0 8604.9 37238.8 37816.2 37906.8 37941.2 37945.8 3016.0 3237.0 3250.8 3551.8 3975.9 26671.3 27178.7 27226.3 27467.8 27931.0 3826.5 3905.9 3952.4 3988.4 4000.5 203761.0 203965.0 205352.0 205448.0 205772.0 52531.2 54787.8 58552.7 60293.4 61523.1 54815.7 55338.7 55472.7 55687.7 55832.7 14977.5 15128.6 15222.8 15263.4 15275.8 12446.5 12615.1 12625.1 12636.2 12676.1 20265.3 20588.2 20741.4 20770.0 20773.8 8105.7 8245.3 8296.3 8312.6 8345.2 917.3 972.5 1004.8 1102.2 1132.3 28271.3 29118.9 29185.1 29301.9 29348.4 1056.6 1067.2 1080.3 1087.7 1117.6 14934.3 15046.9 15054.1 15085.8 15174.7 345961.0 356017.0 358462.0 359022.0 359758.0 55039.0 55040.4 55224.1 55322.2 55441.2 1409.9 1410.6 1417.7 1436.6 1440.7 28587.9 29236.0 29466.3 29692.6 29849.4 46067.8 47008.8 47223.3 47288.3 47310.8 273493.0 274512.0 275033.0 275548.0 276159.0 33161.0 43688.0 43711.3 44561.0 44634.3 39117.0 39287.4 39756.0 40047.0 40281.2 33384.7 33505.5 33861.5 34139.8 34370.8 33188.0 34077.7 34522.3 34695.5 34920.0 37562.2 38115.0 38136.4 38465.0 39012.2 29327.5 29631.4 31435.7 32536.5 34122.7 25916.4 25954.2 25990.0 26082.7 26104.3 17:19:10 INFO - PROCESS | 11936 | 17:19:10 INFO - PROCESS | 11936 | [#2] jquery.html Cycles:180 Average:23648.12 Median:4942.06 stddev:67233.83 (1360.4%) stddev-sans-first:67399.70 17:19:10 INFO - PROCESS | 11936 | Values: 357.5 360.1 367.1 368.5 375.9 16055.6 16960.2 17241.5 17784.0 18304.0 9545.0 9834.2 9839.0 9868.0 10039.3 4804.2 4828.2 4933.8 4951.1 4962.7 4813.5 4938.2 4946.0 4975.8 4984.5 4931.2 4962.6 5102.4 5360.1 5360.2 5301.0 5316.2 5337.0 5735.3 6196.6 5475.5 5499.5 5502.0 5502.9 5508.9 16333.8 19966.9 20280.4 20419.8 20517.3 1968.2 2041.7 2061.5 2100.2 2337.3 8988.3 9919.6 10745.2 12059.9 12991.3 1800.6 1834.9 1843.1 1850.9 1894.1 58176.4 58604.0 59963.1 61354.0 61805.4 9418.7 9640.8 9662.6 9776.1 9832.1 12296.3 12399.6 12413.2 12416.0 12494.1 7426.6 7524.9 7536.1 7559.8 7569.1 7528.7 7546.9 7554.4 7569.8 7583.9 4032.9 4034.6 4044.9 4051.1 4061.4 1743.2 1743.6 1767.9 1773.1 1784.2 901.5 943.7 950.0 985.6 988.4 15882.8 16313.8 16449.7 16748.2 16828.8 892.8 894.7 896.1 934.1 975.7 9315.5 9625.0 9674.8 9707.3 9769.0 368961.0 377468.0 378633.0 381468.0 520625.0 62379.0 67183.7 70595.3 74117.6 75745.6 1114.7 1117.5 1207.8 1226.2 1251.0 10263.2 14789.5 15091.2 15155.5 15278.8 30950.2 33980.3 34943.5 35744.5 35861.5 42449.0 42483.0 45365.0 45751.3 45846.5 10255.9 10509.3 10735.5 10857.8 11026.7 8067.9 8849.9 8984.6 9149.4 12908.7 7804.2 7824.7 8121.6 8124.2 8199.0 7976.5 8070.1 8111.2 8120.8 8133.3 7790.8 7894.5 8048.1 8062.8 8228.7 10601.3 10657.6 10774.9 10811.3 11020.2 7235.2 7338.3 7562.7 7619.3 10288.3 17:19:10 INFO - PROCESS | 11936 | 17:19:10 INFO - PROCESS | 11936 | [#3] mootools.html Cycles:180 Average:5422.33 Median:6283.62 stddev:2735.42 (43.5%) stddev-sans-first:2726.68 17:19:10 INFO - PROCESS | 11936 | Values: 1435.9 1444.4 1610.1 1769.4 1785.1 6596.1 7420.6 7773.7 7962.7 7965.9 7563.5 7630.7 7674.6 7728.0 7734.6 2302.9 2325.7 2327.8 2331.0 2341.6 2305.8 2308.6 2309.2 2342.8 2350.7 2026.0 2273.8 2284.4 2300.7 2326.8 2299.2 2300.5 2332.6 2333.6 2338.6 2338.1 2359.3 2370.4 2370.9 2380.2 7725.6 7744.4 7805.8 7811.0 7812.0 4741.3 4889.4 4916.6 4921.3 4934.8 3058.6 3063.0 3158.9 3161.4 3187.1 970.6 976.4 1055.2 1083.2 1913.7 10234.6 10333.7 10411.3 10460.9 10474.4 4354.2 4388.2 4447.1 4471.7 4498.2 8358.2 8408.1 8460.7 8493.2 8500.2 4735.0 4747.5 4763.0 4774.6 4797.9 4388.6 4408.6 4429.6 4442.7 4451.6 3532.9 3540.5 3561.4 3607.9 3622.3 1089.6 1116.3 1121.8 1127.1 1169.0 1278.2 1288.6 1313.6 1317.8 1323.2 7174.4 7218.2 7286.1 7302.3 7314.8 1105.4 1105.7 1118.2 1118.7 1126.9 5664.0 5731.4 5734.6 5777.9 5830.1 8888.2 9102.4 9289.0 9382.4 9411.8 9209.1 9235.8 9246.7 9277.3 9285.5 7251.2 7307.2 7383.4 7387.4 7403.2 7078.8 7134.7 7135.6 7139.9 7184.4 8256.4 8446.2 8492.4 8521.5 8524.8 8664.6 8726.3 8755.1 8773.7 8801.5 6482.6 6626.7 6661.8 6671.5 6673.0 7479.9 7528.8 7566.4 7570.5 7573.2 6326.7 6781.6 6948.2 7134.3 7291.3 6685.0 6701.1 6786.4 6831.3 6858.9 6547.8 6600.0 6613.8 6617.3 6625.5 6146.3 6247.3 6277.1 6290.2 6313.6 6366.8 6380.3 6401.5 6476.0 6480.5 17:19:10 INFO - PROCESS | 11936 | 17:19:10 INFO - PROCESS | 11936 | [#4] prototype.html Cycles:180 Average:5535.75 Median:6309.37 stddev:1705.92 (27.0%) stddev-sans-first:1665.30 17:19:10 INFO - PROCESS | 11936 | Values: 327.2 327.5 330.6 334.5 337.4 6278.9 6282.5 6305.8 6372.5 6510.5 6300.1 6310.3 6328.9 6349.7 6364.0 4781.0 4784.2 4786.7 4787.9 4800.4 4745.8 4771.4 4785.5 4791.5 4803.1 4652.9 4717.3 4733.1 4733.6 4736.5 4702.6 4710.7 4721.3 4723.8 4733.4 4077.4 4084.1 4089.2 4092.6 4104.2 5982.8 5992.3 6002.7 6014.0 6027.3 5364.4 5459.7 5468.8 5512.4 5513.9 6659.2 6673.5 6695.9 6697.9 6761.6 4477.7 4483.0 4486.3 4489.1 4499.0 6816.5 6901.2 6995.5 7001.5 7016.4 4524.8 4566.3 4582.1 4585.7 4595.9 4602.2 4609.7 4621.1 4623.8 4643.9 5429.2 5431.3 5431.3 5437.1 5439.9 6532.9 6721.1 6733.5 6745.2 6757.4 1534.6 1587.7 1588.2 1614.8 1616.2 1055.9 1062.5 1071.4 1071.5 1085.1 6267.7 6291.3 6313.5 6323.2 6352.2 6731.0 6833.8 6838.9 6839.5 6844.6 6152.4 6298.0 6302.7 6304.7 6308.4 3668.5 3687.3 3703.8 3710.4 3719.0 7059.8 7121.8 7127.0 7133.1 7136.1 6799.7 6949.3 7023.5 7053.5 7054.5 7125.8 7130.6 7133.3 7135.4 7141.6 6722.2 6722.2 6734.7 6736.0 6760.0 6634.9 6681.2 6694.9 6720.7 6722.1 7071.5 7105.9 7128.5 7134.8 7135.2 4501.1 4502.9 4505.8 4516.8 4519.7 6535.7 6762.0 6799.5 6817.9 6868.1 6713.6 6744.7 6755.4 6786.5 6793.5 6659.3 6699.5 6755.8 6755.9 6758.6 6524.3 6641.8 6641.9 6648.0 6665.7 6738.1 6778.8 6782.6 6787.8 6794.0 6583.3 6587.1 6587.9 6590.3 6605.9 17:19:10 INFO - PROCESS | 11936 | 17:19:10 INFO - PROCESS | 11936 | [#5] yui.html Cycles:180 Average:13205.05 Median:46858.15 stddev:14678.05 (31.3%) stddev-sans-first:14689.29 17:19:10 INFO - PROCESS | 11936 | Values: 722.1 726.7 744.9 756.7 812.7 13253.5 13554.1 13615.3 13690.9 13739.9 12962.6 12971.5 13059.9 13066.7 13093.7 673.0 817.5 819.4 830.6 831.3 819.5 820.6 821.1 821.7 822.9 867.0 869.8 870.3 870.7 872.7 860.2 863.2 865.6 866.6 870.3 623.6 629.1 629.4 631.8 633.6 13494.8 13495.6 13510.8 13642.3 13655.2 12781.2 12805.9 12905.3 13335.3 13611.7 10280.5 10313.6 10394.8 10398.2 10454.6 3547.7 3636.0 3640.1 3650.9 3699.0 46850.5 46865.8 46912.5 46971.0 46992.8 9299.0 9500.4 9695.3 9852.5 9882.3 18577.3 18697.8 18713.9 18745.4 18763.9 7559.9 7610.1 7670.4 7702.3 7940.7 4271.7 4341.2 4409.6 4421.8 4511.9 3206.6 3254.2 3258.2 3258.4 3265.8 609.5 624.8 627.7 638.4 644.1 584.7 651.8 659.8 664.0 668.5 7983.9 8181.4 8301.3 8352.5 8457.8 515.3 641.5 689.9 701.1 727.0 4079.2 4253.4 4320.1 4328.8 4523.0 51253.7 51557.0 51657.0 51801.5 52111.7 48222.0 48223.3 48545.0 48768.3 49632.0 43500.6 43792.3 44172.6 44327.1 44681.6 8542.7 8639.8 8748.3 8848.4 8873.2 30383.0 30444.2 30953.4 30961.4 31592.4 37262.4 37460.0 37854.0 40395.6 40418.4 10864.3 11073.8 11247.4 11350.3 11382.7 12051.3 12054.7 12150.0 12170.4 12276.8 10374.0 10521.7 10560.7 10708.9 10879.1 11699.6 11714.9 11898.9 12021.2 12413.6 10570.7 10584.8 10679.5 10961.2 11058.1 9363.7 9446.8 9585.7 9701.2 9706.3 8772.0 9256.3 9547.7 9601.3 9676.7 17:19:10 INFO - PROCESS | 11936 | -------- Summary: end -------- 17:19:10 INFO - PROCESS | 11936 | 17:19:10 INFO - TEST-INFO | 11936: exit 0 17:19:10 INFO - TEST-OK | dromaeo_css | took 1112294ms 17:19:10 INFO - TEST-START | kraken 17:19:10 INFO - operating with platform_type : linux_ 17:19:10 INFO - Initialising browser for kraken test... 17:19:10 INFO - TEST-INFO | started process 12176 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptqEn8R/profile http://localhost:48675/getInfo.html) 17:19:15 INFO - PROCESS | 12176 | 17:19:15 INFO - PROCESS | 12176 | (process:12249): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:19:16 INFO - PROCESS | 12176 | __metrics Screen width/height:1600/1200 17:19:16 INFO - PROCESS | 12176 | colorDepth:24 17:19:16 INFO - PROCESS | 12176 | Browser inner width/height: 1024/697 17:19:16 INFO - PROCESS | 12176 | __metrics 17:19:17 INFO - TEST-INFO | 12176: exit 0 17:19:17 INFO - Browser initialized. 17:19:17 INFO - Running cycle 1/1 for kraken test... 17:19:17 INFO - TEST-INFO | started process 12300 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptqEn8R/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:19:19 INFO - PROCESS | 12300 | 17:19:19 INFO - PROCESS | 12300 | (process:12362): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:19:29 INFO - PROCESS | 12300 | RSS: Main: 158187520 17:19:29 INFO - PROCESS | 12300 | 17:19:32 INFO - PROCESS | 12300 | Cycle 1(1): loaded http://localhost:48675/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48675/tests/kraken/driver.html?testName=audio-beat-detection) 17:19:32 INFO - PROCESS | 12300 | RSS: Main: 162185216 17:19:32 INFO - PROCESS | 12300 | 17:19:35 INFO - PROCESS | 12300 | Cycle 1(1): loaded http://localhost:48675/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48675/tests/kraken/driver.html?testName=audio-dft) 17:19:36 INFO - PROCESS | 12300 | RSS: Main: 166199296 17:19:36 INFO - PROCESS | 12300 | 17:19:38 INFO - PROCESS | 12300 | Cycle 1(1): loaded http://localhost:48675/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48675/tests/kraken/driver.html?testName=audio-fft) 17:19:39 INFO - PROCESS | 12300 | RSS: Main: 156745728 17:19:39 INFO - PROCESS | 12300 | 17:19:41 INFO - PROCESS | 12300 | Cycle 1(1): loaded http://localhost:48675/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48675/tests/kraken/driver.html?testName=audio-oscillator) 17:19:42 INFO - PROCESS | 12300 | RSS: Main: 158883840 17:19:42 INFO - PROCESS | 12300 | 17:19:44 INFO - PROCESS | 12300 | Cycle 1(1): loaded http://localhost:48675/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48675/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:19:45 INFO - PROCESS | 12300 | RSS: Main: 158420992 17:19:45 INFO - PROCESS | 12300 | 17:19:48 INFO - PROCESS | 12300 | Cycle 1(1): loaded http://localhost:48675/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48675/tests/kraken/driver.html?testName=imaging-darkroom) 17:19:48 INFO - PROCESS | 12300 | RSS: Main: 159088640 17:19:48 INFO - PROCESS | 12300 | 17:19:52 INFO - PROCESS | 12300 | Cycle 1(1): loaded http://localhost:48675/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48675/tests/kraken/driver.html?testName=imaging-desaturate) 17:19:52 INFO - PROCESS | 12300 | RSS: Main: 159899648 17:19:52 INFO - PROCESS | 12300 | 17:19:55 INFO - PROCESS | 12300 | Cycle 1(1): loaded http://localhost:48675/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48675/tests/kraken/driver.html?testName=json-parse-financial) 17:19:56 INFO - PROCESS | 12300 | RSS: Main: 162123776 17:19:56 INFO - PROCESS | 12300 | 17:19:57 INFO - PROCESS | 12300 | Cycle 1(1): loaded http://localhost:48675/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48675/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:19:58 INFO - PROCESS | 12300 | RSS: Main: 162111488 17:19:58 INFO - PROCESS | 12300 | 17:20:00 INFO - PROCESS | 12300 | Cycle 1(1): loaded http://localhost:48675/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48675/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:20:00 INFO - PROCESS | 12300 | RSS: Main: 162181120 17:20:00 INFO - PROCESS | 12300 | 17:20:02 INFO - PROCESS | 12300 | Cycle 1(1): loaded http://localhost:48675/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48675/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:20:03 INFO - PROCESS | 12300 | RSS: Main: 162484224 17:20:03 INFO - PROCESS | 12300 | 17:20:05 INFO - PROCESS | 12300 | Cycle 1(1): loaded http://localhost:48675/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48675/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:20:06 INFO - PROCESS | 12300 | RSS: Main: 160985088 17:20:06 INFO - PROCESS | 12300 | 17:20:09 INFO - PROCESS | 12300 | Cycle 1(1): loaded http://localhost:48675/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48675/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:20:09 INFO - PROCESS | 12300 | RSS: Main: 162840576 17:20:09 INFO - PROCESS | 12300 | 17:20:11 INFO - PROCESS | 12300 | Cycle 1(1): loaded http://localhost:48675/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48675/tests/kraken/driver.html?testName=ai-astar) 17:20:11 INFO - PROCESS | 12300 | RSS: Main: 162172928 17:20:11 INFO - PROCESS | 12300 | 17:20:11 INFO - PROCESS | 12300 | __start_tp_report 17:20:11 INFO - PROCESS | 12300 | _x_x_mozilla_page_load 17:20:11 INFO - PROCESS | 12300 | _x_x_mozilla_page_load_details 17:20:11 INFO - PROCESS | 12300 | |i|pagename|runs| 17:20:11 INFO - PROCESS | 12300 | |0;ai-astar;113;109;114;113;112;125;115;113;112;113 17:20:11 INFO - PROCESS | 12300 | |1;audio-beat-detection;158;139;150;172;134;161;156;132;166;130 17:20:11 INFO - PROCESS | 12300 | |2;audio-dft;164;163;162;161;165;162;165;176;167;165 17:20:11 INFO - PROCESS | 12300 | |3;audio-fft;74;74;74;74;73;160;74;74;74;74 17:20:11 INFO - PROCESS | 12300 | |4;audio-oscillator;97;96;143;95;96;98;143;96;97;143 17:20:11 INFO - PROCESS | 12300 | |5;imaging-gaussian-blur;121;116;116;117;116;115;116;116;116;115 17:20:11 INFO - PROCESS | 12300 | |6;imaging-darkroom;146;146;146;146;149;147;148;146;147;149 17:20:11 INFO - PROCESS | 12300 | |7;imaging-desaturate;97;97;97;97;97;96;98;97;97;97 17:20:11 INFO - PROCESS | 12300 | |8;json-parse-financial;59;58;58;58;56;63;58;56;55;57 17:20:11 INFO - PROCESS | 12300 | |9;json-stringify-tinderbox;67;68;68;70;71;68;68;67;67;68 17:20:11 INFO - PROCESS | 12300 | |10;stanford-crypto-aes;84;82;85;89;90;90;83;83;84;84 17:20:11 INFO - PROCESS | 12300 | |11;stanford-crypto-ccm;118;119;130;123;137;128;121;125;120;128 17:20:11 INFO - PROCESS | 12300 | |12;stanford-crypto-pbkdf2;148;151;144;164;151;141;153;152;152;142 17:20:11 INFO - PROCESS | 12300 | |13;stanford-crypto-sha256-iterative;69;70;78;70;71;70;74;70;76;70 17:20:11 INFO - PROCESS | 12300 | __end_tp_report 17:20:11 INFO - PROCESS | 12300 | __start_cc_report 17:20:11 INFO - PROCESS | 12300 | _x_x_mozilla_cycle_collect,783 17:20:11 INFO - PROCESS | 12300 | __end_cc_report 17:20:11 INFO - PROCESS | 12300 | __startTimestamp1455585611768__endTimestamp 17:20:11 INFO - PROCESS | 12300 | 17:20:11 INFO - PROCESS | 12300 | ------- Summary: start ------- 17:20:11 INFO - PROCESS | 12300 | Number of tests: 14 17:20:11 INFO - PROCESS | 12300 | 17:20:11 INFO - PROCESS | 12300 | [#0] ai-astar Cycles:10 Average:113.90 Median:113.00 stddev:4.20 (3.7%) stddev-sans-first:4.44 17:20:11 INFO - PROCESS | 12300 | Values: 113.0 109.0 114.0 113.0 112.0 125.0 115.0 113.0 112.0 113.0 17:20:11 INFO - PROCESS | 12300 | 17:20:11 INFO - PROCESS | 12300 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:157.00 stddev:15.13 (9.6%) stddev-sans-first:15.76 17:20:11 INFO - PROCESS | 12300 | Values: 158.0 139.0 150.0 172.0 134.0 161.0 156.0 132.0 166.0 130.0 17:20:11 INFO - PROCESS | 12300 | 17:20:11 INFO - PROCESS | 12300 | [#2] audio-dft Cycles:10 Average:165.00 Median:165.00 stddev:4.27 (2.6%) stddev-sans-first:4.51 17:20:11 INFO - PROCESS | 12300 | Values: 164.0 163.0 162.0 161.0 165.0 162.0 165.0 176.0 167.0 165.0 17:20:11 INFO - PROCESS | 12300 | 17:20:11 INFO - PROCESS | 12300 | [#3] audio-fft Cycles:10 Average:82.50 Median:74.00 stddev:27.23 (36.8%) stddev-sans-first:28.71 17:20:11 INFO - PROCESS | 12300 | Values: 74.0 74.0 74.0 74.0 73.0 160.0 74.0 74.0 74.0 74.0 17:20:11 INFO - PROCESS | 12300 | 17:20:11 INFO - PROCESS | 12300 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:96.00 stddev:22.51 (23.4%) stddev-sans-first:23.35 17:20:11 INFO - PROCESS | 12300 | Values: 97.0 96.0 143.0 95.0 96.0 98.0 143.0 96.0 97.0 143.0 17:20:11 INFO - PROCESS | 12300 | 17:20:11 INFO - PROCESS | 12300 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.00 stddev:1.71 (1.5%) stddev-sans-first:0.60 17:20:11 INFO - PROCESS | 12300 | Values: 121.0 116.0 116.0 117.0 116.0 115.0 116.0 116.0 116.0 115.0 17:20:11 INFO - PROCESS | 12300 | 17:20:11 INFO - PROCESS | 12300 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:1.25 (0.8%) stddev-sans-first:1.27 17:20:11 INFO - PROCESS | 12300 | Values: 146.0 146.0 146.0 146.0 149.0 147.0 148.0 146.0 147.0 149.0 17:20:11 INFO - PROCESS | 12300 | 17:20:11 INFO - PROCESS | 12300 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:97.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 17:20:11 INFO - PROCESS | 12300 | Values: 97.0 97.0 97.0 97.0 97.0 96.0 98.0 97.0 97.0 97.0 17:20:11 INFO - PROCESS | 12300 | 17:20:11 INFO - PROCESS | 12300 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:58.00 stddev:2.20 (3.8%) stddev-sans-first:2.29 17:20:11 INFO - PROCESS | 12300 | Values: 59.0 58.0 58.0 58.0 56.0 63.0 58.0 56.0 55.0 57.0 17:20:11 INFO - PROCESS | 12300 | 17:20:11 INFO - PROCESS | 12300 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:1.32 (1.9%) stddev-sans-first:1.32 17:20:11 INFO - PROCESS | 12300 | Values: 67.0 68.0 68.0 70.0 71.0 68.0 68.0 67.0 67.0 68.0 17:20:11 INFO - PROCESS | 12300 | 17:20:11 INFO - PROCESS | 12300 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:84.50 stddev:3.06 (3.6%) stddev-sans-first:3.21 17:20:11 INFO - PROCESS | 12300 | Values: 84.0 82.0 85.0 89.0 90.0 90.0 83.0 83.0 84.0 84.0 17:20:11 INFO - PROCESS | 12300 | 17:20:11 INFO - PROCESS | 12300 | [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:126.50 stddev:5.93 (4.7%) stddev-sans-first:5.74 17:20:11 INFO - PROCESS | 12300 | Values: 118.0 119.0 130.0 123.0 137.0 128.0 121.0 125.0 120.0 128.0 17:20:11 INFO - PROCESS | 12300 | 17:20:11 INFO - PROCESS | 12300 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.80 Median:151.50 stddev:6.66 (4.4%) stddev-sans-first:7.04 17:20:11 INFO - PROCESS | 12300 | Values: 148.0 151.0 144.0 164.0 151.0 141.0 153.0 152.0 152.0 142.0 17:20:11 INFO - PROCESS | 12300 | 17:20:11 INFO - PROCESS | 12300 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:70.50 stddev:3.08 (4.4%) stddev-sans-first:3.10 17:20:11 INFO - PROCESS | 12300 | Values: 69.0 70.0 78.0 70.0 71.0 70.0 74.0 70.0 76.0 70.0 17:20:11 INFO - PROCESS | 12300 | -------- Summary: end -------- 17:20:11 INFO - PROCESS | 12300 | 17:20:12 INFO - TEST-INFO | 12300: exit 0 17:20:12 INFO - TEST-OK | kraken | took 61760ms 17:20:12 INFO - SUITE-END | took 1174s 17:20:12 INFO - Completed test suite (00:19:34) 17:20:12 INFO - Working with test: dromaeo_css 17:20:12 INFO - Generating results file: dromaeo_css 17:20:12 INFO - Working with test: kraken 17:20:12 INFO - Generating results file: kraken 17:20:12 INFO - javascript benchmark 17:20:12 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:20:13 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 17:20:13 INFO - process_Request line: dromaeo_css 6895.82 graph.html#tests=[[72,64,43]] 17:20:13 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:20:13 INFO - process_Request line: kraken 1539.90 graph.html#tests=[[232,64,43]] 17:20:13 INFO - RETURN: dromaeo_css: 6895.82 17:20:13 INFO - RETURN: kraken: 1539.90 17:20:13 INFO - javascript benchmark 17:20:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3194.472911969525, 3210.0369889033286, 3241.0924941016524, 3264.6408895021546, 3268.82021488818, 5082.79668813247, 5383.515483606475, 5390.51485366317, 5397.433269506704, 5398.811041613544, 5369.62412631116, 5411.756470958807, 5424.9186262206, 5430.619856610039, 5438.809641662542, 4870.70775753455, 4875.8781030474165, 4931.778069986859, 5010.549050585447, 5079.161938280179, 4781.330613714083, 4890.951090489103, 4975.925361119586, 4977.328060711812, 4998.875028124289, 4826.662133650646, 4851.320815085873, 4864.854054378375, 4868.269759536062, 4913.582345500637, 4827.806887724487, 4840.9515904840855, 4850.175470170079, 4852.8544143675745, 4879.63402744792, 4767.1419144553965, 4841.298011788306, 4843.58829499493, 4896.387951506062, 4979.8008079676765, 5119.206522988943, 5125.974370128126, 5162.819301324435, 5175.870603234912, 5209.53114219722, 5662.320521537442, 5680.3467601225975, 5684.0, 5685.431456854323, 5688.573356998241, 5766.740496677659, 5797.449242321973, 5805.187273781674, 5817.883642327172, 5859.560532960045, 5363.6245462817615, 5426.484483974016, 5428.4300148484235, 5434.130539113723, 5447.319085114361, 5622.325320961429, 5847.502962248256, 5882.647041177543, 5897.115432685132, 5951.553633477506, 5521.254630624894, 5529.447055294519, 5539.279893613804, 5541.944580554224, 5577.609567330248, 5586.497215250647, 5605.747741351649, 5607.80372686954, 5622.91565626516, 5641.548676105984, 5516.089845175581, 5593.812375249501, 5614.0, 5764.942350576524, 5862.237909071793, 5662.490375866192, 5666.2350582670815, 5669.121286200645, 5672.716364181774, 5676.262085928803, 4363.38912552243, 4364.41080454141, 4369.497507786582, 4395.604395604347, 4418.6023257906945, 3854.113553882623, 3939.4484772131923, 3949.8025098744947, 3981.980090099531, 4010.979945100314, 5339.546138578265, 5349.625526213128, 5361.249425080492, 5365.0342938270705, 5378.7041712705395, 5484.972575137099, 5699.401562835926, 5700.885982280414, 5709.8287051388525, 5716.28546431696, 5288.2596436498925, 5320.388155362106, 5320.733963301819, 5349.331333583302, 5373.838784836461, 4733.290006499053, 4737.336772851803, 4750.883542367541, 4783.784729687172, 4792.688475249098, 5684.63049901755, 5785.450382213683, 5789.102689083199, 5804.4775970162045, 5823.359430462646, 5645.971770141123, 5671.602987790815, 5688.345840228261, 5696.829095127153, 5749.310082789924, 5828.6211396259105, 5838.12428135783, 5838.241028666246, 5904.468597826216, 5910.290765108214, 5369.973150134224, 5619.80330688424, 5655.915161272502, 5762.106873434456, 5852.7658893643775, 5716.256886604715, 5742.483176514133, 5765.279340082489, 5765.94234057654, 5767.826965191051, 5580.1629755537, 5612.017896868113, 5615.6630602164005, 5627.52166065889, 5630.7466164023535, 5363.436839131835, 5375.704336261543, 5389.75746091419, 5415.918761218663, 5417.864553386197, 5369.892602148013, 5575.8606034847835, 5606.131049687305, 5612.242347283228, 5633.577481688808, 5664.575156863334, 5689.203511508309, 5702.8289151325525, 5703.7433315500075, 5712.257406537124, 5399.460053994726, 5528.0, 5563.666180029049, 5564.777408903598, 5586.636868603528], "unit": "score", "name": "dojo.html", "value": 5260.797716693268}, {"lowerIsBetter": false, "replicates": [571.3458090486396, 572.1989215098862, 593.2762030323007, 595.3302534648519, 606.1513880567205, 35328.2934341313, 35730.46404303938, 35761.82119089401, 35774.105647358796, 35845.2830943381, 35815.10462238445, 36564.451533227024, 36573.63426365735, 36697.0, 36860.63139368605, 8142.633581488847, 8230.176982301751, 8283.130271321515, 8287.212714792115, 8330.6251218695, 8082.474639148437, 8366.414350995432, 8401.621927013299, 8411.915880841205, 8416.537090460022, 8265.95867020664, 8414.83170336596, 8449.155084491564, 8460.153984601522, 8463.492190468562, 8374.120717324655, 8410.243078122967, 8428.157184281585, 8436.325093992466, 8457.830843383097, 8446.704365347183, 8537.615807288686, 8582.313414926792, 8585.957070214608, 8604.870926936039, 37238.813805931066, 37816.24367512662, 37906.81046594777, 37941.24117517634, 37945.81027094847, 3015.9547606785914, 3236.9838150809096, 3250.772445928786, 3551.804650744208, 3975.8608448704445, 26671.333216669544, 27178.72821271782, 27226.31934201641, 27467.811158798468, 27931.0, 3826.540815102178, 3905.882823515299, 3952.3873799561115, 3988.441618173458, 4000.5199376074765, 203761.0, 203964.98017509966, 205352.0, 205448.0, 205772.0, 52531.21203181955, 54787.80848766005, 58552.707236463546, 60293.39706602878, 61523.07715384273, 54815.72592137093, 55338.72330638321, 55472.72263638656, 55687.72156139193, 55832.72083639556, 14977.475788347574, 15128.621784455476, 15222.771658425132, 15263.389464421522, 15275.770863437057, 12446.502139914483, 12615.053870959531, 12625.116241863165, 12636.178648387826, 12676.112672112864, 20265.29071482491, 20588.176472941213, 20741.377758666964, 20770.02684744947, 20773.792262077488, 8105.716299929474, 8245.299149572234, 8296.253337199681, 8312.584370781437, 8345.207205315486, 917.2982668258787, 972.4943029624698, 1004.7689031522791, 1102.1788767368362, 1132.326265871805, 28271.29321766972, 29118.85440572826, 29185.124446266647, 29301.85349073241, 29348.413031739245, 1056.5615269663158, 1067.2422579968309, 1080.2978064258295, 1087.7498175419698, 1117.5753213778873, 14934.25328733559, 15046.924765376103, 15054.096754194783, 15085.773713394308, 15174.696506069817, 345961.0, 356017.0, 358462.0, 359022.0, 359758.0, 55039.0, 55040.44959550353, 55224.09698787652, 55322.17016744752, 55441.168382474294, 1409.901306908527, 1410.6332353587936, 1417.7235439089484, 1436.5690292912293, 1440.7478691228994, 28587.857060714563, 29236.0, 29466.263343416587, 29692.554611681273, 29849.403011939205, 46067.76966115148, 47008.764956175, 47223.29165062458, 47288.29067564058, 47310.76344618255, 273493.0, 274512.0, 275033.0, 275548.0, 276159.0, 33161.0, 43688.0, 43711.34432983444, 44561.0, 44634.3304850434, 39117.0, 39287.41068883912, 39756.0, 40047.0, 40281.19437611173, 33384.66615333913, 33505.49741753827, 33861.49207761935, 34139.82930085334, 34370.82814585911, 33188.0, 34077.65922340745, 34522.30955380928, 34695.479567805996, 34920.0, 37562.24875502529, 38115.0, 38136.42795358016, 38465.0, 39012.2197556053, 29327.549236627754, 29631.407371852874, 31435.685643143275, 32536.51195232026, 34122.65877341294, 25916.35209119787, 25954.22137335883, 25990.0, 26082.73917260879, 26104.34739131537], "unit": "score", "name": "ext.html", "value": 18322.014180676844}, {"lowerIsBetter": false, "replicates": [357.49057592930075, 360.0781998084903, 367.05483380295726, 368.4510079980828, 375.86656736858396, 16055.598610034755, 16960.151992400362, 17241.48275551734, 17784.0, 18303.99999999998, 9545.0, 9834.164096051827, 9838.950805245982, 9868.0, 10039.29724919256, 4804.183288840897, 4828.203346447832, 4933.777979990909, 4951.108800415924, 4962.677425967318, 4813.518648135194, 4938.160512712848, 4945.950540494585, 4975.776090075955, 4984.501549845023, 4931.186354251544, 4962.578180854632, 5102.38771347437, 5360.061989151903, 5360.195970604402, 5301.0, 5316.229146773716, 5336.9733151334185, 5735.311762588474, 6196.566240363177, 5475.534579560742, 5499.532539734128, 5502.0, 5502.9174562381595, 5508.862278443071, 16333.83666163347, 19966.90016549908, 20280.391588252376, 20419.79580204209, 20517.281895133747, 1968.22255209193, 2041.7345745053196, 2061.4846288427893, 2100.203181525354, 2337.2754446121758, 8988.32587555936, 9919.640370768158, 10745.19411044167, 12059.879401206052, 12991.285479298635, 1800.621869407413, 1834.8990805505691, 1843.0876716025518, 1850.8982005989665, 1894.1003023563835, 58176.418235817524, 58604.0, 59963.1005534913, 61354.0, 61805.38194618041, 9418.717438476857, 9640.807183856283, 9662.56518456671, 9776.071273229032, 9832.115109640166, 12296.323702196287, 12399.628011159679, 12413.193142445713, 12416.0, 12494.125411221126, 7426.5915374654915, 7524.908888211179, 7536.057992750906, 7559.773206803805, 7569.091708994846, 7528.736494222676, 7546.924530754732, 7554.395648348119, 7569.810754731176, 7583.886241706379, 4032.91934161321, 4034.636882680573, 4044.9191016180102, 4051.1290072634524, 4061.431399604058, 1743.1894169211123, 1743.5815404302875, 1767.8939263644222, 1773.0957211822063, 1784.161444121261, 901.4591245252927, 943.698016634684, 949.9525023748785, 985.5959056786683, 988.3625061835077, 15882.76175857363, 16313.836861631231, 16449.6710065798, 16748.24632891523, 16828.831711682727, 892.8392889279992, 894.6510860764307, 896.0815164456484, 934.1499235695485, 975.6536429567543, 9315.534223288809, 9625.0, 9674.75813104678, 9707.271954603433, 9769.0, 368961.0, 377468.0, 378633.0, 381468.0, 520625.0, 62379.0, 67183.66408167928, 70595.2940470599, 74117.6294118526, 75745.6212718933, 1114.6990312615549, 1117.463617463622, 1207.7741092790825, 1226.1539537719123, 1251.0367017396554, 10263.224942673905, 14789.482368117064, 15091.2271932017, 15155.545333639568, 15278.77081843751, 30950.22624434407, 33980.32039359248, 34943.475847861795, 35744.463833042006, 35861.462078068325, 42449.0, 42483.0, 45365.0, 45751.313730293405, 45846.54153458423, 10255.94872025635, 10509.264351495322, 10735.516901739284, 10857.83713244286, 11026.724331891446, 8067.919320806717, 8849.867251991096, 8984.55077246122, 9149.405288656217, 12908.741825163632, 7804.219578042151, 7824.726134585262, 8121.5533145677555, 8124.187581241828, 8198.959005204935, 7976.453421549661, 8070.1122876484715, 8111.229433203836, 8120.796980075309, 8133.268005879263, 7790.844183116419, 7894.460580187038, 8048.114707382067, 8062.798430039296, 8228.670853166046, 10601.257911946399, 10657.57369705203, 10774.946125269324, 10811.297265677706, 11020.228583999044, 7235.204127546071, 7338.266173382619, 7562.697492100255, 7619.276168763959, 10288.2798204125], "unit": "score", "name": "jquery.html", "value": 7953.153369641182}, {"lowerIsBetter": false, "replicates": [1435.8994870359077, 1444.3933547909876, 1610.1385758619142, 1769.3984045424554, 1785.053921421647, 6596.142501474814, 7420.591867447289, 7773.650185741648, 7962.721304754335, 7965.920340796591, 7563.508371955819, 7630.732924347649, 7674.577898215596, 7728.0, 7734.5745983970855, 2302.9424264393397, 2325.6511523271474, 2327.7788610082016, 2331.0, 2341.5785158671433, 2305.804006659436, 2308.6306191009444, 2309.1917828759883, 2342.824288178385, 2350.7296660883962, 2026.0477575539546, 2273.8294627902974, 2284.3832165315357, 2300.723913130418, 2326.8254880883915, 2299.218265789623, 2300.493891343902, 2332.5917964356254, 2333.649952507129, 2338.649202619604, 2338.0647740903605, 2359.256834097271, 2370.383700237933, 2370.9051637934635, 2380.155044959032, 7725.6137193140685, 7744.419168562324, 7805.843883122306, 7810.960945195295, 7811.960940195319, 4741.336212930192, 4889.3888263967, 4916.606671466274, 4921.261810728383, 4934.753262336869, 3058.6023816903885, 3063.0351439296774, 3158.873645054195, 3161.4309424303615, 3187.123541026236, 970.5741817313075, 976.4483067067084, 1055.155875299757, 1083.1659622090947, 1913.722510236022, 10234.6417875374, 10333.689989300334, 10411.271211015232, 10460.947695261551, 10474.371537707686, 4354.194474022316, 4388.166248412791, 4447.132809102194, 4471.664625153061, 4498.212812757754, 8358.205970432798, 8408.075111737704, 8460.703875364332, 8493.193146651058, 8500.192481714228, 4734.95265047352, 4747.477777444478, 4762.9523704763205, 4774.641901857374, 4797.904041919142, 4388.626966707801, 4408.58118478744, 4429.601335879786, 4442.666799990014, 4451.577100175478, 3532.894013179609, 3540.451230059345, 3561.44797556374, 3607.909802254912, 3622.2574372253625, 1089.6077412131626, 1116.2744216259496, 1121.7532142928542, 1127.1321082766387, 1169.0355456748216, 1278.1691900264902, 1288.6327396691897, 1313.6453157647381, 1317.762802695524, 1323.2259128409987, 7174.390176835028, 7218.205997340288, 7286.089238845145, 7302.342789149002, 7314.780556583311, 1105.4196546812987, 1105.7346236903086, 1118.1557923767502, 1118.7370967822555, 1126.8535090438354, 5664.037113690682, 5731.426857314235, 5734.598578099493, 5777.94222057774, 5830.096335068071, 8888.244499217639, 9102.408343457653, 9288.953555232181, 9382.437053776795, 9411.811763764686, 9209.079092090737, 9235.76910577241, 9246.676366327147, 9277.257819374434, 9285.48929808867, 7251.202367739545, 7307.159676637149, 7383.372413344926, 7387.409007279405, 7403.22266162056, 7078.787636370917, 7134.714611415693, 7135.571865688075, 7139.892901606376, 7184.425245980414, 8256.380771442045, 8446.197611226924, 8492.405531612727, 8521.53131577769, 8524.806527086088, 8664.566771661266, 8726.258268047288, 8755.124487551195, 8773.692920747742, 8801.47191168532, 6482.611043337415, 6626.734930602722, 6661.83345416349, 6671.532992690465, 6673.0, 7479.850402992019, 7528.849423011399, 7566.432517561315, 7570.470067095251, 7573.2048134945035, 6326.652034137983, 6781.6270105144695, 6948.235694073749, 7134.32223938725, 7291.30732580404, 6685.0, 6701.061851340719, 6786.355296246848, 6831.316868313129, 6858.862822743617, 6547.803565893031, 6600.0, 6613.834654133685, 6617.2721000688925, 6625.536212465081, 6146.323904370605, 6247.2815626201755, 6277.089821975879, 6290.150829637941, 6313.589616674902, 6366.808995730135, 6380.330065343072, 6401.455876250571, 6476.028595710681, 6480.481561474976], "unit": "score", "name": "mootools.html", "value": 4511.7244339472645}, {"lowerIsBetter": false, "replicates": [327.1738859380066, 327.4694994109543, 330.57686161713013, 334.48322341981634, 337.4314280437463, 6278.874422511547, 6282.497400207983, 6305.779297724586, 6372.522060845437, 6510.5442619016685, 6300.05499175124, 6310.337414571472, 6328.892443822324, 6349.650769207692, 6364.045393191023, 4780.9760951195285, 4784.234522476405, 4786.736729479877, 4787.880302992418, 4800.351952486422, 4745.833895813647, 4771.355866957951, 4785.545373189541, 4791.496892826255, 4803.087413391444, 4652.860414187563, 4717.292406139072, 4733.124371991175, 4733.59764420023, 4736.526347365253, 4702.647301452388, 4710.693804902705, 4721.315409265671, 4723.763811809413, 4733.408323959505, 4077.3883917412327, 4084.1014976705374, 4089.161721847044, 4092.6112019358116, 4104.220198162339, 5982.790602328898, 5992.280926288873, 6002.729877155539, 6014.0, 6027.276726792769, 5364.436734142898, 5459.69971651559, 5468.7539060742365, 5512.448755124496, 5513.9448605513835, 6659.234188068337, 6673.499487538454, 6695.866082678319, 6697.866042679168, 6761.628110453923, 4477.731336119843, 4483.0, 4486.259767138418, 4489.079738653568, 4498.977505112486, 6816.4546836252985, 6901.240863505011, 6995.545289556214, 7001.509894307401, 7016.368526832559, 4524.8416305429155, 4566.315052742115, 4582.106489234634, 4585.72485650862, 4595.885102872455, 4602.171609110393, 4609.700369475973, 4621.1219868224925, 4623.791929363187, 4643.86068417948, 5429.212764149255, 5431.293931788842, 5431.34823821144, 5437.13005919051, 5439.945600544023, 6532.934670653328, 6721.059051732761, 6733.494987875929, 6745.156855393076, 6757.358050985148, 1534.6393597504577, 1587.7221486240094, 1588.1900230882334, 1614.8304428034887, 1616.2403670274953, 1055.8574592430077, 1062.5377960587016, 1071.3786004117594, 1071.5178169823455, 1085.0722632149398, 6267.6866156691985, 6291.307956124822, 6313.463355614732, 6323.20959880015, 6352.205974253218, 6730.966345168243, 6833.829154271084, 6838.897416538756, 6839.452843772586, 6844.589324640538, 6152.384761523901, 6297.960836462024, 6302.747890084345, 6304.716287767062, 6308.400701933309, 3668.486411902336, 3687.2994131115, 3703.759255648374, 3710.443433484999, 3719.0330514066536, 7059.7529086482755, 7121.750738724223, 7127.0, 7133.108361454818, 7136.143662760502, 6799.694013769392, 6949.339812717783, 7023.473239506955, 7053.506254562234, 7054.541454805421, 7125.82185445368, 7130.572165670076, 7133.286671332929, 7135.429165666734, 7141.607211603412, 6722.193336799615, 6722.193336799615, 6734.696938637871, 6736.0, 6759.966200168968, 6634.900476492953, 6681.198256209286, 6694.933050669431, 6720.663966801738, 6722.1261236039, 7071.540349877448, 7105.857882842418, 7128.465365097535, 7134.750283740044, 7135.179454362815, 4501.054778496552, 4502.887427814331, 4505.842295519641, 4516.796744146455, 4519.728816271035, 6535.738570457129, 6761.966190169018, 6799.524033317621, 6817.8636427270185, 6868.107146070979, 6713.597184168965, 6744.730210791709, 6755.4257888080065, 6786.491013174131, 6793.490488213502, 6659.300773418915, 6699.464042876656, 6755.8177318968, 6755.864882702417, 6758.594484330956, 6524.282328943717, 6641.800745977628, 6641.933580664131, 6647.966760166361, 6665.700043497957, 6738.090357801634, 6778.762743303961, 6782.626955517494, 6787.796366109024, 6793.966030169818, 6583.341665833378, 6587.110740050223, 6587.901181482186, 6590.275069742229, 6605.867882642417], "unit": "score", "name": "prototype.html", "value": 4967.953255828104}, {"lowerIsBetter": false, "replicates": [722.0829546475976, 726.654838951498, 744.9292317229863, 756.7313603670693, 812.6993012585336, 13253.536126235584, 13554.118982266158, 13615.25116118613, 13690.863091369083, 13739.931300343484, 12962.611121666365, 12971.481140754382, 13059.934700326508, 13066.673333166676, 13093.67265818355, 672.9831754206135, 817.5462618246886, 819.4345901328095, 830.5515021888173, 831.2975535672347, 819.5041999590252, 820.6307161777195, 821.1337039423406, 821.6795449774593, 822.9259366657, 866.9913300866974, 869.76516340588, 870.2515836380708, 870.6691457246237, 872.7250915961483, 860.1914200651368, 863.2360361080426, 865.5845194306705, 866.5970323799432, 870.3124531620012, 623.6476390839161, 629.1443636654146, 629.4177885455981, 631.8009826904511, 633.6388258692547, 13494.797578036338, 13495.59513214605, 13510.797338039938, 13642.317884105854, 13655.180689158682, 12781.233126012376, 12805.935970320183, 12905.2902090385, 13335.333233338295, 13611.727765444635, 10280.537375818107, 10313.587456501731, 10394.79210415795, 10398.168146548258, 10454.581816727321, 3547.6984456321243, 3636.0364503406618, 3640.0899775056237, 3650.908727281813, 3699.019759763638, 46850.531494685296, 46865.765671171765, 46912.530874691496, 46971.0, 46992.7650361746, 9299.0, 9500.382475139231, 9695.321327507148, 9852.507374631383, 9882.258830587734, 18577.25690972373, 18697.81302186988, 18713.90643046776, 18745.437636870916, 18763.90618046901, 7559.886601700869, 7610.124835643861, 7670.386369090459, 7702.268284512962, 7940.722074727357, 4271.67962402821, 4341.218580655449, 4409.625181859577, 4421.778911054499, 4511.932321015187, 3206.64726880043, 3254.2189874429964, 3258.234314935988, 3258.4297747894025, 3265.804051756902, 609.4819403506983, 624.753222477119, 627.6673363117555, 638.3903372279462, 644.1143427786793, 584.6550535184261, 651.840299126717, 659.8284446044063, 663.9900401493982, 668.5320275806857, 7983.880241796378, 8181.3863960203225, 8301.335893128657, 8352.457090289112, 8457.830843383097, 515.2734644151728, 641.5060403489288, 689.9344562266576, 701.1165930926967, 726.96728647211, 4079.1841631673783, 4253.361995700608, 4320.1143765527995, 4328.761918094472, 4522.954770452319, 51253.7437312811, 51557.0, 51657.0, 51801.48198518042, 52111.739441302554, 48222.0, 48223.27665085027, 48545.0, 48768.26847597289, 49632.0, 43500.56499435029, 43792.343114853305, 44172.55827441684, 44327.113457730666, 44681.55318446774, 8542.701005464778, 8639.827203456021, 8748.256398206224, 8848.380613357262, 8873.245774109273, 30383.0, 30444.238894027825, 30953.380932381675, 30961.380772383975, 31592.36815263728, 37262.44106338461, 37460.0, 37854.0, 40395.59604404036, 40418.39372409475, 10864.293820901616, 11073.833892491459, 11247.437628118398, 11350.262232954832, 11382.658520244406, 12051.33717645538, 12054.698632534257, 12150.0, 12170.417845680005, 12276.815847762113, 10374.0, 10521.736956576147, 10560.735981600521, 10708.89291107079, 10879.129669626569, 11699.649010529698, 11714.88285117138, 11898.940505297418, 12021.158518903592, 12413.565525206574, 10570.735731606464, 10584.841227381441, 10679.46602669848, 10961.232713709964, 11058.060064894575, 9363.719088427359, 9446.811063778548, 9585.664501742405, 9701.223902087675, 9706.272029597949, 8772.0, 9256.25949924018, 9547.665831695856, 9601.32790704672, 9676.70969870905], "unit": "score", "name": "yui.html", "value": 6257.452515595297}], "name": "dromaeo_css", "value": 6895.826259017566}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 109.0, 114.0, 113.0, 112.0, 125.0, 115.0, 113.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 113.9}, {"lowerIsBetter": true, "replicates": [158.0, 139.0, 150.0, 172.0, 134.0, 161.0, 156.0, 132.0, 166.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 149.8}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 162.0, 161.0, 165.0, 162.0, 165.0, 176.0, 167.0, 165.0], "unit": "score", "name": "audio-dft", "value": 165.0}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 74.0, 74.0, 73.0, 160.0, 74.0, 74.0, 74.0, 74.0], "unit": "score", "name": "audio-fft", "value": 82.5}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 143.0, 95.0, 96.0, 98.0, 143.0, 96.0, 97.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 110.4}, {"lowerIsBetter": true, "replicates": [121.0, 116.0, 116.0, 117.0, 116.0, 115.0, 116.0, 116.0, 116.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.4}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 149.0, 147.0, 148.0, 146.0, 147.0, 149.0], "unit": "score", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 97.0, 97.0, 97.0, 96.0, 98.0, 97.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 97.0}, {"lowerIsBetter": true, "replicates": [59.0, 58.0, 58.0, 58.0, 56.0, 63.0, 58.0, 56.0, 55.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 57.8}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 70.0, 71.0, 68.0, 68.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [84.0, 82.0, 85.0, 89.0, 90.0, 90.0, 83.0, 83.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.4}, {"lowerIsBetter": true, "replicates": [118.0, 119.0, 130.0, 123.0, 137.0, 128.0, 121.0, 125.0, 120.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.9}, {"lowerIsBetter": true, "replicates": [148.0, 151.0, 144.0, 164.0, 151.0, 141.0, 153.0, 152.0, 152.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.8}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 78.0, 70.0, 71.0, 70.0, 74.0, 70.0, 76.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.8}], "name": "kraken", "value": 1539.9}]} 17:20:13 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1539.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6895.82"}}} 17:20:13 INFO - Return code: 0 17:20:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:20:13 INFO - # TBPL SUCCESS # 17:20:13 INFO - Running post-action listener: _resource_record_post_action 17:20:13 INFO - Running post-run listener: _resource_record_post_run 17:20:14 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8192; Write bytes: 535113728; Read time: 440; Write time: 1045132 17:20:14 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 0; Write bytes: 239726592; Read time: 0; Write time: 572652 17:20:14 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 8192; Write bytes: 294645760; Read time: 440; Write time: 472440 17:20:14 INFO - Running post-run listener: _upload_blobber_files 17:20:14 INFO - Blob upload gear active. 17:20:14 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:20:14 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 17:20:14 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'] 17:20:14 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 17:20:14 INFO - (blobuploader) - INFO - Open directory for files ... 17:20:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:20:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:20:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:20:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:20:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:20:15 INFO - (blobuploader) - INFO - Done attempting. 17:20:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:20:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:20:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:20:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:20:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:20:16 INFO - (blobuploader) - INFO - Done attempting. 17:20:16 INFO - (blobuploader) - INFO - Iteration through files over. 17:20:16 INFO - Return code: 0 17:20:16 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:20:16 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:20:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b2d7ddffc9718d528b9a37b9909aa57613b3e9284bcd7e5ca6a9ba9d6705220facd2c7c01a7f8d05595467dd9ea59f1f4ab14ae255558bc8e49cda102479c4b5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce9f32da00525401536c02a3ebd5fe72b53dba8956190527c9430bdf9e1828afff3040752d0c888b5bf5e1fe623029683fef7d5296b7694ae60f41581ca9a38a"} 17:20:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:20:16 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:20:16 INFO - Contents: 17:20:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b2d7ddffc9718d528b9a37b9909aa57613b3e9284bcd7e5ca6a9ba9d6705220facd2c7c01a7f8d05595467dd9ea59f1f4ab14ae255558bc8e49cda102479c4b5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce9f32da00525401536c02a3ebd5fe72b53dba8956190527c9430bdf9e1828afff3040752d0c888b5bf5e1fe623029683fef7d5296b7694ae60f41581ca9a38a"} 17:20:16 INFO - Running post-run listener: copy_logs_to_upload_dir 17:20:16 INFO - Copying logs to upload dir... 17:20:16 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 17:20:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.633967 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-02-15 17:20:13.632978) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-15 17:20:13.636905) ========= 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=1861a34ebfea852630dec091000001fa-1455583826.755046-327662611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b2d7ddffc9718d528b9a37b9909aa57613b3e9284bcd7e5ca6a9ba9d6705220facd2c7c01a7f8d05595467dd9ea59f1f4ab14ae255558bc8e49cda102479c4b5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce9f32da00525401536c02a3ebd5fe72b53dba8956190527c9430bdf9e1828afff3040752d0c888b5bf5e1fe623029683fef7d5296b7694ae60f41581ca9a38a"} build_url:https://queue.taskcluster.net/v1/task/XQYnj-hQTTyWB6rqA1cY0A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011427 build_url: 'https://queue.taskcluster.net/v1/task/XQYnj-hQTTyWB6rqA1cY0A/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b2d7ddffc9718d528b9a37b9909aa57613b3e9284bcd7e5ca6a9ba9d6705220facd2c7c01a7f8d05595467dd9ea59f1f4ab14ae255558bc8e49cda102479c4b5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce9f32da00525401536c02a3ebd5fe72b53dba8956190527c9430bdf9e1828afff3040752d0c888b5bf5e1fe623029683fef7d5296b7694ae60f41581ca9a38a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-15 17:20:13.661915) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 17:20:13.662244) ========= 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=1861a34ebfea852630dec091000001fa-1455583826.755046-327662611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004427 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 17:20:13.745355) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-15 17:20:13.745684) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-15 17:20:13.746035) ========= ========= Total master_lag: 0.31 =========