builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-043 starttime: 1455076274.77 results: success (0) buildid: 20160209173022 builduid: d12e4d0cfaf74980b8c952bf87f644bd revision: 9c8bdf34b06654ef4c84854d2a49726c918febb9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-09 19:51:14.766946) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-09 19:51:14.767377) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-09 19:51:14.767669) ========= 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=d2a8c569965ab8367867b893000001a1-1455075974.272821-268906732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006433 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-09 19:51:14.801784) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-09 19:51:14.802063) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-09 19:51:15.668676) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 19:51:15.668987) ========= 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=d2a8c569965ab8367867b893000001a1-1455075974.272821-268906732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004722 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 19:51:15.717952) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-09 19:51:15.718256) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-09 19:51:15.718598) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 19:51:15.718867) ========= 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=d2a8c569965ab8367867b893000001a1-1455075974.272821-268906732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-09 19:51:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.3M=0s 2016-02-09 19:51:15 (37.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.133241 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 19:51:15.867104) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 19:51:15.867392) ========= 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=d2a8c569965ab8367867b893000001a1-1455075974.272821-268906732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022335 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 19:51:15.922979) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 19:51:15.923356) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9c8bdf34b06654ef4c84854d2a49726c918febb9 --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 9c8bdf34b06654ef4c84854d2a49726c918febb9 --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=d2a8c569965ab8367867b893000001a1-1455075974.272821-268906732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-09 19:51:16,057 truncating revision to first 12 chars 2016-02-09 19:51:16,057 Setting DEBUG logging. 2016-02-09 19:51:16,057 attempt 1/10 2016-02-09 19:51:16,057 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9c8bdf34b066?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-09 19:51:16,332 unpacking tar archive at: fx-team-9c8bdf34b066/testing/mozharness/ program finished with exit code 0 elapsedTime=0.541772 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 19:51:16.477672) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-09 19:51:16.478013) ========= echo 9c8bdf34b06654ef4c84854d2a49726c918febb9 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'9c8bdf34b06654ef4c84854d2a49726c918febb9'] 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=d2a8c569965ab8367867b893000001a1-1455075974.272821-268906732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 9c8bdf34b06654ef4c84854d2a49726c918febb9 program finished with exit code 0 elapsedTime=0.004654 script_repo_revision: '9c8bdf34b06654ef4c84854d2a49726c918febb9' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-09 19:51:16.528470) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-09 19:51:16.528752) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-09 19:51:16.543730) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-02-09 19:51:16.544012) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d2a8c569965ab8367867b893000001a1-1455075974.272821-268906732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:51:16 INFO - MultiFileLogger online at 20160209 19:51:16 in /builds/slave/test-pgo 19:51:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:51:16 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:51:16 INFO - {'append_to_log': False, 19:51:16 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:51:16 INFO - 'blob_upload_branch': 'Fx-Team', 19:51:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:51:16 INFO - 'branch': 'Fx-Team', 19:51:16 INFO - 'buildbot_json_path': 'buildprops.json', 19:51:16 INFO - 'config_files': ('talos/linux_config.py',), 19:51:16 INFO - 'default_actions': ('clobber', 19:51:16 INFO - 'read-buildbot-config', 19:51:16 INFO - 'download-and-extract', 19:51:16 INFO - 'populate-webroot', 19:51:16 INFO - 'create-virtualenv', 19:51:16 INFO - 'install', 19:51:16 INFO - 'run-tests'), 19:51:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:51:16 INFO - 'download_minidump_stackwalk': True, 19:51:16 INFO - 'download_symbols': 'ondemand', 19:51:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:51:16 INFO - 'tooltool.py': '/tools/tooltool.py', 19:51:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:51:16 INFO - '/tools/misc-python/virtualenv.py')}, 19:51:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:51:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:51:16 INFO - 'installer_path': 'installer.exe', 19:51:16 INFO - 'log_level': 'info', 19:51:16 INFO - 'log_name': 'talos', 19:51:16 INFO - 'log_to_console': True, 19:51:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:51:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:51:16 INFO - 'opt_config_files': (), 19:51:16 INFO - 'pip_index': False, 19:51:16 INFO - 'sps_profile': False, 19:51:16 INFO - 'sps_profile_interval': 0, 19:51:16 INFO - 'suite': 'dromaeojs', 19:51:16 INFO - 'system_bits': '32', 19:51:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:51:16 INFO - 'title': 'talos-linux64-ix-043', 19:51:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:51:16 INFO - 'use_talos_json': True, 19:51:16 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:51:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:51:16 INFO - 'work_dir': 'build'} 19:51:16 INFO - ##### 19:51:16 INFO - ##### Running clobber step. 19:51:16 INFO - ##### 19:51:16 INFO - Running pre-action listener: _resource_record_pre_action 19:51:16 INFO - Running main action method: clobber 19:51:16 INFO - rmtree: /builds/slave/test-pgo/build 19:51:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:51:17 INFO - Running post-action listener: _resource_record_post_action 19:51:17 INFO - ##### 19:51:17 INFO - ##### Running read-buildbot-config step. 19:51:17 INFO - ##### 19:51:17 INFO - Running pre-action listener: _resource_record_pre_action 19:51:17 INFO - Running main action method: read_buildbot_config 19:51:17 INFO - Using buildbot properties: 19:51:17 INFO - { 19:51:17 INFO - "project": "", 19:51:17 INFO - "product": "firefox", 19:51:17 INFO - "script_repo_revision": "production", 19:51:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:51:17 INFO - "repository": "", 19:51:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 19:51:17 INFO - "buildid": "20160209173022", 19:51:17 INFO - "pgo_build": "True", 19:51:17 INFO - "basedir": "/builds/slave/test-pgo", 19:51:17 INFO - "buildnumber": 636, 19:51:17 INFO - "slavename": "talos-linux64-ix-043", 19:51:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:51:17 INFO - "platform": "ubuntu64_hw", 19:51:17 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:51:17 INFO - "branch": "fx-team", 19:51:17 INFO - "repo_path": "integration/fx-team", 19:51:17 INFO - "revision": "9c8bdf34b06654ef4c84854d2a49726c918febb9", 19:51:17 INFO - "stage_platform": "linux64-pgo", 19:51:17 INFO - "builduid": "d12e4d0cfaf74980b8c952bf87f644bd", 19:51:17 INFO - "slavebuilddir": "test" 19:51:17 INFO - } 19:51:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/R9CiDnWySy2c-NmQUFELAA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 19:51:17 INFO - Running post-action listener: _resource_record_post_action 19:51:17 INFO - ##### 19:51:17 INFO - ##### Running download-and-extract step. 19:51:17 INFO - ##### 19:51:17 INFO - Running pre-action listener: _resource_record_pre_action 19:51:17 INFO - Running main action method: download_and_extract 19:51:17 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:51: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')]} 19:51:17 INFO - https://queue.taskcluster.net/v1/task/R9CiDnWySy2c-NmQUFELAA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:51:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9CiDnWySy2c-NmQUFELAA/artifacts/public/build/test_packages.json 19:51:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9CiDnWySy2c-NmQUFELAA/artifacts/public/build/test_packages.json 19:51:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9CiDnWySy2c-NmQUFELAA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:51:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9CiDnWySy2c-NmQUFELAA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:51:17 INFO - Downloaded 1448 bytes. 19:51:17 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:51:17 INFO - Using the following test package requirements: 19:51:17 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 19:51:17 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:17 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:51:17 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:17 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:51:17 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:17 INFO - u'jsshell-linux-x86_64.zip'], 19:51:17 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:17 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:51:17 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 19:51:17 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:17 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:51:17 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:17 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:51:17 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:17 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:51:17 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 19:51:17 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:51:17 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:51:17 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:51: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')]} 19:51:17 INFO - https://queue.taskcluster.net/v1/task/R9CiDnWySy2c-NmQUFELAA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:51:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9CiDnWySy2c-NmQUFELAA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:51:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9CiDnWySy2c-NmQUFELAA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:51:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9CiDnWySy2c-NmQUFELAA/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 19:51:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9CiDnWySy2c-NmQUFELAA/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 19:51:18 INFO - Downloaded 23289737 bytes. 19:51:18 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'] 19:51:18 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 19:51:20 INFO - Return code: 0 19:51:20 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 19:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:20 INFO - https://queue.taskcluster.net/v1/task/R9CiDnWySy2c-NmQUFELAA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:51:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9CiDnWySy2c-NmQUFELAA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:51:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9CiDnWySy2c-NmQUFELAA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:51:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9CiDnWySy2c-NmQUFELAA/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 19:51:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9CiDnWySy2c-NmQUFELAA/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 19:51:23 INFO - Downloaded 23289737 bytes. 19:51:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:51:23 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 19:51:24 INFO - Return code: 0 19:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:24 INFO - https://queue.taskcluster.net/v1/task/R9CiDnWySy2c-NmQUFELAA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:51:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9CiDnWySy2c-NmQUFELAA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 19:51:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9CiDnWySy2c-NmQUFELAA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 19:51:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9CiDnWySy2c-NmQUFELAA/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 19:51:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9CiDnWySy2c-NmQUFELAA/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 19:51:25 INFO - Downloaded 10706547 bytes. 19:51:25 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'] 19:51:25 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 19:51:26 INFO - Return code: 0 19:51:26 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')]} 19:51:26 INFO - https://queue.taskcluster.net/v1/task/R9CiDnWySy2c-NmQUFELAA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:51:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9CiDnWySy2c-NmQUFELAA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 19:51:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9CiDnWySy2c-NmQUFELAA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 19:51:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9CiDnWySy2c-NmQUFELAA/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 19:51:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R9CiDnWySy2c-NmQUFELAA/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 19:51:31 INFO - Downloaded 56500620 bytes. 19:51:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R9CiDnWySy2c-NmQUFELAA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 19:51:31 INFO - mkdir: /builds/slave/test-pgo/properties 19:51:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:51:31 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:51:31 INFO - Contents: 19:51:31 INFO - build_url:https://queue.taskcluster.net/v1/task/R9CiDnWySy2c-NmQUFELAA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 19:51:32 INFO - Running post-action listener: _resource_record_post_action 19:51:32 INFO - Running post-action listener: set_extra_try_arguments 19:51:32 INFO - ##### 19:51:32 INFO - ##### Running populate-webroot step. 19:51:32 INFO - ##### 19:51:32 INFO - Running pre-action listener: _resource_record_pre_action 19:51:32 INFO - Running main action method: populate_webroot 19:51:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:51:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:51:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:51:32 INFO - '--tppagecycles', 19:51:32 INFO - '7'], 19:51:32 INFO - 'tests': ['tsvgm']}}, 19:51:32 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:51:32 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:51:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:51:32 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:51:32 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:51:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:51:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:51:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:32 INFO - 'talos_options': ['--e10s'], 19:51:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:51:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:32 INFO - 'tests': ['damp', 'tps']}, 19:51:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:32 INFO - 'talos_options': ['--e10s'], 19:51:32 INFO - 'tests': ['damp', 'tps']}, 19:51:32 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:51:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:51:32 INFO - 'other': {'tests': ['a11yr', 19:51:32 INFO - 'ts_paint', 19:51:32 INFO - 'tpaint', 19:51:32 INFO - 'sessionrestore', 19:51:32 INFO - 'sessionrestore_no_auto_restore']}, 19:51:32 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:51:32 INFO - 'tests': ['a11yr', 19:51:32 INFO - 'ts_paint', 19:51:32 INFO - 'tpaint', 19:51:32 INFO - 'sessionrestore', 19:51:32 INFO - 'sessionrestore_no_auto_restore']}, 19:51:32 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:51:32 INFO - 'tests': ['a11yr', 19:51:32 INFO - 'ts_paint', 19:51:32 INFO - 'tpaint', 19:51:32 INFO - 'sessionrestore', 19:51:32 INFO - 'sessionrestore_no_auto_restore']}, 19:51:32 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:51:32 INFO - 'tests': ['a11yr', 19:51:32 INFO - 'ts_paint', 19:51:32 INFO - 'tpaint', 19:51:32 INFO - 'sessionrestore', 19:51:32 INFO - 'sessionrestore_no_auto_restore']}, 19:51:32 INFO - 'other_l64': {'tests': ['a11yr', 19:51:32 INFO - 'ts_paint', 19:51:32 INFO - 'tpaint', 19:51:32 INFO - 'sessionrestore', 19:51:32 INFO - 'sessionrestore_no_auto_restore']}, 19:51:32 INFO - 'other_nol64': {'tests': ['a11yr', 19:51:32 INFO - 'ts_paint', 19:51:32 INFO - 'tpaint', 19:51:32 INFO - 'sessionrestore', 19:51:32 INFO - 'sessionrestore_no_auto_restore']}, 19:51:32 INFO - 'svgr': {'tests': ['tsvgx', 19:51:32 INFO - 'tsvgr_opacity', 19:51:32 INFO - 'tart', 19:51:32 INFO - 'tscrollx', 19:51:32 INFO - 'cart']}, 19:51:32 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:51:32 INFO - 'tests': ['tsvgx', 19:51:32 INFO - 'tsvgr_opacity', 19:51:32 INFO - 'tart', 19:51:32 INFO - 'tscrollx', 19:51:32 INFO - 'cart']}, 19:51:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:32 INFO - 'tests': ['tp5o']}, 19:51:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:32 INFO - 'talos_options': ['--e10s'], 19:51:32 INFO - 'tests': ['tp5o']}, 19:51:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:32 INFO - 'talos_options': ['--xperf_path', 19:51:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:51:32 INFO - 'tests': ['tp5n']}, 19:51:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:32 INFO - 'talos_options': ['--e10s', 19:51:32 INFO - '--xperf_path', 19:51:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:51:32 INFO - 'tests': ['tp5n']}}, 19:51:32 INFO - 'talos.zip': {'path': '', 19:51:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:51:32 INFO - Running post-action listener: _resource_record_post_action 19:51:32 INFO - ##### 19:51:32 INFO - ##### Running create-virtualenv step. 19:51:32 INFO - ##### 19:51:32 INFO - Running pre-action listener: _resource_record_pre_action 19:51:32 INFO - Running main action method: create_virtualenv 19:51:32 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:51:32 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 19:51:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:51:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:51:32 INFO - Using real prefix '/usr' 19:51:32 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:51:32 INFO - Installing distribute.............................................................................................................................................................................................done. 19:51:34 INFO - Installing pip.................done. 19:51:34 INFO - Return code: 0 19:51:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:34 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 0x7f8a05655f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea7670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf368c0>, '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 0xf377c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf37c50>, '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': 'd2a8c569965ab8367867b893000001a1-1455075974.272821-268906732', '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 19:51:34 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 19:51:34 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 19:51:34 INFO - Using env: {'DISPLAY': ':0', 19:51:34 INFO - 'HOME': '/home/cltbld', 19:51:34 INFO - 'LANG': 'en_US.UTF-8', 19:51:34 INFO - 'LANGUAGE': 'en_US:en', 19:51:34 INFO - 'LOGNAME': 'cltbld', 19:51:34 INFO - 'MAIL': '/var/mail/cltbld', 19:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:34 INFO - 'MOZ_NO_REMOTE': '1', 19:51:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:34 INFO - 'NO_EM_RESTART': '1', 19:51:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:34 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:34 INFO - 'SHELL': '/bin/bash', 19:51:34 INFO - 'SHLVL': '1', 19:51:34 INFO - 'TERM': 'linux', 19:51:34 INFO - 'TMOUT': '86400', 19:51:34 INFO - 'USER': 'cltbld', 19:51:34 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1455075974.272821-268906732', 19:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:34 INFO - '_': '/tools/buildbot/bin/python'} 19:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:34 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 19:51:34 INFO - Cleaning up... 19:51:34 INFO - Return code: 0 19:51:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:34 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 0x7f8a05655f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea7670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf368c0>, '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 0xf377c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf37c50>, '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': 'd2a8c569965ab8367867b893000001a1-1455075974.272821-268906732', '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 19:51:34 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 19:51:34 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 19:51:34 INFO - Using env: {'DISPLAY': ':0', 19:51:34 INFO - 'HOME': '/home/cltbld', 19:51:34 INFO - 'LANG': 'en_US.UTF-8', 19:51:34 INFO - 'LANGUAGE': 'en_US:en', 19:51:34 INFO - 'LOGNAME': 'cltbld', 19:51:34 INFO - 'MAIL': '/var/mail/cltbld', 19:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:34 INFO - 'MOZ_NO_REMOTE': '1', 19:51:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:34 INFO - 'NO_EM_RESTART': '1', 19:51:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:34 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:34 INFO - 'SHELL': '/bin/bash', 19:51:34 INFO - 'SHLVL': '1', 19:51:34 INFO - 'TERM': 'linux', 19:51:34 INFO - 'TMOUT': '86400', 19:51:34 INFO - 'USER': 'cltbld', 19:51:34 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1455075974.272821-268906732', 19:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:34 INFO - '_': '/tools/buildbot/bin/python'} 19:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:35 INFO - Downloading/unpacking psutil>=0.7.1 19:51:35 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 19:51:35 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 19:51:35 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 19:51:35 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 19:51:35 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 19:51:35 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 19:51:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:51:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:51:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:51:36 INFO - Installing collected packages: psutil 19:51:36 INFO - Running setup.py install for psutil 19:51:37 INFO - building 'psutil._psutil_linux' extension 19:51:37 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 19:51:37 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 19:51:37 INFO - building 'psutil._psutil_posix' extension 19:51:37 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 19:51:37 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 19:51:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:51:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:51:37 INFO - Successfully installed psutil 19:51:37 INFO - Cleaning up... 19:51:37 INFO - Return code: 0 19:51:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:51: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')]} 19:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51: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')]} 19:51:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:37 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 0x7f8a05655f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea7670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf368c0>, '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 0xf377c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf37c50>, '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': 'd2a8c569965ab8367867b893000001a1-1455075974.272821-268906732', '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 19:51:37 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 19:51:37 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 19:51:37 INFO - Using env: {'DISPLAY': ':0', 19:51:37 INFO - 'HOME': '/home/cltbld', 19:51:37 INFO - 'LANG': 'en_US.UTF-8', 19:51:37 INFO - 'LANGUAGE': 'en_US:en', 19:51:37 INFO - 'LOGNAME': 'cltbld', 19:51:37 INFO - 'MAIL': '/var/mail/cltbld', 19:51:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:37 INFO - 'MOZ_NO_REMOTE': '1', 19:51:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:37 INFO - 'NO_EM_RESTART': '1', 19:51:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:37 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:37 INFO - 'SHELL': '/bin/bash', 19:51:37 INFO - 'SHLVL': '1', 19:51:37 INFO - 'TERM': 'linux', 19:51:37 INFO - 'TMOUT': '86400', 19:51:37 INFO - 'USER': 'cltbld', 19:51:37 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1455075974.272821-268906732', 19:51:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:37 INFO - '_': '/tools/buildbot/bin/python'} 19:51:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:51:37 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 19:51:37 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 19:51:37 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 19:51:37 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 19:51:37 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 19:51:37 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 19:51:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:51:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:51:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:51:39 INFO - Installing collected packages: mozsystemmonitor 19:51:39 INFO - Running setup.py install for mozsystemmonitor 19:51:39 INFO - Successfully installed mozsystemmonitor 19:51:39 INFO - Cleaning up... 19:51:39 INFO - Return code: 0 19:51:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:51:39 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')]} 19:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:39 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')]} 19:51:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:39 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 0x7f8a05655f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea7670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf368c0>, '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 0xf377c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf37c50>, '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': 'd2a8c569965ab8367867b893000001a1-1455075974.272821-268906732', '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 19:51:39 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 19:51:39 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 19:51:39 INFO - Using env: {'DISPLAY': ':0', 19:51:39 INFO - 'HOME': '/home/cltbld', 19:51:39 INFO - 'LANG': 'en_US.UTF-8', 19:51:39 INFO - 'LANGUAGE': 'en_US:en', 19:51:39 INFO - 'LOGNAME': 'cltbld', 19:51:39 INFO - 'MAIL': '/var/mail/cltbld', 19:51:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:39 INFO - 'MOZ_NO_REMOTE': '1', 19:51:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:39 INFO - 'NO_EM_RESTART': '1', 19:51:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:39 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:39 INFO - 'SHELL': '/bin/bash', 19:51:39 INFO - 'SHLVL': '1', 19:51:39 INFO - 'TERM': 'linux', 19:51:39 INFO - 'TMOUT': '86400', 19:51:39 INFO - 'USER': 'cltbld', 19:51:39 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1455075974.272821-268906732', 19:51:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:39 INFO - '_': '/tools/buildbot/bin/python'} 19:51:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:39 INFO - Downloading/unpacking blobuploader==1.2.4 19:51:39 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 19:51:39 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 19:51:39 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 19:51:39 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 19:51:39 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 19:51:39 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 19:51:41 INFO - Downloading blobuploader-1.2.4.tar.gz 19:51:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:51:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:51:41 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 19:51:41 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 19:51:41 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 19:51:41 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 19:51:41 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 19:51:41 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 19:51:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:51:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:42 INFO - Downloading docopt-0.6.1.tar.gz 19:51:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:51:42 INFO - Installing collected packages: blobuploader, requests, docopt 19:51:42 INFO - Running setup.py install for blobuploader 19:51:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:51:42 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:51:42 INFO - Running setup.py install for requests 19:51:42 INFO - Running setup.py install for docopt 19:51:42 INFO - Successfully installed blobuploader requests docopt 19:51:42 INFO - Cleaning up... 19:51:42 INFO - Return code: 0 19:51:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:51:42 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')]} 19:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:42 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')]} 19:51:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:42 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 0x7f8a05655f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea7670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf368c0>, '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 0xf377c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf37c50>, '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': 'd2a8c569965ab8367867b893000001a1-1455075974.272821-268906732', '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 19:51:42 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 19:51:42 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 19:51:42 INFO - Using env: {'DISPLAY': ':0', 19:51:42 INFO - 'HOME': '/home/cltbld', 19:51:42 INFO - 'LANG': 'en_US.UTF-8', 19:51:42 INFO - 'LANGUAGE': 'en_US:en', 19:51:42 INFO - 'LOGNAME': 'cltbld', 19:51:42 INFO - 'MAIL': '/var/mail/cltbld', 19:51:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:42 INFO - 'MOZ_NO_REMOTE': '1', 19:51:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:42 INFO - 'NO_EM_RESTART': '1', 19:51:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:42 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:42 INFO - 'SHELL': '/bin/bash', 19:51:42 INFO - 'SHLVL': '1', 19:51:42 INFO - 'TERM': 'linux', 19:51:42 INFO - 'TMOUT': '86400', 19:51:42 INFO - 'USER': 'cltbld', 19:51:42 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1455075974.272821-268906732', 19:51:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:42 INFO - '_': '/tools/buildbot/bin/python'} 19:51:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:51:43 INFO - Running setup.py (path:/tmp/pip-KaIc4D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:51:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:51:43 INFO - Running setup.py (path:/tmp/pip-77g1_c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:51:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:51:43 INFO - Running setup.py (path:/tmp/pip-tDE53j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:51:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:51:43 INFO - Running setup.py (path:/tmp/pip-DyAWdT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:51:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:51:43 INFO - Running setup.py (path:/tmp/pip-l9ci4i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:51:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:51:43 INFO - Running setup.py (path:/tmp/pip-jf87vO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:51:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:51:43 INFO - Running setup.py (path:/tmp/pip-XAB0Yj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:51:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:51:43 INFO - Running setup.py (path:/tmp/pip-NXhgEd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:51:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:51:43 INFO - Running setup.py (path:/tmp/pip-NZwqm9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:51:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:51:43 INFO - Running setup.py (path:/tmp/pip-e6S8Rb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:51:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:51:43 INFO - Running setup.py (path:/tmp/pip-BUX85a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:51:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:51:44 INFO - Running setup.py (path:/tmp/pip-LTsPk4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:51:44 INFO - Running setup.py (path:/tmp/pip-pZuArq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:51:44 INFO - Running setup.py (path:/tmp/pip-QM6TA2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:51:44 INFO - Running setup.py (path:/tmp/pip-H58gZx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:51:44 INFO - Running setup.py (path:/tmp/pip-Os9Ayu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:51:44 INFO - Running setup.py (path:/tmp/pip-Ijr7t7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:51:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:51:44 INFO - Running setup.py install for manifestparser 19:51:44 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:51:44 INFO - Running setup.py install for mozcrash 19:51:44 INFO - Running setup.py install for mozdebug 19:51:44 INFO - Running setup.py install for mozdevice 19:51:44 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:51:44 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:51:44 INFO - Running setup.py install for mozfile 19:51:44 INFO - Running setup.py install for mozhttpd 19:51:45 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:51:45 INFO - Running setup.py install for mozinfo 19:51:45 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:51:45 INFO - Running setup.py install for mozInstall 19:51:45 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:51:45 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:51:45 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:51:45 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:51:45 INFO - Running setup.py install for mozleak 19:51:45 INFO - Running setup.py install for mozlog 19:51:45 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:51:45 INFO - Running setup.py install for moznetwork 19:51:45 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:51:45 INFO - Running setup.py install for mozprocess 19:51:45 INFO - Running setup.py install for mozprofile 19:51:45 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:51:45 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:51:45 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:51:45 INFO - Running setup.py install for mozrunner 19:51:45 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:51:45 INFO - Running setup.py install for mozscreenshot 19:51:45 INFO - Running setup.py install for moztest 19:51:46 INFO - Running setup.py install for mozversion 19:51:46 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:51:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:51:46 INFO - Cleaning up... 19:51:46 INFO - Return code: 0 19:51:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:46 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 0x7f8a05655f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea7670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf368c0>, '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 0xf377c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf37c50>, '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': 'd2a8c569965ab8367867b893000001a1-1455075974.272821-268906732', '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 19:51:46 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 19:51:46 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 19:51:46 INFO - Using env: {'DISPLAY': ':0', 19:51:46 INFO - 'HOME': '/home/cltbld', 19:51:46 INFO - 'LANG': 'en_US.UTF-8', 19:51:46 INFO - 'LANGUAGE': 'en_US:en', 19:51:46 INFO - 'LOGNAME': 'cltbld', 19:51:46 INFO - 'MAIL': '/var/mail/cltbld', 19:51:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:46 INFO - 'MOZ_NO_REMOTE': '1', 19:51:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:46 INFO - 'NO_EM_RESTART': '1', 19:51:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:46 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:46 INFO - 'SHELL': '/bin/bash', 19:51:46 INFO - 'SHLVL': '1', 19:51:46 INFO - 'TERM': 'linux', 19:51:46 INFO - 'TMOUT': '86400', 19:51:46 INFO - 'USER': 'cltbld', 19:51:46 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1455075974.272821-268906732', 19:51:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:46 INFO - '_': '/tools/buildbot/bin/python'} 19:51:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:51:46 INFO - Running setup.py (path:/tmp/pip-KQFw67-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:51:46 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)) 19:51:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:51:46 INFO - Running setup.py (path:/tmp/pip-Wr9zuD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:51:46 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)) 19:51:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:51:46 INFO - Running setup.py (path:/tmp/pip-MQZMG_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:51:46 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)) 19:51:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:51:46 INFO - Running setup.py (path:/tmp/pip-orDX8X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:51:46 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)) 19:51:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:51:46 INFO - Running setup.py (path:/tmp/pip-agrxf_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:51:46 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)) 19:51:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:51:46 INFO - Running setup.py (path:/tmp/pip-PsFHPi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:51:46 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)) 19:51:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:51:46 INFO - Running setup.py (path:/tmp/pip-eg0rzs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:51:46 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)) 19:51:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:51:46 INFO - Running setup.py (path:/tmp/pip-PcDoYc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:51:46 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)) 19:51:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:51:46 INFO - Running setup.py (path:/tmp/pip-LO6o2X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:51:47 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)) 19:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:51:47 INFO - Running setup.py (path:/tmp/pip-JIf7fZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:51:47 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)) 19:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:51:47 INFO - Running setup.py (path:/tmp/pip-NorJuM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:51:47 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)) 19:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:51:47 INFO - Running setup.py (path:/tmp/pip-NOFyMR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:51:47 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)) 19:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:51:47 INFO - Running setup.py (path:/tmp/pip-3J7GH2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:51:47 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)) 19:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:51:47 INFO - Running setup.py (path:/tmp/pip-pMSH7k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:51:47 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)) 19:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:51:47 INFO - Running setup.py (path:/tmp/pip-wRXu2I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:51:47 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)) 19:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:51:47 INFO - Running setup.py (path:/tmp/pip-qgodT7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:51:47 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)) 19:51:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:51:47 INFO - Running setup.py (path:/tmp/pip-R7lS_r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:51:47 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)) 19:51:47 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)) 19:51:47 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)) 19:51:47 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)) 19:51:47 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)) 19:51:47 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)) 19:51:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:51:47 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 19:51:47 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 19:51:47 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 19:51:47 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 19:51:47 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 19:51:47 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 19:51:49 INFO - Downloading blessings-1.6.tar.gz 19:51:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:51:49 INFO - Installing collected packages: blessings 19:51:49 INFO - Running setup.py install for blessings 19:51:49 INFO - Successfully installed blessings 19:51:49 INFO - Cleaning up... 19:51:49 INFO - Return code: 0 19:51:49 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:51:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:51:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:51:49 INFO - Reading from file tmpfile_stdout 19:51:49 INFO - Current package versions: 19:51:49 INFO - argparse == 1.2.1 19:51:49 INFO - blessings == 1.6 19:51:49 INFO - blobuploader == 1.2.4 19:51:49 INFO - docopt == 0.6.1 19:51:49 INFO - manifestparser == 1.1 19:51:49 INFO - mozInstall == 1.12 19:51:49 INFO - mozcrash == 0.16 19:51:49 INFO - mozdebug == 0.1 19:51:49 INFO - mozdevice == 0.48 19:51:49 INFO - mozfile == 1.2 19:51:49 INFO - mozhttpd == 0.7 19:51:49 INFO - mozinfo == 0.9 19:51:49 INFO - mozleak == 0.1 19:51:49 INFO - mozlog == 3.1 19:51:49 INFO - moznetwork == 0.27 19:51:49 INFO - mozprocess == 0.22 19:51:49 INFO - mozprofile == 0.28 19:51:49 INFO - mozrunner == 6.11 19:51:49 INFO - mozscreenshot == 0.1 19:51:49 INFO - mozsystemmonitor == 0.0 19:51:49 INFO - moztest == 0.7 19:51:49 INFO - mozversion == 1.4 19:51:49 INFO - psutil == 3.1.1 19:51:49 INFO - requests == 1.2.3 19:51:49 INFO - wsgiref == 0.1.2 19:51:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:49 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 0x7f8a05655f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea7670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf368c0>, '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 0xf377c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf37c50>, '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': 'd2a8c569965ab8367867b893000001a1-1455075974.272821-268906732', '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 19:51:49 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 19:51:49 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 19:51:49 INFO - Using env: {'DISPLAY': ':0', 19:51:49 INFO - 'HOME': '/home/cltbld', 19:51:49 INFO - 'LANG': 'en_US.UTF-8', 19:51:49 INFO - 'LANGUAGE': 'en_US:en', 19:51:49 INFO - 'LOGNAME': 'cltbld', 19:51:49 INFO - 'MAIL': '/var/mail/cltbld', 19:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:49 INFO - 'MOZ_NO_REMOTE': '1', 19:51:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:49 INFO - 'NO_EM_RESTART': '1', 19:51:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:49 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:49 INFO - 'SHELL': '/bin/bash', 19:51:49 INFO - 'SHLVL': '1', 19:51:49 INFO - 'TERM': 'linux', 19:51:49 INFO - 'TMOUT': '86400', 19:51:49 INFO - 'USER': 'cltbld', 19:51:49 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1455075974.272821-268906732', 19:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:49 INFO - '_': '/tools/buildbot/bin/python'} 19:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:50 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)) 19:51:50 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)) 19:51:50 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)) 19:51:50 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)) 19:51:50 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)) 19:51:50 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)) 19:51:50 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)) 19:51:50 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)) 19:51:50 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)) 19:51:50 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)) 19:51:50 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)) 19:51:50 INFO - Cleaning up... 19:51:50 INFO - Return code: 0 19:51:50 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:51:50 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')]} 19:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:50 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')]} 19:51:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:50 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 0x7f8a05655f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea7670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf368c0>, '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 0xf377c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf37c50>, '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': 'd2a8c569965ab8367867b893000001a1-1455075974.272821-268906732', '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 19:51:50 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 19:51:50 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 19:51:50 INFO - Using env: {'DISPLAY': ':0', 19:51:50 INFO - 'HOME': '/home/cltbld', 19:51:50 INFO - 'LANG': 'en_US.UTF-8', 19:51:50 INFO - 'LANGUAGE': 'en_US:en', 19:51:50 INFO - 'LOGNAME': 'cltbld', 19:51:50 INFO - 'MAIL': '/var/mail/cltbld', 19:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:50 INFO - 'MOZ_NO_REMOTE': '1', 19:51:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:50 INFO - 'NO_EM_RESTART': '1', 19:51:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:50 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:50 INFO - 'SHELL': '/bin/bash', 19:51:50 INFO - 'SHLVL': '1', 19:51:50 INFO - 'TERM': 'linux', 19:51:50 INFO - 'TMOUT': '86400', 19:51:50 INFO - 'USER': 'cltbld', 19:51:50 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1455075974.272821-268906732', 19:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:50 INFO - '_': '/tools/buildbot/bin/python'} 19:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:50 INFO - Downloading/unpacking jsonschema 19:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:51:52 INFO - Downloading/unpacking functools32 (from jsonschema) 19:51:52 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 19:51:52 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 19:51:52 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 19:51:52 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 19:51:52 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 19:51:52 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 19:51:52 INFO - Downloading functools32-3.2.3-2.tar.gz 19:51:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:51:52 INFO - warning: no files found matching '*.txt' 19:51:52 INFO - no previously-included directories found matching 'build' 19:51:52 INFO - no previously-included directories found matching 'dist' 19:51:52 INFO - no previously-included directories found matching '.git*' 19:51:52 INFO - Installing collected packages: jsonschema, functools32 19:51:52 INFO - Running setup.py install for functools32 19:51:52 INFO - warning: no files found matching '*.txt' 19:51:52 INFO - no previously-included directories found matching 'build' 19:51:52 INFO - no previously-included directories found matching 'dist' 19:51:52 INFO - no previously-included directories found matching '.git*' 19:51:52 INFO - Successfully installed jsonschema functools32 19:51:52 INFO - Cleaning up... 19:51:52 INFO - Return code: 0 19:51:52 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:51:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:51:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:52 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 0x7f8a05655f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea7670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf368c0>, '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 0xf377c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf37c50>, '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': 'd2a8c569965ab8367867b893000001a1-1455075974.272821-268906732', '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 19:51:52 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 19:51:52 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 19:51:52 INFO - Using env: {'DISPLAY': ':0', 19:51:52 INFO - 'HOME': '/home/cltbld', 19:51:52 INFO - 'LANG': 'en_US.UTF-8', 19:51:52 INFO - 'LANGUAGE': 'en_US:en', 19:51:52 INFO - 'LOGNAME': 'cltbld', 19:51:52 INFO - 'MAIL': '/var/mail/cltbld', 19:51:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:52 INFO - 'MOZ_NO_REMOTE': '1', 19:51:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:51:52 INFO - 'NO_EM_RESTART': '1', 19:51:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:51:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:51:52 INFO - 'PWD': '/builds/slave/test-pgo', 19:51:52 INFO - 'SHELL': '/bin/bash', 19:51:52 INFO - 'SHLVL': '1', 19:51:52 INFO - 'TERM': 'linux', 19:51:52 INFO - 'TMOUT': '86400', 19:51:52 INFO - 'USER': 'cltbld', 19:51:52 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1455075974.272821-268906732', 19:51:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:52 INFO - '_': '/tools/buildbot/bin/python'} 19:51:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:52 INFO - Downloading/unpacking flake8 19:51:52 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 19:51:52 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 19:51:52 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 19:51:52 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 19:51:52 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 19:51:52 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 19:51:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:51:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:51:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:51:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:51:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:51:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:51:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:51:55 INFO - no previously-included directories found matching 'docs/_build' 19:51:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:51:55 INFO - Running setup.py install for pep8 19:51:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:51:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:51:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:51:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:51:55 INFO - no previously-included directories found matching 'docs/_build' 19:51:55 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:51:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:51:55 INFO - Cleaning up... 19:51:56 INFO - Return code: 0 19:51:56 INFO - Running post-action listener: _resource_record_post_action 19:51:56 INFO - Running post-action listener: _start_resource_monitoring 19:51:57 INFO - Starting resource monitoring. 19:51:57 INFO - ##### 19:51:57 INFO - ##### Running install step. 19:51:57 INFO - ##### 19:51:57 INFO - Running pre-action listener: _resource_record_pre_action 19:51:57 INFO - Running main action method: install 19:51:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:51:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:51:58 INFO - Reading from file tmpfile_stdout 19:51:58 INFO - Detecting whether we're running mozinstall >=1.0... 19:51:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:51:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:51:58 INFO - Reading from file tmpfile_stdout 19:51:58 INFO - Output received: 19:51:58 INFO - Usage: mozinstall [options] installer 19:51:58 INFO - Options: 19:51:58 INFO - -h, --help show this help message and exit 19:51:58 INFO - -d DEST, --destination=DEST 19:51:58 INFO - Directory to install application into. [default: 19:51:58 INFO - "/builds/slave/test-pgo"] 19:51:58 INFO - --app=APP Application being installed. [default: firefox] 19:51:58 INFO - mkdir: /builds/slave/test-pgo/build/application 19:51:58 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'] 19:51:58 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 19:52:14 INFO - Reading from file tmpfile_stdout 19:52:14 INFO - Output received: 19:52:14 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:52:14 INFO - Running post-action listener: _resource_record_post_action 19:52:14 INFO - ##### 19:52:14 INFO - ##### Running run-tests step. 19:52:14 INFO - ##### 19:52:14 INFO - Running pre-action listener: _resource_record_pre_action 19:52:14 INFO - Running main action method: run_tests 19:52:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:52:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:52:14 INFO - Python 2.7.3 19:52:14 INFO - Return code: 0 19:52:14 INFO - grabbing minidump binary from tooltool 19:52:14 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')]} 19:52:14 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 0xf368c0>, '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 0xf377c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf37c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:52:14 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 19:52:14 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 19:52:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:52:14 INFO - Return code: 0 19:52:14 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:52:14 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:52:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:52:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:52:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:52:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:52:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:52:15 INFO - Return code: 0 19:52:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R9CiDnWySy2c-NmQUFELAA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 19:52:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/R9CiDnWySy2c-NmQUFELAA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 19:52:15 INFO - Using env: {'DISPLAY': ':0', 19:52:15 INFO - 'HOME': '/home/cltbld', 19:52:15 INFO - 'LANG': 'en_US.UTF-8', 19:52:15 INFO - 'LANGUAGE': 'en_US:en', 19:52:15 INFO - 'LOGNAME': 'cltbld', 19:52:15 INFO - 'MAIL': '/var/mail/cltbld', 19:52:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:52:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:52:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:52:15 INFO - 'MOZ_NO_REMOTE': '1', 19:52:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:52:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:52:15 INFO - 'NO_EM_RESTART': '1', 19:52:15 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:52:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:52:15 INFO - 'PWD': '/builds/slave/test-pgo', 19:52:15 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:52:15 INFO - 'SHELL': '/bin/bash', 19:52:15 INFO - 'SHLVL': '1', 19:52:15 INFO - 'TERM': 'linux', 19:52:15 INFO - 'TMOUT': '86400', 19:52:15 INFO - 'USER': 'cltbld', 19:52:15 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1455075974.272821-268906732', 19:52:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:52:15 INFO - '_': '/tools/buildbot/bin/python'} 19:52:15 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R9CiDnWySy2c-NmQUFELAA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:52:15 INFO - mozversion application_buildid: 20160209173022 19:52:15 INFO - mozversion application_changeset: 9c8bdf34b06654ef4c84854d2a49726c918febb9 19:52:15 INFO - mozversion application_display_name: Nightly 19:52:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:52:15 INFO - mozversion application_name: Firefox 19:52:15 INFO - mozversion application_remotingname: firefox 19:52:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:52:15 INFO - mozversion application_vendor: Mozilla 19:52:15 INFO - mozversion application_version: 47.0a1 19:52:15 INFO - mozversion platform_buildid: 20160209173022 19:52:15 INFO - mozversion platform_changeset: 9c8bdf34b06654ef4c84854d2a49726c918febb9 19:52:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:52:15 INFO - mozversion platform_version: 47.0a1 19:52:15 INFO - using testdate: 1455076335 19:52:15 INFO - actual date: 1455076335 19:52:15 INFO - starting webserver on 'localhost:35243' 19:52:15 INFO - SUITE-START | Running 2 tests 19:52:15 INFO - TEST-START | dromaeo_css 19:52:15 INFO - operating with platform_type : linux_ 19:52:15 INFO - Initialising browser for dromaeo_css test... 19:52:15 INFO - TEST-INFO | started process 25668 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyMnEPk/profile http://localhost:35243/getInfo.html) 19:52:19 INFO - PROCESS | 25668 | __metrics Screen width/height:1600/1200 19:52:19 INFO - PROCESS | 25668 | colorDepth:24 19:52:19 INFO - PROCESS | 25668 | Browser inner width/height: 1024/697 19:52:19 INFO - PROCESS | 25668 | __metrics 19:52:19 INFO - PROCESS | 25668 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:52:21 INFO - TEST-INFO | 25668: exit 0 19:52:21 INFO - Browser initialized. 19:52:21 INFO - Running cycle 1/1 for dromaeo_css test... 19:52:21 INFO - TEST-INFO | started process 25763 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyMnEPk/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:52:32 INFO - PROCESS | 25763 | RSS: Main: 151695360 19:52:32 INFO - PROCESS | 25763 | 19:53:24 INFO - PROCESS | 25763 | 1455076404264 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] 19:55:32 INFO - PROCESS | 25763 | Cycle 1(1): loaded http://localhost:35243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35243/tests/dromaeo/cssquery-ext.html) 19:55:33 INFO - PROCESS | 25763 | RSS: Main: 264445952 19:55:33 INFO - PROCESS | 25763 | 19:58:36 INFO - PROCESS | 25763 | Cycle 1(1): loaded http://localhost:35243/tests/dromaeo/cssquery-ext.html (next: http://localhost:35243/tests/dromaeo/cssquery-jquery.html) 19:58:36 INFO - PROCESS | 25763 | RSS: Main: 230232064 19:58:36 INFO - PROCESS | 25763 | 20:01:38 INFO - PROCESS | 25763 | Cycle 1(1): loaded http://localhost:35243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35243/tests/dromaeo/cssquery-mootools.html) 20:01:39 INFO - PROCESS | 25763 | RSS: Main: 232255488 20:01:39 INFO - PROCESS | 25763 | 20:04:41 INFO - PROCESS | 25763 | Cycle 1(1): loaded http://localhost:35243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35243/tests/dromaeo/cssquery-prototype.html) 20:04:41 INFO - PROCESS | 25763 | RSS: Main: 213520384 20:04:41 INFO - PROCESS | 25763 | 20:07:44 INFO - PROCESS | 25763 | Cycle 1(1): loaded http://localhost:35243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35243/tests/dromaeo/cssquery-yui.html) 20:07:45 INFO - PROCESS | 25763 | RSS: Main: 213696512 20:07:45 INFO - PROCESS | 25763 | 20:10:47 INFO - PROCESS | 25763 | Cycle 1(1): loaded http://localhost:35243/tests/dromaeo/cssquery-yui.html (next: http://localhost:35243/tests/dromaeo/cssquery-dojo.html) 20:10:48 INFO - PROCESS | 25763 | RSS: Main: 269082624 20:10:48 INFO - PROCESS | 25763 | 20:10:48 INFO - PROCESS | 25763 | __start_tp_report 20:10:48 INFO - PROCESS | 25763 | _x_x_mozilla_page_load 20:10:48 INFO - PROCESS | 25763 | _x_x_mozilla_page_load_details 20:10:48 INFO - PROCESS | 25763 | |i|pagename|runs| 20:10:48 INFO - PROCESS | 25763 | |0;dojo.html;3155.1165673611386;3174.968250317499;3215.951760723588;3220.3237320162766;3250.6261779895312;5077.923831142536;5188.009492319759;5196.428392876785;5198.792048318072;5259.737013149342;5110.131277682794;5129.512696293846;5148.716820574867;5153.098207813627;5164.070467315891;4659.767011649421;4737.976310118444;4802.711837289757;4858.489858564835;4893.2170852663585;4655.371524844153;4698.154332220199;4836.984233311009;4840.467548569654;4962.702237865721;4685.4143232095985;4685.906281874343;4694.08465349257;4722.90554188916;4725.598324142435;4666.976665116653;4677.6491763117565;4698.130845793505;4726.692764970266;4727.57451829337;4583.610393116589;4670.6497012724185;4675.742834144121;4679.906401871944;4778.689385189951;4953.306537084811;4959.90080198394;4965.90068198634;5010.724410157476;5051.166557518005;5498.945010549924;5501.697406642633;5506.80726174586;5508.03609368359;5525.613207075507;5421.674699518042;5571.192177134293;5585.994520986221;5597.964376590303;5649.12438572022;5239.921401178947;5291.497307755795;5292.206169074631;5299.099153143936;5340.30576025122;5476.58925580583;5563.5271001964475;5733.627314224562;5755.424457554295;5755.769769209269;5536.474034966672;5547.639403438763;5569.805056822992;5571.526420254324;5627.634203776742;5583.804566840141;5596.2165296858475;5600.355959064678;5601.29983752031;5601.887962240814;5410.350757908997;5452.482014208644;5497.505224529811;5558.333000040021;5568.526675232651;5578.497935185853;5584.190292407578;5584.804531841447;5590.552755779528;5594.664320140723;4334.783260837009;4363.563643635611;4365.1051534436;4368.847090351823;4401.273789824707;3841.4814000110186;3881.7088718346236;3910.8240129194255;3922.9604154898975;3962.623550762673;5218.9562087582635;5239.266502689627;5250.606204534675;5251.448597897166;5305.8938821223355;5613.129964855454;5637.872425514914;5650.095984642519;5654.208410822488;5657.773689052474;5099.566536844335;5171.3535808024;5184.092783762826;5231.215317702375;5255.054090263713;4767.95232047682;4773.570378665937;4775.044991001813;4780.521947805191;4854.951450485521;5609.859753506195;5789.797357092566;5791.189233507313;5797.8550536236935;5799.333076696234;5515.531179849758;5579.525740311957;5642.971785141212;5660;5705.258316418839;5776.220210271559;5784.82645520635;5788.594798364074;5790.507806836466;5798.246227990503;5395.595330350318;5480.451954804487;5566.081596536526;5568.721563921868;5572.526335261548;5645.06856368711;5651.43485651448;5696.344920334214;5700.144978253295;5737.168110623853;5400.243965844864;5404.351477822686;5429.592780541396;5435.755391007493;5466.098093814476;5338.1458966566715;5386.4110087523495;5390.19147127934;5392.919106213331;5433.320834895638;5416.106342453609;5423.810166644149;5428.212909128233;5465.234867118686;5468.507834294933;5503.11950087984;5525.640833345819;5534.225208470898;5535.8892822144135;5550.333959924835;5259.132243179833;5360.865978350573;5435.537979271806;5438.83683489496;5439.347278326626 20:10:48 INFO - PROCESS | 25763 | |1;ext.html;518.1424742051905;538.647186093109;544.4174733035652;559.8544378461598;579.2672269578981;28191.859040704792;28874.422511549783;36248.2750344993;36969.63030369702;37055.25889482209;39630.60369396305;39998.60001399985;40026.39960400589;40068.198636027264;40078.799606002;8501.872471912926;8680.479171249714;8680.956595217047;8683.826323473526;8686.956565217197;8572.699955501559;8672.653093876237;8679.349048821332;8687.30501559877;8697.608607612672;8917.955410222972;8977.371583989123;8985.955070224672;8996.865047024266;9005.099490051009;8874.42316249445;8949.194572488475;8955.731328060168;8956.283497320264;8956.776080597972;8755.737327880173;8908.910910890938;8913.37606367548;8918.019017908025;8921.910780892238;40112.59887401118;40414.79792601018;40506.79746601248;40516.1896762066;40528.98677533085;3183.0769076967654;3283;3288.4574045282498;3305.752068594865;3365;30212.697873021207;30662.693373066206;30860.691393086006;30972.8451357744;32040.19899502508;3917.743237287886;3981.422693709425;4047.4535937648334;4091.9386209206887;4093.2222877653153;261301;261462;262362;262457;263014.9999999981;52383.73808131011;58247.41752582505;58651.70674146602;59945.10082348768;60984.69507652522;55242.44757552373;55259.44740552623;55537.444625553224;55564.16653750197;55602.443975560534;15430.691386172213;15612.3755049799;15618.531444056696;15627;15629.452969146025;11078.667639970814;11603.0137438317;11957.282563046245;12000.63998080059;12023.458944347525;19343.709844352346;19353.322633707754;19467.805321946882;19550;19613;7083;7146.678399471933;7187.96406017977;7233.602151881591;7256.7460138894885;990.6780296403698;996.6412091647002;996.9102780749768;1058.1270451877233;1076.3649446826253;24906.750932490442;26134.477310454065;27840.303992400353;27866.79920477137;27887.442251154862;1053.5522402978704;1114.409363037575;1124.2804605052772;1130.8869113088626;1199.4662375243108;13682.31588420575;13775.311234438439;13857.584272471842;14148.43406263738;14575.255638911502;342195;343135;345963;346951;347372;51780.22329665058;51966.22050669243;51982.74008629932;52040.73979630153;52133.7393313031;1185.887340702632;1274.7832868412206;1276.8020956751718;1350.723101764136;1370.9245991470566;22822.65766013478;29794;30082.54876176903;30429;30633;49720.751396242784;49804.25293620526;50086.24870626871;50104.749476252386;50243;252717;254314;257018;300235;312414;28673.13980580586;28687.856560717064;28714.569281461212;29016.854915725286;29082.563761544017;39272.80363598278;40044.59955400409;40440.39339409852;40443.1911361777;40871.1825763489;33384;34042.489362659086;35011.12472188114;35444.64555354517;37509.81245093757;31804.840975794974;32210;32522.512162318057;33943.151421214665;34560.308793824486;35805.82097089498;36224.818875905454;36584.08539786527;36607.81696091503;36691.63308366989;29964.70035299619;31041.379172416877;32403.51394729128;32497.187570310933;32678.50982235316;25111.24666260015;25422.872885635454;25540.872295638404;25812.483750325264;25998.09006684757 20:10:48 INFO - PROCESS | 25763 | |2;jquery.html;334.5143603649968;338.3419249559607;350.764987458403;352.36925902634283;353.84254006966876;13089.214647121156;13536;16164.676706465878;16267.75598366024;17656.646867062653;15028.797696184307;15083.245837708098;16673.082980436073;16985.3205871765;17016.914915425437;5131.948680513194;5258.421573626898;5349.491798279177;5383.111786555213;5387.326584176978;3903.668188204006;5378.085725426687;5608.186812912125;5810.651360918338;5816.476517113459;5568.805091821787;5732.0828667413225;5790.160426738142;5791.391903850098;5849.415058494138;5786.42135786418;5798.884022319551;5800.8839823203725;5812.970935145318;5821.068629019358;5033.572146367563;5170.948290517122;5171.689698618057;5171.896562068738;5173.430922598511;19544.70682939743;20021.299254526166;20023.699644505345;20058.39824805258;20117.195312187494;2204.2725900452974;2228.487447886995;2686.529857274969;2842.2894276430893;2952.936942700626;12408.255504669658;12800.103992720513;12863.099583029192;13017.153884997444;13203.40584673692;1780.813014633458;1840.917158727847;1864.580469394389;1872.410190789897;1907.8569107317007;56828;57932.71033644847;59194.70402648002;59641.40358596402;61961;9759.609615615438;10088.495575221357;10354.430506322075;10378.377297362182;10469.476526173661;13637.181769093886;13695.109817861807;13702.246376449391;13708.451661933412;13732.107413018122;7492.550446973199;7572.20491848348;7584.355329796918;7605.847883042419;7613.9238607614325;7338.41292696583;7341.082364704412;7384;7441.441891858132;7515.661795219228;4139;4418.491873434532;4462.888427789331;4481.686281960231;4508.301213311942;1687.4262750664832;1740.1647209339335;1791.641671665672;1792.1308165539704;1802.1619946724836;957.6887511558632;974.1427543761445;1085.2891356161726;1121.2431608664283;1127.520803658442;15698.450554230547;16084;16168.757468637745;16338.918305408397;16454.83545164557;947;974.512743628186;974.5711886769799;979.5560077606275;1028.753099256173;9417.858732119024;9796.314258001872;9822.26333025026;9824.852627210597;9838.9016109838;531870;536558;538956;539866;556311;75087.24912750912;75167.24832751602;77617;78605;78961.60519197368;1046.26238501856;1050.1074087025968;1118.0496577908712;1150.1948635954698;1150.7813515432042;14969.101853888802;15001.474948376754;15105.32026058852;15167.143652118944;15372.615684607974;31251.53122703207;31491.685083148874;31591.526127108573;31717.207069822514;31719;42759.57240427556;42860.571394286904;43085.56914430815;43154.352684710386;43230;7404.185539590749;7599.708049631466;7655.311022007823;7677.385809135368;7702.114256860533;10639.308444951053;10708.518116684612;11309.151813613847;11477.311361318347;11893.583724569598;7781.277635906674;8366.414350995372;9584.472853993097;10246.692599221737;10341.37951722899;9767.218622510325;10113.89886101159;10151.543180556744;10226.28416010872;10557.366558006544;6954.513184077066;8364.958175209329;10081.193504519768;10344.482775861328;10543.683689489328;5507.697076660662;6823;7256.23809500016;7501.362384197404;7586.089669239726;9806.558704858442;10338.689839304832;10515.78968420612;10546.367217966947;10550.103241224582 20:10:48 INFO - PROCESS | 25763 | |3;mootools.html;1378.9103708258956;1479.940802367905;1486.1751727791075;1679.8908070975385;1838.4668446150617;7096.112985876765;7758.806029849249;7895.210478952102;7909.525428474281;7922;7798.376129909608;7953.4432589718745;7957.641906114224;7967.3626109911065;7986;1988.3438465306415;2251.448395143192;2292.587334279829;2311.7225932888036;2343.742188359279;2307.0541078157958;2345.319857241398;2348.412896775806;2355.0108954239263;2355.9764402356013;2253.0874995626796;2331.3239160643393;2332.2303639798824;2334.253039027512;2334.673145759595;2326.8836558172106;2335.8948847301913;2337.322176568793;2340.9297721068397;2357.2456813819585;2255.2557655973487;2267.818574514035;2285.3600991722346;2312.1329501436962;2318.6637937499136;7840.333571646417;7841.098273698541;7843.960780196119;7846.882296765553;7850.9214907850765;4712.246040633517;4773.904521909577;4777.450593181759;4779.832705855279;4830.516948305177;3009.7893147479685;3087.9691203087905;3108.4715598348334;3116.3611459650715;3136.905892823219;971.2715463402449;1009.1170226052204;1009.1220638044874;1066.7013236293851;1073.3559864081567;11226.719332016764;11346.20576559641;11373.09015278784;11383;11409.48657310423;4351.651867850627;4390.8024138913825;4468.754218517947;4479.910401791946;4486.618637415856;9675.177609903238;9723.854142187873;9742;9746.220302375792;9746.415215087118;4954.959458513753;4956.231784073474;4964.131277026579;4964.528369804862;4967.031428871335;4458.621017213573;4482.8206871725415;4483.55164483549;4506.59440650343;4522.0277640307495;3483.7561370703806;3687.797171155612;3707.9247018364913;3749.1002159481527;3754.75594086389;1236.1532350340046;1249.6376050945305;1250.4060571228595;1250.9061820363509;1263.943122559487;1328.8471825740164;1329;1345.6770375109902;1353.0325817040864;1374.4090041282345;7512.436567257478;7524.548527088283;7684.923150768533;7686.192949740309;7715.151333353327;1137.5449820072038;1146;1150.8734039255676;1152.2107356460851;1156.2079975217002;5872.207252021008;5936.079907614327;5940.584159108907;5944.375840536768;5951.613145145551;9223.907760922439;9831.213502919749;9995.650152244636;10033.046860548237;10036.197104231644;9705.902940970642;9873.555689993824;9894.06006429388;9907.603695852229;9908.653197138066;7183.748568800067;7470.73852415152;7473.140588832245;7487.66305516253;7489.176190619028;7454.3663788576405;7483.850322993619;7516.135644400745;7529.736459223901;7545.170031296443;8326.375521836007;8914.598843051948;8974.326925480484;8985.146411090936;8986.370954033155;8692.826143477221;8721.040685524715;8851.998620779239;8965.686200982935;8965.775855603662;6796.796096117125;7763.767086987399;7878.448508604342;7881.684732610861;7883.684652614061;7497.475176737576;7663.386929045551;7685;7703.807404814925;7704.26809453101;7002.124734408199;7125.964370178116;7143.357097861218;7268.309510596485;7292.088488938883;7054.647267636495;7104.04095447108;7192.31672991065;7224.819379515554;7249;7104.431645468247;7151.60666163366;7186.029885965328;7353.926460735324;7359.337659610661;6738.225104112894;6762.560433571802;6768.187817461936;6772.966135169293;6778.017187507882;6653.833654158685;6673.566218195801;6720.361565651256;6794.252632210551;6799.082123913407 20:10:48 INFO - PROCESS | 25763 | |4;prototype.html;322.4212538493404;325.2908659123111;328.2335746033013;329.46626465126496;333.52639252261775;5838.095095260231;5910.438508341706;5943.673097979609;5949.107633854924;5969.432903874131;5736.598438109334;5861.7362218700155;5890.440408161228;5905.055191169414;5925.7925972590965;4563.361129441864;4565.726056436608;4576.656750743699;4582.564656357641;4583.083383323348;4363.498197707257;4405.713628614129;4456.754878481682;4477.3731677565165;4585.747783871886;4466.508684044752;4472.6645501587345;4478.0596074824325;4478.888027799315;4485.775711214426;4445.422095127645;4448.221561226773;4465.6650751193465;4472.105578884236;4473.731576105444;3920;3927.469791578129;3941.2708648900043;3941.7437866538585;3944.3097457944746;5523.088690366085;5654.802081927154;5679.772809087632;5691.715414229313;5747.310322761254;5160.612954028463;5164.122099243138;5164.741762911877;5212.400573934008;5214.478552144793;5980.401959804029;6241.375862413768;6245.188125543696;6246.531510136758;6249.437550620421;4191.7694526801015;4282.42187304713;4293;4294.506131794852;4304.053108316165;6462.579932304385;6507.251666058417;6519.282878883319;6521.64130972801;6528.347165283481;4292.3561465780385;4296.312589985588;4298.204832106007;4301.0537681709975;4301.096769678403;4352.434183556117;4357;4359.673024523174;4368.453943257093;4506.459224892968;5199.402068762065;5199.766010529535;5205.219217117463;5210.687358758487;5211;6335.303116657164;6363.5227357947415;6406.23125224976;6412.198475190601;6417.197850268716;1541.0984574024096;1576.7713681516116;1576.7950166478513;1577.7869987551762;1578.684263147375;1036.1710631494775;1046.8429735539578;1049.4437947887632;1056.6143357674393;1071.2287153249647;5990.73041713124;5994.460498555151;5999.820005399845;6007.3992600739575;6015.759369625253;6520.510961677893;6534.444572211415;6544.967275163689;6547.247066587308;6554.279029306773;6005;6006.759729610854;6009.969950150221;6013.819585412444;6019.69901504923;3427.7600567960503;3541;3543.6456354364873;3545.166885781839;3547.7161827053774;6851.9657401712675;6859.3140685932;6859.9314006859295;6860.656967151723;6864.519483636098;6701.229358623821;6707.966460167668;6711.664416779142;6712.228093769181;6712.798616041527;6697.732090716414;6829.248782633907;6834.111565496453;6848.1097457330225;6865.691043903136;6270.122182894307;6441.066045423481;6587.934120658923;6596.142501474969;6603.7688680895935;6461.515386346136;6479.287278399466;6483.513736469689;6493.837654058686;6494.253160886558;6844;6844.726210951705;6846.884667476187;6851.07510486078;6852.349026842442;4507.414036175407;4558.3618293438285;4562.8631141065825;4616.053708989716;4618.076384723136;6419.711112999833;6423.743050277936;6465.0948867157695;6507.9674601628585;6511.916186820172;6288.779892703734;6342.175517182736;6343.714532846126;6348.666779976256;6360.332165122781;6171.290301615371;6315.915747803306;6318.08387783778;6321;6335.873282534416;6203.503719702323;6205.627662340274;6212.06818977157;6218.502519798496;6221.96889015552;6296.905546416716;6329.49364050884;6331.556791024768;6333.936660633335;6391.96804015977;6145.201123853871;6212.254529456313;6216.7824126157175;6221.440070393686;6312.495000400048 20:10:48 INFO - PROCESS | 25763 | |5;yui.html;681.2574294019518;702.9543079699819;741.6699568691931;782.5226611766822;788.3259812860005;13437.865621343784;13737.450501979934;13741.03812733109;13753.724925501483;13754.518591849275;12940;13007.47970081198;13016.349182540858;13020.153690010142;13021.479140834355;657.1457105762513;668.1381018486147;809.5426084262373;823.6993497373445;825.1830687619243;827.4869580859845;832.6378025558871;833.1168960901433;833.3708050421923;834.2200042959852;680.1124532485105;842.7977285451509;858.0347109501811;859.8237361340941;859.9852174434166;863.223099210709;865.5196366016858;866.2593482572373;866.4108406283724;866.4194989357114;637.9776707815204;638.2436812377301;638.3265654734254;638.4605008767584;638.4636904999776;13271.004674649439;13302.534411295559;13325.466981320735;13325.466981320735;13327.466901323935;12880.484780608764;13295.73690499401;13327.733445331136;13365.131266467648;13540.390682419216;10664.306820056672;10691.83962240567;10769.353838769699;10804.405757683324;10945.781084378268;3645.8906232813056;3672.4307732301536;3705.9073523162137;3710.666040056408;3796.2787070456525;47630.76184619089;48434.757826211;48569;48641;48783.26825097591;9508.381955172892;9603.663871764455;9696.806063878825;9707.514624268759;9899.208063354914;19075.2369905205;19088.331908383418;19093.140808663367;19226.32707855218;19378.127984240742;7425.62871856405;7523.059617547807;7611.65747541362;7687.385009199251;7764.068311802507;4031.677465802729;4228.936565951513;4242.4272723181975;4288.807003684841;4312.633555656292;3075.1697041799034;3097.860596273128;3099.2097015260965;3112.346407254502;3132.9373412531622;530.5410819640982;549.4121290219507;554.0802268234711;555.6804837218615;559.815260963881;617.0990354083089;620.4818976154871;626.7117126121943;671.8219671786981;681.9770344483275;8518.23335899772;9018.639254429749;9043.683471078612;9051.14014168653;9251.90748092524;518.7769259218572;526.6813577785462;568.7412227436506;586.0564491169214;633.5944995203074;4095.460814295156;4197.307444271661;4457.888552786207;4550.635949124062;4657.4876763555985;57992;58345.124823127684;58590.4140958585;58619.12071318934;58765.70617146973;53393.46606533885;53945.460545394046;54472;54672.45327546753;55160;50445.747771260176;50465.74767126141;50670;50699.746501268;51264.23103653448;8797.428167169113;9011.63953441855;9040.502772347583;9086.909130908607;9140.314476414163;31970.20074498156;32080;33201.50197747084;33256.33487330288;33454.4981825268;40693.59306407016;42147.7892610535;42428.151436971704;42653.36019959641;43521.34717979296;11160.015067705559;11378.658640240807;11538.82691759641;11602.751239599656;11761.529538818351;11580;11600.593979210687;11944.402779861146;12440.937795310965;12605.180663256859;11532.538698452303;11545.595904143314;11810.544987095529;11894.762104758029;11901.285922844658;11212.719682008015;11364.602238921598;11429.942850286028;11712.70718232051;12027.398630068637;10937.945310273397;11138.888611113785;11297.43512824372;11433.542658293907;11575;9044.432561556372;9413.85879211826;9421.434713917188;9630.48018768021;9854.359466634645;8848.734537963872;9224.262059035127;9249.30630202724;9588.37675551087;10201.183905287708 20:10:48 INFO - PROCESS | 25763 | __end_tp_report 20:10:48 INFO - PROCESS | 25763 | __start_cc_report 20:10:48 INFO - PROCESS | 25763 | _x_x_mozilla_cycle_collect,878 20:10:48 INFO - PROCESS | 25763 | __end_cc_report 20:10:48 INFO - PROCESS | 25763 | __startTimestamp1455077448108__endTimestamp 20:10:48 INFO - PROCESS | 25763 | 20:10:48 INFO - PROCESS | 25763 | ------- Summary: start ------- 20:10:48 INFO - PROCESS | 25763 | Number of tests: 6 20:10:48 INFO - PROCESS | 25763 | 20:10:48 INFO - PROCESS | 25763 | [#0] dojo.html Cycles:165 Average:5186.26 Median:5400.24 stddev:562.85 (10.4%) stddev-sans-first:541.56 20:10:48 INFO - PROCESS | 25763 | Values: 3155.1 3175.0 3216.0 3220.3 3250.6 5077.9 5188.0 5196.4 5198.8 5259.7 5110.1 5129.5 5148.7 5153.1 5164.1 4659.8 4738.0 4802.7 4858.5 4893.2 4655.4 4698.2 4837.0 4840.5 4962.7 4685.4 4685.9 4694.1 4722.9 4725.6 4667.0 4677.6 4698.1 4726.7 4727.6 4583.6 4670.6 4675.7 4679.9 4778.7 4953.3 4959.9 4965.9 5010.7 5051.2 5498.9 5501.7 5506.8 5508.0 5525.6 5421.7 5571.2 5586.0 5598.0 5649.1 5239.9 5291.5 5292.2 5299.1 5340.3 5476.6 5563.5 5733.6 5755.4 5755.8 5536.5 5547.6 5569.8 5571.5 5627.6 5583.8 5596.2 5600.4 5601.3 5601.9 5410.4 5452.5 5497.5 5558.3 5568.5 5578.5 5584.2 5584.8 5590.6 5594.7 4334.8 4363.6 4365.1 4368.8 4401.3 3841.5 3881.7 3910.8 3923.0 3962.6 5219.0 5239.3 5250.6 5251.4 5305.9 5613.1 5637.9 5650.1 5654.2 5657.8 5099.6 5171.4 5184.1 5231.2 5255.1 4768.0 4773.6 4775.0 4780.5 4855.0 5609.9 5789.8 5791.2 5797.9 5799.3 5515.5 5579.5 5643.0 5660.0 5705.3 5776.2 5784.8 5788.6 5790.5 5798.2 5395.6 5480.5 5566.1 5568.7 5572.5 5645.1 5651.4 5696.3 5700.1 5737.2 5400.2 5404.4 5429.6 5435.8 5466.1 5338.1 5386.4 5390.2 5392.9 5433.3 5416.1 5423.8 5428.2 5465.2 5468.5 5503.1 5525.6 5534.2 5535.9 5550.3 5259.1 5360.9 5435.5 5438.8 5439.3 20:10:48 INFO - PROCESS | 25763 | 20:10:48 INFO - PROCESS | 25763 | [#1] ext.html Cycles:180 Average:45908.42 Median:191191.56 stddev:77701.32 (40.6%) stddev-sans-first:77844.55 20:10:48 INFO - PROCESS | 25763 | Values: 518.1 538.6 544.4 559.9 579.3 28191.9 28874.4 36248.3 36969.6 37055.3 39630.6 39998.6 40026.4 40068.2 40078.8 8501.9 8680.5 8681.0 8683.8 8687.0 8572.7 8672.7 8679.3 8687.3 8697.6 8918.0 8977.4 8986.0 8996.9 9005.1 8874.4 8949.2 8955.7 8956.3 8956.8 8755.7 8908.9 8913.4 8918.0 8921.9 40112.6 40414.8 40506.8 40516.2 40529.0 3183.1 3283.0 3288.5 3305.8 3365.0 30212.7 30662.7 30860.7 30972.8 32040.2 3917.7 3981.4 4047.5 4091.9 4093.2 261301.0 261462.0 262362.0 262457.0 263015.0 52383.7 58247.4 58651.7 59945.1 60984.7 55242.4 55259.4 55537.4 55564.2 55602.4 15430.7 15612.4 15618.5 15627.0 15629.5 11078.7 11603.0 11957.3 12000.6 12023.5 19343.7 19353.3 19467.8 19550.0 19613.0 7083.0 7146.7 7188.0 7233.6 7256.7 990.7 996.6 996.9 1058.1 1076.4 24906.8 26134.5 27840.3 27866.8 27887.4 1053.6 1114.4 1124.3 1130.9 1199.5 13682.3 13775.3 13857.6 14148.4 14575.3 342195.0 343135.0 345963.0 346951.0 347372.0 51780.2 51966.2 51982.7 52040.7 52133.7 1185.9 1274.8 1276.8 1350.7 1370.9 22822.7 29794.0 30082.5 30429.0 30633.0 49720.8 49804.3 50086.2 50104.7 50243.0 252717.0 254314.0 257018.0 300235.0 312414.0 28673.1 28687.9 28714.6 29016.9 29082.6 39272.8 40044.6 40440.4 40443.2 40871.2 33384.0 34042.5 35011.1 35444.6 37509.8 31804.8 32210.0 32522.5 33943.2 34560.3 35805.8 36224.8 36584.1 36607.8 36691.6 29964.7 31041.4 32403.5 32497.2 32678.5 25111.2 25422.9 25540.9 25812.5 25998.1 20:10:48 INFO - PROCESS | 25763 | 20:10:48 INFO - PROCESS | 25763 | [#2] jquery.html Cycles:180 Average:27829.43 Median:2128.76 stddev:88390.59 (4152.2%) stddev-sans-first:88614.44 20:10:48 INFO - PROCESS | 25763 | Values: 334.5 338.3 350.8 352.4 353.8 13089.2 13536.0 16164.7 16267.8 17656.6 15028.8 15083.2 16673.1 16985.3 17016.9 5131.9 5258.4 5349.5 5383.1 5387.3 3903.7 5378.1 5608.2 5810.7 5816.5 5568.8 5732.1 5790.2 5791.4 5849.4 5786.4 5798.9 5800.9 5813.0 5821.1 5033.6 5170.9 5171.7 5171.9 5173.4 19544.7 20021.3 20023.7 20058.4 20117.2 2204.3 2228.5 2686.5 2842.3 2952.9 12408.3 12800.1 12863.1 13017.2 13203.4 1780.8 1840.9 1864.6 1872.4 1907.9 56828.0 57932.7 59194.7 59641.4 61961.0 9759.6 10088.5 10354.4 10378.4 10469.5 13637.2 13695.1 13702.2 13708.5 13732.1 7492.6 7572.2 7584.4 7605.8 7613.9 7338.4 7341.1 7384.0 7441.4 7515.7 4139.0 4418.5 4462.9 4481.7 4508.3 1687.4 1740.2 1791.6 1792.1 1802.2 957.7 974.1 1085.3 1121.2 1127.5 15698.5 16084.0 16168.8 16338.9 16454.8 947.0 974.5 974.6 979.6 1028.8 9417.9 9796.3 9822.3 9824.9 9838.9 531870.0 536558.0 538956.0 539866.0 556311.0 75087.2 75167.2 77617.0 78605.0 78961.6 1046.3 1050.1 1118.0 1150.2 1150.8 14969.1 15001.5 15105.3 15167.1 15372.6 31251.5 31491.7 31591.5 31717.2 31719.0 42759.6 42860.6 43085.6 43154.4 43230.0 7404.2 7599.7 7655.3 7677.4 7702.1 10639.3 10708.5 11309.2 11477.3 11893.6 7781.3 8366.4 9584.5 10246.7 10341.4 9767.2 10113.9 10151.5 10226.3 10557.4 6954.5 8365.0 10081.2 10344.5 10543.7 5507.7 6823.0 7256.2 7501.4 7586.1 9806.6 10338.7 10515.8 10546.4 10550.1 20:10:48 INFO - PROCESS | 25763 | 20:10:48 INFO - PROCESS | 25763 | [#3] mootools.html Cycles:180 Average:5668.13 Median:6302.72 stddev:2961.82 (47.0%) stddev-sans-first:2952.58 20:10:48 INFO - PROCESS | 25763 | Values: 1378.9 1479.9 1486.2 1679.9 1838.5 7096.1 7758.8 7895.2 7909.5 7922.0 7798.4 7953.4 7957.6 7967.4 7986.0 1988.3 2251.4 2292.6 2311.7 2343.7 2307.1 2345.3 2348.4 2355.0 2356.0 2253.1 2331.3 2332.2 2334.3 2334.7 2326.9 2335.9 2337.3 2340.9 2357.2 2255.3 2267.8 2285.4 2312.1 2318.7 7840.3 7841.1 7844.0 7846.9 7850.9 4712.2 4773.9 4777.5 4779.8 4830.5 3009.8 3088.0 3108.5 3116.4 3136.9 971.3 1009.1 1009.1 1066.7 1073.4 11226.7 11346.2 11373.1 11383.0 11409.5 4351.7 4390.8 4468.8 4479.9 4486.6 9675.2 9723.9 9742.0 9746.2 9746.4 4955.0 4956.2 4964.1 4964.5 4967.0 4458.6 4482.8 4483.6 4506.6 4522.0 3483.8 3687.8 3707.9 3749.1 3754.8 1236.2 1249.6 1250.4 1250.9 1263.9 1328.8 1329.0 1345.7 1353.0 1374.4 7512.4 7524.5 7684.9 7686.2 7715.2 1137.5 1146.0 1150.9 1152.2 1156.2 5872.2 5936.1 5940.6 5944.4 5951.6 9223.9 9831.2 9995.7 10033.0 10036.2 9705.9 9873.6 9894.1 9907.6 9908.7 7183.7 7470.7 7473.1 7487.7 7489.2 7454.4 7483.9 7516.1 7529.7 7545.2 8326.4 8914.6 8974.3 8985.1 8986.4 8692.8 8721.0 8852.0 8965.7 8965.8 6796.8 7763.8 7878.4 7881.7 7883.7 7497.5 7663.4 7685.0 7703.8 7704.3 7002.1 7126.0 7143.4 7268.3 7292.1 7054.6 7104.0 7192.3 7224.8 7249.0 7104.4 7151.6 7186.0 7353.9 7359.3 6738.2 6762.6 6768.2 6773.0 6778.0 6653.8 6673.6 6720.4 6794.3 6799.1 20:10:48 INFO - PROCESS | 25763 | 20:10:48 INFO - PROCESS | 25763 | [#4] prototype.html Cycles:180 Average:5262.81 Median:5985.57 stddev:1609.30 (26.9%) stddev-sans-first:1570.51 20:10:48 INFO - PROCESS | 25763 | Values: 322.4 325.3 328.2 329.5 333.5 5838.1 5910.4 5943.7 5949.1 5969.4 5736.6 5861.7 5890.4 5905.1 5925.8 4563.4 4565.7 4576.7 4582.6 4583.1 4363.5 4405.7 4456.8 4477.4 4585.7 4466.5 4472.7 4478.1 4478.9 4485.8 4445.4 4448.2 4465.7 4472.1 4473.7 3920.0 3927.5 3941.3 3941.7 3944.3 5523.1 5654.8 5679.8 5691.7 5747.3 5160.6 5164.1 5164.7 5212.4 5214.5 5980.4 6241.4 6245.2 6246.5 6249.4 4191.8 4282.4 4293.0 4294.5 4304.1 6462.6 6507.3 6519.3 6521.6 6528.3 4292.4 4296.3 4298.2 4301.1 4301.1 4352.4 4357.0 4359.7 4368.5 4506.5 5199.4 5199.8 5205.2 5210.7 5211.0 6335.3 6363.5 6406.2 6412.2 6417.2 1541.1 1576.8 1576.8 1577.8 1578.7 1036.2 1046.8 1049.4 1056.6 1071.2 5990.7 5994.5 5999.8 6007.4 6015.8 6520.5 6534.4 6545.0 6547.2 6554.3 6005.0 6006.8 6010.0 6013.8 6019.7 3427.8 3541.0 3543.6 3545.2 3547.7 6852.0 6859.3 6859.9 6860.7 6864.5 6701.2 6708.0 6711.7 6712.2 6712.8 6697.7 6829.2 6834.1 6848.1 6865.7 6270.1 6441.1 6587.9 6596.1 6603.8 6461.5 6479.3 6483.5 6493.8 6494.3 6844.0 6844.7 6846.9 6851.1 6852.3 4507.4 4558.4 4562.9 4616.1 4618.1 6419.7 6423.7 6465.1 6508.0 6511.9 6288.8 6342.2 6343.7 6348.7 6360.3 6171.3 6315.9 6318.1 6321.0 6335.9 6203.5 6205.6 6212.1 6218.5 6222.0 6296.9 6329.5 6331.6 6333.9 6392.0 6145.2 6212.3 6216.8 6221.4 6312.5 20:10:48 INFO - PROCESS | 25763 | 20:10:48 INFO - PROCESS | 25763 | [#5] yui.html Cycles:180 Average:14008.68 Median:49614.51 stddev:16300.38 (32.9%) stddev-sans-first:16315.38 20:10:48 INFO - PROCESS | 25763 | Values: 681.3 703.0 741.7 782.5 788.3 13437.9 13737.5 13741.0 13753.7 13754.5 12940.0 13007.5 13016.3 13020.2 13021.5 657.1 668.1 809.5 823.7 825.2 827.5 832.6 833.1 833.4 834.2 680.1 842.8 858.0 859.8 860.0 863.2 865.5 866.3 866.4 866.4 638.0 638.2 638.3 638.5 638.5 13271.0 13302.5 13325.5 13325.5 13327.5 12880.5 13295.7 13327.7 13365.1 13540.4 10664.3 10691.8 10769.4 10804.4 10945.8 3645.9 3672.4 3705.9 3710.7 3796.3 47630.8 48434.8 48569.0 48641.0 48783.3 9508.4 9603.7 9696.8 9707.5 9899.2 19075.2 19088.3 19093.1 19226.3 19378.1 7425.6 7523.1 7611.7 7687.4 7764.1 4031.7 4228.9 4242.4 4288.8 4312.6 3075.2 3097.9 3099.2 3112.3 3132.9 530.5 549.4 554.1 555.7 559.8 617.1 620.5 626.7 671.8 682.0 8518.2 9018.6 9043.7 9051.1 9251.9 518.8 526.7 568.7 586.1 633.6 4095.5 4197.3 4457.9 4550.6 4657.5 57992.0 58345.1 58590.4 58619.1 58765.7 53393.5 53945.5 54472.0 54672.5 55160.0 50445.7 50465.7 50670.0 50699.7 51264.2 8797.4 9011.6 9040.5 9086.9 9140.3 31970.2 32080.0 33201.5 33256.3 33454.5 40693.6 42147.8 42428.2 42653.4 43521.3 11160.0 11378.7 11538.8 11602.8 11761.5 11580.0 11600.6 11944.4 12440.9 12605.2 11532.5 11545.6 11810.5 11894.8 11901.3 11212.7 11364.6 11429.9 11712.7 12027.4 10937.9 11138.9 11297.4 11433.5 11575.0 9044.4 9413.9 9421.4 9630.5 9854.4 8848.7 9224.3 9249.3 9588.4 10201.2 20:10:48 INFO - PROCESS | 25763 | -------- Summary: end -------- 20:10:48 INFO - PROCESS | 25763 | 20:10:48 INFO - TEST-INFO | 25763: exit 0 20:10:48 INFO - TEST-OK | dromaeo_css | took 1113075ms 20:10:48 INFO - TEST-START | kraken 20:10:48 INFO - operating with platform_type : linux_ 20:10:48 INFO - Initialising browser for kraken test... 20:10:48 INFO - TEST-INFO | started process 25949 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTWR74B/profile http://localhost:35243/getInfo.html) 20:10:52 INFO - PROCESS | 25949 | __metrics Screen width/height:1600/1200 20:10:52 INFO - PROCESS | 25949 | colorDepth:24 20:10:52 INFO - PROCESS | 25949 | Browser inner width/height: 1024/697 20:10:52 INFO - PROCESS | 25949 | __metrics 20:10:52 INFO - PROCESS | 25949 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:10:54 INFO - TEST-INFO | 25949: exit 0 20:10:54 INFO - Browser initialized. 20:10:54 INFO - Running cycle 1/1 for kraken test... 20:10:54 INFO - TEST-INFO | started process 26029 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTWR74B/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:11:05 INFO - PROCESS | 26029 | RSS: Main: 152956928 20:11:05 INFO - PROCESS | 26029 | 20:11:08 INFO - PROCESS | 26029 | Cycle 1(1): loaded http://localhost:35243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35243/tests/kraken/driver.html?testName=audio-beat-detection) 20:11:08 INFO - PROCESS | 26029 | RSS: Main: 192827392 20:11:08 INFO - PROCESS | 26029 | 20:11:11 INFO - PROCESS | 26029 | Cycle 1(1): loaded http://localhost:35243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35243/tests/kraken/driver.html?testName=audio-dft) 20:11:12 INFO - PROCESS | 26029 | RSS: Main: 182247424 20:11:12 INFO - PROCESS | 26029 | 20:11:15 INFO - PROCESS | 26029 | Cycle 1(1): loaded http://localhost:35243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35243/tests/kraken/driver.html?testName=audio-fft) 20:11:15 INFO - PROCESS | 26029 | RSS: Main: 165339136 20:11:15 INFO - PROCESS | 26029 | 20:11:17 INFO - PROCESS | 26029 | Cycle 1(1): loaded http://localhost:35243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35243/tests/kraken/driver.html?testName=audio-oscillator) 20:11:18 INFO - PROCESS | 26029 | RSS: Main: 166879232 20:11:18 INFO - PROCESS | 26029 | 20:11:20 INFO - PROCESS | 26029 | Cycle 1(1): loaded http://localhost:35243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:11:21 INFO - PROCESS | 26029 | RSS: Main: 171069440 20:11:21 INFO - PROCESS | 26029 | 20:11:24 INFO - PROCESS | 26029 | Cycle 1(1): loaded http://localhost:35243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35243/tests/kraken/driver.html?testName=imaging-darkroom) 20:11:24 INFO - PROCESS | 26029 | RSS: Main: 169648128 20:11:24 INFO - PROCESS | 26029 | 20:11:27 INFO - PROCESS | 26029 | Cycle 1(1): loaded http://localhost:35243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35243/tests/kraken/driver.html?testName=imaging-desaturate) 20:11:28 INFO - PROCESS | 26029 | RSS: Main: 171040768 20:11:28 INFO - PROCESS | 26029 | 20:11:31 INFO - PROCESS | 26029 | Cycle 1(1): loaded http://localhost:35243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35243/tests/kraken/driver.html?testName=json-parse-financial) 20:11:31 INFO - PROCESS | 26029 | RSS: Main: 170786816 20:11:31 INFO - PROCESS | 26029 | 20:11:33 INFO - PROCESS | 26029 | Cycle 1(1): loaded http://localhost:35243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:11:34 INFO - PROCESS | 26029 | RSS: Main: 183422976 20:11:34 INFO - PROCESS | 26029 | 20:11:35 INFO - PROCESS | 26029 | Cycle 1(1): loaded http://localhost:35243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35243/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:11:36 INFO - PROCESS | 26029 | RSS: Main: 179232768 20:11:36 INFO - PROCESS | 26029 | 20:11:38 INFO - PROCESS | 26029 | Cycle 1(1): loaded http://localhost:35243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:11:39 INFO - PROCESS | 26029 | RSS: Main: 191451136 20:11:39 INFO - PROCESS | 26029 | 20:11:41 INFO - PROCESS | 26029 | Cycle 1(1): loaded http://localhost:35243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:11:42 INFO - PROCESS | 26029 | RSS: Main: 196194304 20:11:42 INFO - PROCESS | 26029 | 20:11:44 INFO - PROCESS | 26029 | Cycle 1(1): loaded http://localhost:35243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:11:45 INFO - PROCESS | 26029 | RSS: Main: 196481024 20:11:45 INFO - PROCESS | 26029 | 20:11:47 INFO - PROCESS | 26029 | Cycle 1(1): loaded http://localhost:35243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35243/tests/kraken/driver.html?testName=ai-astar) 20:11:47 INFO - PROCESS | 26029 | RSS: Main: 255967232 20:11:47 INFO - PROCESS | 26029 | 20:11:47 INFO - PROCESS | 26029 | __start_tp_report 20:11:47 INFO - PROCESS | 26029 | _x_x_mozilla_page_load 20:11:47 INFO - PROCESS | 26029 | _x_x_mozilla_page_load_details 20:11:47 INFO - PROCESS | 26029 | |i|pagename|runs| 20:11:47 INFO - PROCESS | 26029 | |0;ai-astar;108;112;105;110;111;111;103;111;109;111 20:11:47 INFO - PROCESS | 26029 | |1;audio-beat-detection;150;135;155;169;131;147;151;139;163;134 20:11:47 INFO - PROCESS | 26029 | |2;audio-dft;160;160;162;161;162;161;161;164;160;161 20:11:47 INFO - PROCESS | 26029 | |3;audio-fft;75;73;95;95;75;73;73;104;95;76 20:11:47 INFO - PROCESS | 26029 | |4;audio-oscillator;96;96;135;95;95;96;145;96;100;135 20:11:47 INFO - PROCESS | 26029 | |5;imaging-gaussian-blur;118;115;115;115;116;115;115;115;114;115 20:11:47 INFO - PROCESS | 26029 | |6;imaging-darkroom;145;146;145;145;145;145;147;146;145;145 20:11:47 INFO - PROCESS | 26029 | |7;imaging-desaturate;97;96;96;96;96;96;96;96;96;96 20:11:47 INFO - PROCESS | 26029 | |8;json-parse-financial;56;58;56;56;55;57;57;66;54;55 20:11:47 INFO - PROCESS | 26029 | |9;json-stringify-tinderbox;67;68;67;67;67;68;66;66;66;67 20:11:47 INFO - PROCESS | 26029 | |10;stanford-crypto-aes;85;93;86;86;86;87;87;93;87;88 20:11:47 INFO - PROCESS | 26029 | |11;stanford-crypto-ccm;123;118;119;115;123;117;114;117;116;116 20:11:47 INFO - PROCESS | 26029 | |12;stanford-crypto-pbkdf2;157;148;153;152;153;149;155;152;157;156 20:11:47 INFO - PROCESS | 26029 | |13;stanford-crypto-sha256-iterative;69;69;71;71;68;69;69;69;68;70 20:11:47 INFO - PROCESS | 26029 | __end_tp_report 20:11:47 INFO - PROCESS | 26029 | __start_cc_report 20:11:47 INFO - PROCESS | 26029 | _x_x_mozilla_cycle_collect,979 20:11:47 INFO - PROCESS | 26029 | __end_cc_report 20:11:47 INFO - PROCESS | 26029 | __startTimestamp1455077507371__endTimestamp 20:11:47 INFO - PROCESS | 26029 | 20:11:47 INFO - PROCESS | 26029 | ------- Summary: start ------- 20:11:47 INFO - PROCESS | 26029 | Number of tests: 14 20:11:47 INFO - PROCESS | 26029 | 20:11:47 INFO - PROCESS | 26029 | [#0] ai-astar Cycles:10 Average:109.10 Median:111.00 stddev:2.96 (2.7%) stddev-sans-first:3.11 20:11:47 INFO - PROCESS | 26029 | Values: 108.0 112.0 105.0 110.0 111.0 111.0 103.0 111.0 109.0 111.0 20:11:47 INFO - PROCESS | 26029 | 20:11:47 INFO - PROCESS | 26029 | [#1] audio-beat-detection Cycles:10 Average:147.40 Median:150.50 stddev:12.74 (8.5%) stddev-sans-first:13.48 20:11:47 INFO - PROCESS | 26029 | Values: 150.0 135.0 155.0 169.0 131.0 147.0 151.0 139.0 163.0 134.0 20:11:47 INFO - PROCESS | 26029 | 20:11:47 INFO - PROCESS | 26029 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.23 (0.8%) stddev-sans-first:1.22 20:11:47 INFO - PROCESS | 26029 | Values: 160.0 160.0 162.0 161.0 162.0 161.0 161.0 164.0 160.0 161.0 20:11:47 INFO - PROCESS | 26029 | 20:11:47 INFO - PROCESS | 26029 | [#3] audio-fft Cycles:10 Average:83.40 Median:75.50 stddev:12.24 (16.2%) stddev-sans-first:12.60 20:11:47 INFO - PROCESS | 26029 | Values: 75.0 73.0 95.0 95.0 75.0 73.0 73.0 104.0 95.0 76.0 20:11:47 INFO - PROCESS | 26029 | 20:11:47 INFO - PROCESS | 26029 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:95.50 stddev:20.54 (21.5%) stddev-sans-first:21.25 20:11:47 INFO - PROCESS | 26029 | Values: 96.0 96.0 135.0 95.0 95.0 96.0 145.0 96.0 100.0 135.0 20:11:47 INFO - PROCESS | 26029 | 20:11:47 INFO - PROCESS | 26029 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:115.00 stddev:1.06 (0.9%) stddev-sans-first:0.50 20:11:47 INFO - PROCESS | 26029 | Values: 118.0 115.0 115.0 115.0 116.0 115.0 115.0 115.0 114.0 115.0 20:11:47 INFO - PROCESS | 26029 | 20:11:47 INFO - PROCESS | 26029 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 20:11:47 INFO - PROCESS | 26029 | Values: 145.0 146.0 145.0 145.0 145.0 145.0 147.0 146.0 145.0 145.0 20:11:47 INFO - PROCESS | 26029 | 20:11:47 INFO - PROCESS | 26029 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 20:11:47 INFO - PROCESS | 26029 | Values: 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 20:11:47 INFO - PROCESS | 26029 | 20:11:47 INFO - PROCESS | 26029 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:56.50 stddev:3.37 (6.0%) stddev-sans-first:3.55 20:11:47 INFO - PROCESS | 26029 | Values: 56.0 58.0 56.0 56.0 55.0 57.0 57.0 66.0 54.0 55.0 20:11:47 INFO - PROCESS | 26029 | 20:11:47 INFO - PROCESS | 26029 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 20:11:47 INFO - PROCESS | 26029 | Values: 67.0 68.0 67.0 67.0 67.0 68.0 66.0 66.0 66.0 67.0 20:11:47 INFO - PROCESS | 26029 | 20:11:47 INFO - PROCESS | 26029 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:87.00 stddev:2.86 (3.3%) stddev-sans-first:2.85 20:11:47 INFO - PROCESS | 26029 | Values: 85.0 93.0 86.0 86.0 86.0 87.0 87.0 93.0 87.0 88.0 20:11:47 INFO - PROCESS | 26029 | 20:11:47 INFO - PROCESS | 26029 | [#11] stanford-crypto-ccm Cycles:10 Average:117.80 Median:117.50 stddev:3.08 (2.6%) stddev-sans-first:2.64 20:11:47 INFO - PROCESS | 26029 | Values: 123.0 118.0 119.0 115.0 123.0 117.0 114.0 117.0 116.0 116.0 20:11:47 INFO - PROCESS | 26029 | 20:11:47 INFO - PROCESS | 26029 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.20 Median:154.00 stddev:3.12 (2.0%) stddev-sans-first:2.99 20:11:47 INFO - PROCESS | 26029 | Values: 157.0 148.0 153.0 152.0 153.0 149.0 155.0 152.0 157.0 156.0 20:11:47 INFO - PROCESS | 26029 | 20:11:47 INFO - PROCESS | 26029 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:1.06 (1.5%) stddev-sans-first:1.12 20:11:47 INFO - PROCESS | 26029 | Values: 69.0 69.0 71.0 71.0 68.0 69.0 69.0 69.0 68.0 70.0 20:11:47 INFO - PROCESS | 26029 | -------- Summary: end -------- 20:11:47 INFO - PROCESS | 26029 | 20:11:48 INFO - TEST-INFO | 26029: exit 0 20:11:48 INFO - TEST-OK | kraken | took 59528ms 20:11:48 INFO - SUITE-END | took 1172s 20:11:48 INFO - Completed test suite (00:19:32) 20:11:48 INFO - Working with test: dromaeo_css 20:11:48 INFO - Generating results file: dromaeo_css 20:11:48 INFO - Working with test: kraken 20:11:48 INFO - Generating results file: kraken 20:11:48 INFO - javascript benchmark 20:11:48 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:11:48 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 20:11:48 INFO - process_Request line: dromaeo_css 6912.65 graph.html#tests=[[72,64,35]] 20:11:48 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:11:48 INFO - process_Request line: kraken 1518.80 graph.html#tests=[[232,64,35]] 20:11:48 INFO - RETURN: dromaeo_css: 6912.65 20:11:48 INFO - RETURN: kraken: 1518.80 20:11:48 INFO - javascript benchmark 20:11:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3155.1165673611386, 3174.968250317499, 3215.951760723588, 3220.3237320162766, 3250.6261779895312, 5077.923831142536, 5188.009492319759, 5196.428392876785, 5198.792048318072, 5259.737013149342, 5110.131277682794, 5129.512696293846, 5148.716820574867, 5153.098207813627, 5164.070467315891, 4659.767011649421, 4737.976310118444, 4802.711837289757, 4858.489858564835, 4893.2170852663585, 4655.371524844153, 4698.154332220199, 4836.984233311009, 4840.467548569654, 4962.702237865721, 4685.4143232095985, 4685.906281874343, 4694.08465349257, 4722.90554188916, 4725.598324142435, 4666.976665116653, 4677.6491763117565, 4698.130845793505, 4726.692764970266, 4727.57451829337, 4583.610393116589, 4670.6497012724185, 4675.742834144121, 4679.906401871944, 4778.689385189951, 4953.306537084811, 4959.90080198394, 4965.90068198634, 5010.724410157476, 5051.166557518005, 5498.945010549924, 5501.697406642633, 5506.80726174586, 5508.03609368359, 5525.613207075507, 5421.674699518042, 5571.192177134293, 5585.994520986221, 5597.964376590303, 5649.12438572022, 5239.921401178947, 5291.497307755795, 5292.206169074631, 5299.099153143936, 5340.30576025122, 5476.58925580583, 5563.5271001964475, 5733.627314224562, 5755.424457554295, 5755.769769209269, 5536.474034966672, 5547.639403438763, 5569.805056822992, 5571.526420254324, 5627.634203776742, 5583.804566840141, 5596.2165296858475, 5600.355959064678, 5601.29983752031, 5601.887962240814, 5410.350757908997, 5452.482014208644, 5497.505224529811, 5558.333000040021, 5568.526675232651, 5578.497935185853, 5584.190292407578, 5584.804531841447, 5590.552755779528, 5594.664320140723, 4334.783260837009, 4363.563643635611, 4365.1051534436, 4368.847090351823, 4401.273789824707, 3841.4814000110186, 3881.7088718346236, 3910.8240129194255, 3922.9604154898975, 3962.623550762673, 5218.9562087582635, 5239.266502689627, 5250.606204534675, 5251.448597897166, 5305.8938821223355, 5613.129964855454, 5637.872425514914, 5650.095984642519, 5654.208410822488, 5657.773689052474, 5099.566536844335, 5171.3535808024, 5184.092783762826, 5231.215317702375, 5255.054090263713, 4767.95232047682, 4773.570378665937, 4775.044991001813, 4780.521947805191, 4854.951450485521, 5609.859753506195, 5789.797357092566, 5791.189233507313, 5797.8550536236935, 5799.333076696234, 5515.531179849758, 5579.525740311957, 5642.971785141212, 5660.0, 5705.258316418839, 5776.220210271559, 5784.82645520635, 5788.594798364074, 5790.507806836466, 5798.246227990503, 5395.595330350318, 5480.451954804487, 5566.081596536526, 5568.721563921868, 5572.526335261548, 5645.06856368711, 5651.43485651448, 5696.344920334214, 5700.144978253295, 5737.168110623853, 5400.243965844864, 5404.351477822686, 5429.592780541396, 5435.755391007493, 5466.098093814476, 5338.1458966566715, 5386.4110087523495, 5390.19147127934, 5392.919106213331, 5433.320834895638, 5416.106342453609, 5423.810166644149, 5428.212909128233, 5465.234867118686, 5468.507834294933, 5503.11950087984, 5525.640833345819, 5534.225208470898, 5535.8892822144135, 5550.333959924835, 5259.132243179833, 5360.865978350573, 5435.537979271806, 5438.83683489496, 5439.347278326626], "unit": "score", "name": "dojo.html", "value": 5151.135456839173}, {"lowerIsBetter": false, "replicates": [518.1424742051905, 538.647186093109, 544.4174733035652, 559.8544378461598, 579.2672269578981, 28191.859040704792, 28874.422511549783, 36248.2750344993, 36969.63030369702, 37055.25889482209, 39630.60369396305, 39998.60001399985, 40026.39960400589, 40068.198636027264, 40078.799606002, 8501.872471912926, 8680.479171249714, 8680.956595217047, 8683.826323473526, 8686.956565217197, 8572.699955501559, 8672.653093876237, 8679.349048821332, 8687.30501559877, 8697.608607612672, 8917.955410222972, 8977.371583989123, 8985.955070224672, 8996.865047024266, 9005.099490051009, 8874.42316249445, 8949.194572488475, 8955.731328060168, 8956.283497320264, 8956.776080597972, 8755.737327880173, 8908.910910890938, 8913.37606367548, 8918.019017908025, 8921.910780892238, 40112.59887401118, 40414.79792601018, 40506.79746601248, 40516.1896762066, 40528.98677533085, 3183.0769076967654, 3283.0, 3288.4574045282498, 3305.752068594865, 3365.0, 30212.697873021207, 30662.693373066206, 30860.691393086006, 30972.8451357744, 32040.19899502508, 3917.743237287886, 3981.422693709425, 4047.4535937648334, 4091.9386209206887, 4093.2222877653153, 261301.0, 261462.0, 262362.0, 262457.0, 263014.9999999981, 52383.73808131011, 58247.41752582505, 58651.70674146602, 59945.10082348768, 60984.69507652522, 55242.44757552373, 55259.44740552623, 55537.444625553224, 55564.16653750197, 55602.443975560534, 15430.691386172213, 15612.3755049799, 15618.531444056696, 15627.0, 15629.452969146025, 11078.667639970814, 11603.0137438317, 11957.282563046245, 12000.63998080059, 12023.458944347525, 19343.709844352346, 19353.322633707754, 19467.805321946882, 19550.0, 19613.0, 7083.0, 7146.678399471933, 7187.96406017977, 7233.602151881591, 7256.7460138894885, 990.6780296403698, 996.6412091647002, 996.9102780749768, 1058.1270451877233, 1076.3649446826253, 24906.750932490442, 26134.477310454065, 27840.303992400353, 27866.79920477137, 27887.442251154862, 1053.5522402978704, 1114.409363037575, 1124.2804605052772, 1130.8869113088626, 1199.4662375243108, 13682.31588420575, 13775.311234438439, 13857.584272471842, 14148.43406263738, 14575.255638911502, 342195.0, 343135.0, 345963.0, 346951.0, 347372.0, 51780.22329665058, 51966.22050669243, 51982.74008629932, 52040.73979630153, 52133.7393313031, 1185.887340702632, 1274.7832868412206, 1276.8020956751718, 1350.723101764136, 1370.9245991470566, 22822.65766013478, 29794.0, 30082.54876176903, 30429.0, 30633.0, 49720.751396242784, 49804.25293620526, 50086.24870626871, 50104.749476252386, 50243.0, 252717.0, 254314.0, 257018.0, 300235.0, 312414.0, 28673.13980580586, 28687.856560717064, 28714.569281461212, 29016.854915725286, 29082.563761544017, 39272.80363598278, 40044.59955400409, 40440.39339409852, 40443.1911361777, 40871.1825763489, 33384.0, 34042.489362659086, 35011.12472188114, 35444.64555354517, 37509.81245093757, 31804.840975794974, 32210.0, 32522.512162318057, 33943.151421214665, 34560.308793824486, 35805.82097089498, 36224.818875905454, 36584.08539786527, 36607.81696091503, 36691.63308366989, 29964.70035299619, 31041.379172416877, 32403.51394729128, 32497.187570310933, 32678.50982235316, 25111.24666260015, 25422.872885635454, 25540.872295638404, 25812.483750325264, 25998.09006684757], "unit": "score", "name": "ext.html", "value": 18179.510215594935}, {"lowerIsBetter": false, "replicates": [334.5143603649968, 338.3419249559607, 350.764987458403, 352.36925902634283, 353.84254006966876, 13089.214647121156, 13536.0, 16164.676706465878, 16267.75598366024, 17656.646867062653, 15028.797696184307, 15083.245837708098, 16673.082980436073, 16985.3205871765, 17016.914915425437, 5131.948680513194, 5258.421573626898, 5349.491798279177, 5383.111786555213, 5387.326584176978, 3903.668188204006, 5378.085725426687, 5608.186812912125, 5810.651360918338, 5816.476517113459, 5568.805091821787, 5732.0828667413225, 5790.160426738142, 5791.391903850098, 5849.415058494138, 5786.42135786418, 5798.884022319551, 5800.8839823203725, 5812.970935145318, 5821.068629019358, 5033.572146367563, 5170.948290517122, 5171.689698618057, 5171.896562068738, 5173.430922598511, 19544.70682939743, 20021.299254526166, 20023.699644505345, 20058.39824805258, 20117.195312187494, 2204.2725900452974, 2228.487447886995, 2686.529857274969, 2842.2894276430893, 2952.936942700626, 12408.255504669658, 12800.103992720513, 12863.099583029192, 13017.153884997444, 13203.40584673692, 1780.813014633458, 1840.917158727847, 1864.580469394389, 1872.410190789897, 1907.8569107317007, 56828.0, 57932.71033644847, 59194.70402648002, 59641.40358596402, 61961.0, 9759.609615615438, 10088.495575221357, 10354.430506322075, 10378.377297362182, 10469.476526173661, 13637.181769093886, 13695.109817861807, 13702.246376449391, 13708.451661933412, 13732.107413018122, 7492.550446973199, 7572.20491848348, 7584.355329796918, 7605.847883042419, 7613.9238607614325, 7338.41292696583, 7341.082364704412, 7384.0, 7441.441891858132, 7515.661795219228, 4139.0, 4418.491873434532, 4462.888427789331, 4481.686281960231, 4508.301213311942, 1687.4262750664832, 1740.1647209339335, 1791.641671665672, 1792.1308165539704, 1802.1619946724836, 957.6887511558632, 974.1427543761445, 1085.2891356161726, 1121.2431608664283, 1127.520803658442, 15698.450554230547, 16084.0, 16168.757468637745, 16338.918305408397, 16454.83545164557, 947.0, 974.512743628186, 974.5711886769799, 979.5560077606275, 1028.753099256173, 9417.858732119024, 9796.314258001872, 9822.26333025026, 9824.852627210597, 9838.9016109838, 531870.0, 536558.0, 538956.0, 539866.0, 556311.0, 75087.24912750912, 75167.24832751602, 77617.0, 78605.0, 78961.60519197368, 1046.26238501856, 1050.1074087025968, 1118.0496577908712, 1150.1948635954698, 1150.7813515432042, 14969.101853888802, 15001.474948376754, 15105.32026058852, 15167.143652118944, 15372.615684607974, 31251.53122703207, 31491.685083148874, 31591.526127108573, 31717.207069822514, 31719.0, 42759.57240427556, 42860.571394286904, 43085.56914430815, 43154.352684710386, 43230.0, 7404.185539590749, 7599.708049631466, 7655.311022007823, 7677.385809135368, 7702.114256860533, 10639.308444951053, 10708.518116684612, 11309.151813613847, 11477.311361318347, 11893.583724569598, 7781.277635906674, 8366.414350995372, 9584.472853993097, 10246.692599221737, 10341.37951722899, 9767.218622510325, 10113.89886101159, 10151.543180556744, 10226.28416010872, 10557.366558006544, 6954.513184077066, 8364.958175209329, 10081.193504519768, 10344.482775861328, 10543.683689489328, 5507.697076660662, 6823.0, 7256.23809500016, 7501.362384197404, 7586.089669239726, 9806.558704858442, 10338.689839304832, 10515.78968420612, 10546.367217966947, 10550.103241224582], "unit": "score", "name": "jquery.html", "value": 8348.155258857143}, {"lowerIsBetter": false, "replicates": [1378.9103708258956, 1479.940802367905, 1486.1751727791075, 1679.8908070975385, 1838.4668446150617, 7096.112985876765, 7758.806029849249, 7895.210478952102, 7909.525428474281, 7922.0, 7798.376129909608, 7953.4432589718745, 7957.641906114224, 7967.3626109911065, 7986.0, 1988.3438465306415, 2251.448395143192, 2292.587334279829, 2311.7225932888036, 2343.742188359279, 2307.0541078157958, 2345.319857241398, 2348.412896775806, 2355.0108954239263, 2355.9764402356013, 2253.0874995626796, 2331.3239160643393, 2332.2303639798824, 2334.253039027512, 2334.673145759595, 2326.8836558172106, 2335.8948847301913, 2337.322176568793, 2340.9297721068397, 2357.2456813819585, 2255.2557655973487, 2267.818574514035, 2285.3600991722346, 2312.1329501436962, 2318.6637937499136, 7840.333571646417, 7841.098273698541, 7843.960780196119, 7846.882296765553, 7850.9214907850765, 4712.246040633517, 4773.904521909577, 4777.450593181759, 4779.832705855279, 4830.516948305177, 3009.7893147479685, 3087.9691203087905, 3108.4715598348334, 3116.3611459650715, 3136.905892823219, 971.2715463402449, 1009.1170226052204, 1009.1220638044874, 1066.7013236293851, 1073.3559864081567, 11226.719332016764, 11346.20576559641, 11373.09015278784, 11383.0, 11409.48657310423, 4351.651867850627, 4390.8024138913825, 4468.754218517947, 4479.910401791946, 4486.618637415856, 9675.177609903238, 9723.854142187873, 9742.0, 9746.220302375792, 9746.415215087118, 4954.959458513753, 4956.231784073474, 4964.131277026579, 4964.528369804862, 4967.031428871335, 4458.621017213573, 4482.8206871725415, 4483.55164483549, 4506.59440650343, 4522.0277640307495, 3483.7561370703806, 3687.797171155612, 3707.9247018364913, 3749.1002159481527, 3754.75594086389, 1236.1532350340046, 1249.6376050945305, 1250.4060571228595, 1250.9061820363509, 1263.943122559487, 1328.8471825740164, 1329.0, 1345.6770375109902, 1353.0325817040864, 1374.4090041282345, 7512.436567257478, 7524.548527088283, 7684.923150768533, 7686.192949740309, 7715.151333353327, 1137.5449820072038, 1146.0, 1150.8734039255676, 1152.2107356460851, 1156.2079975217002, 5872.207252021008, 5936.079907614327, 5940.584159108907, 5944.375840536768, 5951.613145145551, 9223.907760922439, 9831.213502919749, 9995.650152244636, 10033.046860548237, 10036.197104231644, 9705.902940970642, 9873.555689993824, 9894.06006429388, 9907.603695852229, 9908.653197138066, 7183.748568800067, 7470.73852415152, 7473.140588832245, 7487.66305516253, 7489.176190619028, 7454.3663788576405, 7483.850322993619, 7516.135644400745, 7529.736459223901, 7545.170031296443, 8326.375521836007, 8914.598843051948, 8974.326925480484, 8985.146411090936, 8986.370954033155, 8692.826143477221, 8721.040685524715, 8851.998620779239, 8965.686200982935, 8965.775855603662, 6796.796096117125, 7763.767086987399, 7878.448508604342, 7881.684732610861, 7883.684652614061, 7497.475176737576, 7663.386929045551, 7685.0, 7703.807404814925, 7704.26809453101, 7002.124734408199, 7125.964370178116, 7143.357097861218, 7268.309510596485, 7292.088488938883, 7054.647267636495, 7104.04095447108, 7192.31672991065, 7224.819379515554, 7249.0, 7104.431645468247, 7151.60666163366, 7186.029885965328, 7353.926460735324, 7359.337659610661, 6738.225104112894, 6762.560433571802, 6768.187817461936, 6772.966135169293, 6778.017187507882, 6653.833654158685, 6673.566218195801, 6720.361565651256, 6794.252632210551, 6799.082123913407], "unit": "score", "name": "mootools.html", "value": 4652.389383772228}, {"lowerIsBetter": false, "replicates": [322.4212538493404, 325.2908659123111, 328.2335746033013, 329.46626465126496, 333.52639252261775, 5838.095095260231, 5910.438508341706, 5943.673097979609, 5949.107633854924, 5969.432903874131, 5736.598438109334, 5861.7362218700155, 5890.440408161228, 5905.055191169414, 5925.7925972590965, 4563.361129441864, 4565.726056436608, 4576.656750743699, 4582.564656357641, 4583.083383323348, 4363.498197707257, 4405.713628614129, 4456.754878481682, 4477.3731677565165, 4585.747783871886, 4466.508684044752, 4472.6645501587345, 4478.0596074824325, 4478.888027799315, 4485.775711214426, 4445.422095127645, 4448.221561226773, 4465.6650751193465, 4472.105578884236, 4473.731576105444, 3920.0, 3927.469791578129, 3941.2708648900043, 3941.7437866538585, 3944.3097457944746, 5523.088690366085, 5654.802081927154, 5679.772809087632, 5691.715414229313, 5747.310322761254, 5160.612954028463, 5164.122099243138, 5164.741762911877, 5212.400573934008, 5214.478552144793, 5980.401959804029, 6241.375862413768, 6245.188125543696, 6246.531510136758, 6249.437550620421, 4191.7694526801015, 4282.42187304713, 4293.0, 4294.506131794852, 4304.053108316165, 6462.579932304385, 6507.251666058417, 6519.282878883319, 6521.64130972801, 6528.347165283481, 4292.3561465780385, 4296.312589985588, 4298.204832106007, 4301.0537681709975, 4301.096769678403, 4352.434183556117, 4357.0, 4359.673024523174, 4368.453943257093, 4506.459224892968, 5199.402068762065, 5199.766010529535, 5205.219217117463, 5210.687358758487, 5211.0, 6335.303116657164, 6363.5227357947415, 6406.23125224976, 6412.198475190601, 6417.197850268716, 1541.0984574024096, 1576.7713681516116, 1576.7950166478513, 1577.7869987551762, 1578.684263147375, 1036.1710631494775, 1046.8429735539578, 1049.4437947887632, 1056.6143357674393, 1071.2287153249647, 5990.73041713124, 5994.460498555151, 5999.820005399845, 6007.3992600739575, 6015.759369625253, 6520.510961677893, 6534.444572211415, 6544.967275163689, 6547.247066587308, 6554.279029306773, 6005.0, 6006.759729610854, 6009.969950150221, 6013.819585412444, 6019.69901504923, 3427.7600567960503, 3541.0, 3543.6456354364873, 3545.166885781839, 3547.7161827053774, 6851.9657401712675, 6859.3140685932, 6859.9314006859295, 6860.656967151723, 6864.519483636098, 6701.229358623821, 6707.966460167668, 6711.664416779142, 6712.228093769181, 6712.798616041527, 6697.732090716414, 6829.248782633907, 6834.111565496453, 6848.1097457330225, 6865.691043903136, 6270.122182894307, 6441.066045423481, 6587.934120658923, 6596.142501474969, 6603.7688680895935, 6461.515386346136, 6479.287278399466, 6483.513736469689, 6493.837654058686, 6494.253160886558, 6844.0, 6844.726210951705, 6846.884667476187, 6851.07510486078, 6852.349026842442, 4507.414036175407, 4558.3618293438285, 4562.8631141065825, 4616.053708989716, 4618.076384723136, 6419.711112999833, 6423.743050277936, 6465.0948867157695, 6507.9674601628585, 6511.916186820172, 6288.779892703734, 6342.175517182736, 6343.714532846126, 6348.666779976256, 6360.332165122781, 6171.290301615371, 6315.915747803306, 6318.08387783778, 6321.0, 6335.873282534416, 6203.503719702323, 6205.627662340274, 6212.06818977157, 6218.502519798496, 6221.96889015552, 6296.905546416716, 6329.49364050884, 6331.556791024768, 6333.936660633335, 6391.96804015977, 6145.201123853871, 6212.254529456313, 6216.7824126157175, 6221.440070393686, 6312.495000400048], "unit": "score", "name": "prototype.html", "value": 4736.8645833539285}, {"lowerIsBetter": false, "replicates": [681.2574294019518, 702.9543079699819, 741.6699568691931, 782.5226611766822, 788.3259812860005, 13437.865621343784, 13737.450501979934, 13741.03812733109, 13753.724925501483, 13754.518591849275, 12940.0, 13007.47970081198, 13016.349182540858, 13020.153690010142, 13021.479140834355, 657.1457105762513, 668.1381018486147, 809.5426084262373, 823.6993497373445, 825.1830687619243, 827.4869580859845, 832.6378025558871, 833.1168960901433, 833.3708050421923, 834.2200042959852, 680.1124532485105, 842.7977285451509, 858.0347109501811, 859.8237361340941, 859.9852174434166, 863.223099210709, 865.5196366016858, 866.2593482572373, 866.4108406283724, 866.4194989357114, 637.9776707815204, 638.2436812377301, 638.3265654734254, 638.4605008767584, 638.4636904999776, 13271.004674649439, 13302.534411295559, 13325.466981320735, 13325.466981320735, 13327.466901323935, 12880.484780608764, 13295.73690499401, 13327.733445331136, 13365.131266467648, 13540.390682419216, 10664.306820056672, 10691.83962240567, 10769.353838769699, 10804.405757683324, 10945.781084378268, 3645.8906232813056, 3672.4307732301536, 3705.9073523162137, 3710.666040056408, 3796.2787070456525, 47630.76184619089, 48434.757826211, 48569.0, 48641.0, 48783.26825097591, 9508.381955172892, 9603.663871764455, 9696.806063878825, 9707.514624268759, 9899.208063354914, 19075.2369905205, 19088.331908383418, 19093.140808663367, 19226.32707855218, 19378.127984240742, 7425.62871856405, 7523.059617547807, 7611.65747541362, 7687.385009199251, 7764.068311802507, 4031.677465802729, 4228.936565951513, 4242.4272723181975, 4288.807003684841, 4312.633555656292, 3075.1697041799034, 3097.860596273128, 3099.2097015260965, 3112.346407254502, 3132.9373412531622, 530.5410819640982, 549.4121290219507, 554.0802268234711, 555.6804837218615, 559.815260963881, 617.0990354083089, 620.4818976154871, 626.7117126121943, 671.8219671786981, 681.9770344483275, 8518.23335899772, 9018.639254429749, 9043.683471078612, 9051.14014168653, 9251.90748092524, 518.7769259218572, 526.6813577785462, 568.7412227436506, 586.0564491169214, 633.5944995203074, 4095.460814295156, 4197.307444271661, 4457.888552786207, 4550.635949124062, 4657.4876763555985, 57992.0, 58345.124823127684, 58590.4140958585, 58619.12071318934, 58765.70617146973, 53393.46606533885, 53945.460545394046, 54472.0, 54672.45327546753, 55160.0, 50445.747771260176, 50465.74767126141, 50670.0, 50699.746501268, 51264.23103653448, 8797.428167169113, 9011.63953441855, 9040.502772347583, 9086.909130908607, 9140.314476414163, 31970.20074498156, 32080.0, 33201.50197747084, 33256.33487330288, 33454.4981825268, 40693.59306407016, 42147.7892610535, 42428.151436971704, 42653.36019959641, 43521.34717979296, 11160.015067705559, 11378.658640240807, 11538.82691759641, 11602.751239599656, 11761.529538818351, 11580.0, 11600.593979210687, 11944.402779861146, 12440.937795310965, 12605.180663256859, 11532.538698452303, 11545.595904143314, 11810.544987095529, 11894.762104758029, 11901.285922844658, 11212.719682008015, 11364.602238921598, 11429.942850286028, 11712.70718232051, 12027.398630068637, 10937.945310273397, 11138.888611113785, 11297.43512824372, 11433.542658293907, 11575.0, 9044.432561556372, 9413.85879211826, 9421.434713917188, 9630.48018768021, 9854.359466634645, 8848.734537963872, 9224.262059035127, 9249.30630202724, 9588.37675551087, 10201.183905287708], "unit": "score", "name": "yui.html", "value": 6332.659799230867}], "name": "dromaeo_css", "value": 6912.645512519248}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 112.0, 105.0, 110.0, 111.0, 111.0, 103.0, 111.0, 109.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.1}, {"lowerIsBetter": true, "replicates": [150.0, 135.0, 155.0, 169.0, 131.0, 147.0, 151.0, 139.0, 163.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 147.4}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 162.0, 161.0, 162.0, 161.0, 161.0, 164.0, 160.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 95.0, 95.0, 75.0, 73.0, 73.0, 104.0, 95.0, 76.0], "unit": "score", "name": "audio-fft", "value": 83.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 135.0, 95.0, 95.0, 96.0, 145.0, 96.0, 100.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [118.0, 115.0, 115.0, 115.0, 116.0, 115.0, 115.0, 115.0, 114.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.3}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 147.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [56.0, 58.0, 56.0, 56.0, 55.0, 57.0, 57.0, 66.0, 54.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.0}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 67.0, 67.0, 68.0, 66.0, 66.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.9}, {"lowerIsBetter": true, "replicates": [85.0, 93.0, 86.0, 86.0, 86.0, 87.0, 87.0, 93.0, 87.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.8}, {"lowerIsBetter": true, "replicates": [123.0, 118.0, 119.0, 115.0, 123.0, 117.0, 114.0, 117.0, 116.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.8}, {"lowerIsBetter": true, "replicates": [157.0, 148.0, 153.0, 152.0, 153.0, 149.0, 155.0, 152.0, 157.0, 156.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.2}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 71.0, 71.0, 68.0, 69.0, 69.0, 69.0, 68.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.3}], "name": "kraken", "value": 1518.8}]} 20:11:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1518.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6912.65"}}} 20:11:48 INFO - Return code: 0 20:11:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:11:48 INFO - # TBPL SUCCESS # 20:11:48 INFO - Running post-action listener: _resource_record_post_action 20:11:48 INFO - Running post-run listener: _resource_record_post_run 20:11:49 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8192; Write bytes: 299687936; Read time: 68; Write time: 157244 20:11:49 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 13737984; Read time: 0; Write time: 4376 20:11:49 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 285945856; Read time: 68; Write time: 152140 20:11:49 INFO - Running post-run listener: _upload_blobber_files 20:11:49 INFO - Blob upload gear active. 20:11:49 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:11:49 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 20:11:49 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'] 20:11:49 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 20:11:50 INFO - (blobuploader) - INFO - Open directory for files ... 20:11:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 20:11:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:11:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:11:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:11:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:11:51 INFO - (blobuploader) - INFO - Done attempting. 20:11:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:11:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:11:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:11:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:11:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:11:52 INFO - (blobuploader) - INFO - Done attempting. 20:11:52 INFO - (blobuploader) - INFO - Iteration through files over. 20:11:52 INFO - Return code: 0 20:11:52 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:11:52 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:11:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/25b312072ccc12c1cc94485c6889e4aa57fa2351190dd529496c94a03abbc33a8b88485feffe00a3115791cf03411193f92588564c427f07a8ac987e00d95a3e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/facacd4918bfe0d29c2a31c49132e716d1d7de6eca72eb672fc1d1939c3feb34a6c3e67cf14fd20caa24d330ecbc0507d33604203149a9927301c127ddd969d3"} 20:11:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:11:52 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:11:52 INFO - Contents: 20:11:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/25b312072ccc12c1cc94485c6889e4aa57fa2351190dd529496c94a03abbc33a8b88485feffe00a3115791cf03411193f92588564c427f07a8ac987e00d95a3e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/facacd4918bfe0d29c2a31c49132e716d1d7de6eca72eb672fc1d1939c3feb34a6c3e67cf14fd20caa24d330ecbc0507d33604203149a9927301c127ddd969d3"} 20:11:52 INFO - Running post-run listener: copy_logs_to_upload_dir 20:11:52 INFO - Copying logs to upload dir... 20:11:52 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 20:11:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.408738 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-02-09 20:11:51.965686) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-09 20:11:51.969707) ========= 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=d2a8c569965ab8367867b893000001a1-1455075974.272821-268906732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/25b312072ccc12c1cc94485c6889e4aa57fa2351190dd529496c94a03abbc33a8b88485feffe00a3115791cf03411193f92588564c427f07a8ac987e00d95a3e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/facacd4918bfe0d29c2a31c49132e716d1d7de6eca72eb672fc1d1939c3feb34a6c3e67cf14fd20caa24d330ecbc0507d33604203149a9927301c127ddd969d3"} build_url:https://queue.taskcluster.net/v1/task/R9CiDnWySy2c-NmQUFELAA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011495 build_url: 'https://queue.taskcluster.net/v1/task/R9CiDnWySy2c-NmQUFELAA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/25b312072ccc12c1cc94485c6889e4aa57fa2351190dd529496c94a03abbc33a8b88485feffe00a3115791cf03411193f92588564c427f07a8ac987e00d95a3e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/facacd4918bfe0d29c2a31c49132e716d1d7de6eca72eb672fc1d1939c3feb34a6c3e67cf14fd20caa24d330ecbc0507d33604203149a9927301c127ddd969d3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-09 20:11:51.994292) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 20:11:51.994642) ========= 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=d2a8c569965ab8367867b893000001a1-1455075974.272821-268906732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004821 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 20:11:52.077965) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-09 20:11:52.078322) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-09 20:11:52.078629) ========= ========= Total master_lag: 0.28 =========