builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1455915107.48 results: success (0) buildid: 20160219103113 builduid: 15630221784649429634119ecb76a82e revision: 69ec3dc408a2a720cb2b8210fea33e3504aeec22 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-19 12:51:47.482119) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-19 12:51:47.482527) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-19 12:51:47.482818) ========= 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=6dbc10da6d83fee962c624be000001a8-1455914880.598177-993953364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006806 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-19 12:51:47.506267) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-19 12:51:47.506542) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-19 12:51:47.530238) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 12:51:47.530501) ========= 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=6dbc10da6d83fee962c624be000001a8-1455914880.598177-993953364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004595 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 12:51:47.584461) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-19 12:51:47.584738) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-19 12:51:47.585091) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 12:51:47.585383) ========= 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=6dbc10da6d83fee962c624be000001a8-1455914880.598177-993953364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-19 12:51:47-- 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% 43.2M=0s 2016-02-19 12:51:47 (43.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121501 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 12:51:47.721704) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 12:51:47.721993) ========= 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=6dbc10da6d83fee962c624be000001a8-1455914880.598177-993953364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015418 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 12:51:47.771703) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-19 12:51:47.772052) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 69ec3dc408a2a720cb2b8210fea33e3504aeec22 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 69ec3dc408a2a720cb2b8210fea33e3504aeec22 --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=6dbc10da6d83fee962c624be000001a8-1455914880.598177-993953364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-19 12:51:47,986 truncating revision to first 12 chars 2016-02-19 12:51:47,986 Setting DEBUG logging. 2016-02-19 12:51:47,986 attempt 1/10 2016-02-19 12:51:47,986 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/69ec3dc408a2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-19 12:51:48,881 unpacking tar archive at: mozilla-central-69ec3dc408a2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.180582 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-19 12:51:48.966927) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-19 12:51:48.967487) ========= echo 69ec3dc408a2a720cb2b8210fea33e3504aeec22 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'69ec3dc408a2a720cb2b8210fea33e3504aeec22'] 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=6dbc10da6d83fee962c624be000001a8-1455914880.598177-993953364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 69ec3dc408a2a720cb2b8210fea33e3504aeec22 program finished with exit code 0 elapsedTime=0.004705 script_repo_revision: '69ec3dc408a2a720cb2b8210fea33e3504aeec22' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-19 12:51:49.018959) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-19 12:51:49.019313) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-19 12:51:49.030173) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-02-19 12:51:49.030524) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=6dbc10da6d83fee962c624be000001a8-1455914880.598177-993953364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:51:49 INFO - MultiFileLogger online at 20160219 12:51:49 in /builds/slave/test-pgo 12:51:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 12:51:49 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 12:51:49 INFO - {'append_to_log': False, 12:51:49 INFO - 'base_work_dir': '/builds/slave/test-pgo', 12:51:49 INFO - 'blob_upload_branch': 'Firefox', 12:51:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 12:51:49 INFO - 'branch': 'Firefox', 12:51:49 INFO - 'buildbot_json_path': 'buildprops.json', 12:51:49 INFO - 'config_files': ('talos/linux_config.py',), 12:51:49 INFO - 'default_actions': ('clobber', 12:51:49 INFO - 'read-buildbot-config', 12:51:49 INFO - 'download-and-extract', 12:51:49 INFO - 'populate-webroot', 12:51:49 INFO - 'create-virtualenv', 12:51:49 INFO - 'install', 12:51:49 INFO - 'run-tests'), 12:51:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:51:49 INFO - 'download_minidump_stackwalk': True, 12:51:49 INFO - 'download_symbols': 'ondemand', 12:51:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:51:49 INFO - 'tooltool.py': '/tools/tooltool.py', 12:51:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:51:49 INFO - '/tools/misc-python/virtualenv.py')}, 12:51:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:51:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:51:49 INFO - 'installer_path': 'installer.exe', 12:51:49 INFO - 'log_level': 'info', 12:51:49 INFO - 'log_name': 'talos', 12:51:49 INFO - 'log_to_console': True, 12:51:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:51:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:51:49 INFO - 'opt_config_files': (), 12:51:49 INFO - 'pip_index': False, 12:51:49 INFO - 'sps_profile': False, 12:51:49 INFO - 'sps_profile_interval': 0, 12:51:49 INFO - 'suite': 'dromaeojs', 12:51:49 INFO - 'system_bits': '32', 12:51:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:51:49 INFO - 'title': 'talos-linux64-ix-050', 12:51:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:51:49 INFO - 'use_talos_json': True, 12:51:49 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 12:51:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:51:49 INFO - 'work_dir': 'build'} 12:51:49 INFO - ##### 12:51:49 INFO - ##### Running clobber step. 12:51:49 INFO - ##### 12:51:49 INFO - Running pre-action listener: _resource_record_pre_action 12:51:49 INFO - Running main action method: clobber 12:51:49 INFO - rmtree: /builds/slave/test-pgo/build 12:51:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 12:51:50 INFO - Running post-action listener: _resource_record_post_action 12:51:50 INFO - ##### 12:51:50 INFO - ##### Running read-buildbot-config step. 12:51:50 INFO - ##### 12:51:50 INFO - Running pre-action listener: _resource_record_pre_action 12:51:50 INFO - Running main action method: read_buildbot_config 12:51:50 INFO - Using buildbot properties: 12:51:50 INFO - { 12:51:50 INFO - "project": "", 12:51:50 INFO - "product": "firefox", 12:51:50 INFO - "script_repo_revision": "production", 12:51:50 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 12:51:50 INFO - "repository": "", 12:51:50 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 12:51:50 INFO - "buildid": "20160219103113", 12:51:50 INFO - "pgo_build": "True", 12:51:50 INFO - "basedir": "/builds/slave/test-pgo", 12:51:50 INFO - "buildnumber": 194, 12:51:50 INFO - "slavename": "talos-linux64-ix-050", 12:51:50 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:51:50 INFO - "platform": "ubuntu64_hw", 12:51:50 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 12:51:50 INFO - "branch": "mozilla-central", 12:51:50 INFO - "repo_path": "mozilla-central", 12:51:50 INFO - "revision": "69ec3dc408a2a720cb2b8210fea33e3504aeec22", 12:51:50 INFO - "stage_platform": "linux64-pgo", 12:51:50 INFO - "builduid": "15630221784649429634119ecb76a82e", 12:51:50 INFO - "slavebuilddir": "test" 12:51:50 INFO - } 12:51:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/Tfa2so9DTV--qfZQCoeSvw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 12:51:50 INFO - Running post-action listener: _resource_record_post_action 12:51:50 INFO - ##### 12:51:50 INFO - ##### Running download-and-extract step. 12:51:50 INFO - ##### 12:51:50 INFO - Running pre-action listener: _resource_record_pre_action 12:51:50 INFO - Running main action method: download_and_extract 12:51:50 INFO - mkdir: /builds/slave/test-pgo/build/tests 12: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')]} 12:51:50 INFO - https://queue.taskcluster.net/v1/task/Tfa2so9DTV--qfZQCoeSvw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:51:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tfa2so9DTV--qfZQCoeSvw/artifacts/public/build/test_packages.json 12:51:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tfa2so9DTV--qfZQCoeSvw/artifacts/public/build/test_packages.json 12:51:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tfa2so9DTV--qfZQCoeSvw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 12:51:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tfa2so9DTV--qfZQCoeSvw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 12:51:54 INFO - Downloaded 1448 bytes. 12:51:54 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 12:51:54 INFO - Using the following test package requirements: 12:51:54 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 12:51:54 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 12:51:54 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:51:54 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 12:51:54 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:51:54 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 12:51:54 INFO - u'jsshell-linux-x86_64.zip'], 12:51:54 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 12:51:54 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:51:54 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 12:51:54 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 12:51:54 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:51:54 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 12:51:54 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:51:54 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 12:51:54 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:51:54 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 12:51:54 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 12:51:54 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:51:54 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:51:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:54 INFO - https://queue.taskcluster.net/v1/task/Tfa2so9DTV--qfZQCoeSvw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:51:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tfa2so9DTV--qfZQCoeSvw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 12:51:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tfa2so9DTV--qfZQCoeSvw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 12:51:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tfa2so9DTV--qfZQCoeSvw/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 12:51:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tfa2so9DTV--qfZQCoeSvw/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 12:52:00 INFO - Downloaded 23349749 bytes. 12:52:00 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'] 12:52:00 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 12:52:01 INFO - Return code: 0 12:52:01 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 12:52:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:01 INFO - https://queue.taskcluster.net/v1/task/Tfa2so9DTV--qfZQCoeSvw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:52:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tfa2so9DTV--qfZQCoeSvw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 12:52:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tfa2so9DTV--qfZQCoeSvw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 12:52:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tfa2so9DTV--qfZQCoeSvw/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 12:52:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tfa2so9DTV--qfZQCoeSvw/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 12:52:02 INFO - Downloaded 23349749 bytes. 12:52:02 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'] 12:52:02 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 12:52:03 INFO - Return code: 0 12:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:03 INFO - https://queue.taskcluster.net/v1/task/Tfa2so9DTV--qfZQCoeSvw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:52:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tfa2so9DTV--qfZQCoeSvw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 12:52:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tfa2so9DTV--qfZQCoeSvw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 12:52:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tfa2so9DTV--qfZQCoeSvw/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 12:52:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tfa2so9DTV--qfZQCoeSvw/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 12:52:04 INFO - Downloaded 10707015 bytes. 12:52:04 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'] 12:52:04 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 12:52:04 INFO - Return code: 0 12:52:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:04 INFO - https://queue.taskcluster.net/v1/task/Tfa2so9DTV--qfZQCoeSvw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:52:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tfa2so9DTV--qfZQCoeSvw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 12:52:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tfa2so9DTV--qfZQCoeSvw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 12:52:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tfa2so9DTV--qfZQCoeSvw/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 12:52:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tfa2so9DTV--qfZQCoeSvw/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 12:52:06 INFO - Downloaded 56599143 bytes. 12:52:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Tfa2so9DTV--qfZQCoeSvw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 12:52:06 INFO - mkdir: /builds/slave/test-pgo/properties 12:52:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 12:52:06 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 12:52:06 INFO - Contents: 12:52:06 INFO - build_url:https://queue.taskcluster.net/v1/task/Tfa2so9DTV--qfZQCoeSvw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 12:52:07 INFO - Running post-action listener: _resource_record_post_action 12:52:07 INFO - Running post-action listener: set_extra_try_arguments 12:52:07 INFO - ##### 12:52:07 INFO - ##### Running populate-webroot step. 12:52:07 INFO - ##### 12:52:07 INFO - Running pre-action listener: _resource_record_pre_action 12:52:07 INFO - Running main action method: populate_webroot 12:52:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:52:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:52:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:52:07 INFO - '--tppagecycles', 12:52:07 INFO - '7'], 12:52:07 INFO - 'tests': ['tsvgm']}}, 12:52:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:52:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:52:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:52:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 12:52:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:52:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:52:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:52:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:07 INFO - 'talos_options': ['--e10s'], 12:52:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:52:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:07 INFO - 'tests': ['damp', 'tps']}, 12:52:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:07 INFO - 'talos_options': ['--e10s'], 12:52:07 INFO - 'tests': ['damp', 'tps']}, 12:52:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:52:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:52:07 INFO - 'other': {'tests': ['a11yr', 12:52:07 INFO - 'ts_paint', 12:52:07 INFO - 'tpaint', 12:52:07 INFO - 'sessionrestore', 12:52:07 INFO - 'sessionrestore_no_auto_restore']}, 12:52:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:52:07 INFO - 'tests': ['a11yr', 12:52:07 INFO - 'ts_paint', 12:52:07 INFO - 'tpaint', 12:52:07 INFO - 'sessionrestore', 12:52:07 INFO - 'sessionrestore_no_auto_restore']}, 12:52:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:52:07 INFO - 'tests': ['a11yr', 12:52:07 INFO - 'ts_paint', 12:52:07 INFO - 'tpaint', 12:52:07 INFO - 'sessionrestore', 12:52:07 INFO - 'sessionrestore_no_auto_restore']}, 12:52:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:52:07 INFO - 'tests': ['a11yr', 12:52:07 INFO - 'ts_paint', 12:52:07 INFO - 'tpaint', 12:52:07 INFO - 'sessionrestore', 12:52:07 INFO - 'sessionrestore_no_auto_restore']}, 12:52:07 INFO - 'other_l64': {'tests': ['a11yr', 12:52:07 INFO - 'ts_paint', 12:52:07 INFO - 'tpaint', 12:52:07 INFO - 'sessionrestore', 12:52:07 INFO - 'sessionrestore_no_auto_restore']}, 12:52:07 INFO - 'other_nol64': {'tests': ['a11yr', 12:52:07 INFO - 'ts_paint', 12:52:07 INFO - 'tpaint', 12:52:07 INFO - 'sessionrestore', 12:52:07 INFO - 'sessionrestore_no_auto_restore']}, 12:52:07 INFO - 'svgr': {'tests': ['tsvgx', 12:52:07 INFO - 'tsvgr_opacity', 12:52:07 INFO - 'tart', 12:52:07 INFO - 'tscrollx', 12:52:07 INFO - 'cart']}, 12:52:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:52:07 INFO - 'tests': ['tsvgx', 12:52:07 INFO - 'tsvgr_opacity', 12:52:07 INFO - 'tart', 12:52:07 INFO - 'tscrollx', 12:52:07 INFO - 'cart']}, 12:52:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:07 INFO - 'tests': ['tp5o']}, 12:52:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:07 INFO - 'talos_options': ['--e10s'], 12:52:07 INFO - 'tests': ['tp5o']}, 12:52:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:07 INFO - 'talos_options': ['--xperf_path', 12:52:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:52:07 INFO - 'tests': ['tp5n']}, 12:52:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:52:07 INFO - 'talos_options': ['--e10s', 12:52:07 INFO - '--xperf_path', 12:52:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:52:07 INFO - 'tests': ['tp5n']}}, 12:52:07 INFO - 'talos.zip': {'path': '', 12:52:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:52:07 INFO - Running post-action listener: _resource_record_post_action 12:52:07 INFO - ##### 12:52:07 INFO - ##### Running create-virtualenv step. 12:52:07 INFO - ##### 12:52:07 INFO - Running pre-action listener: _resource_record_pre_action 12:52:07 INFO - Running main action method: create_virtualenv 12:52:07 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 12:52:07 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 12:52:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 12:52:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:52:07 INFO - Using real prefix '/usr' 12:52:07 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 12:52:07 INFO - Installing distribute.............................................................................................................................................................................................done. 12:52:09 INFO - Installing pip.................done. 12:52:09 INFO - Return code: 0 12:52:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 12:52:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:09 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 0x7fdae635df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x159a8c0>, '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 0x159b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159bc50>, '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': '6dbc10da6d83fee962c624be000001a8-1455914880.598177-993953364', '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 12:52:09 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 12:52:09 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 12:52:09 INFO - Using env: {'DISPLAY': ':0', 12:52:09 INFO - 'HOME': '/home/cltbld', 12:52:09 INFO - 'LANG': 'en_US.UTF-8', 12:52:09 INFO - 'LANGUAGE': 'en_US:en', 12:52:09 INFO - 'LOGNAME': 'cltbld', 12:52:09 INFO - 'MAIL': '/var/mail/cltbld', 12:52:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:09 INFO - 'MOZ_NO_REMOTE': '1', 12:52:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:09 INFO - 'NO_EM_RESTART': '1', 12:52:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:52:09 INFO - 'PWD': '/builds/slave/test-pgo', 12:52:09 INFO - 'SHELL': '/bin/bash', 12:52:09 INFO - 'SHLVL': '1', 12:52:09 INFO - 'TERM': 'linux', 12:52:09 INFO - 'TMOUT': '86400', 12:52:09 INFO - 'USER': 'cltbld', 12:52:09 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1455914880.598177-993953364', 12:52:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:09 INFO - '_': '/tools/buildbot/bin/python'} 12:52:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:10 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 12:52:10 INFO - Cleaning up... 12:52:10 INFO - Return code: 0 12:52:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 12:52:10 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')]} 12:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:10 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')]} 12:52:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:10 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 0x7fdae635df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x159a8c0>, '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 0x159b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159bc50>, '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': '6dbc10da6d83fee962c624be000001a8-1455914880.598177-993953364', '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 12:52:10 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 12:52:10 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 12:52:10 INFO - Using env: {'DISPLAY': ':0', 12:52:10 INFO - 'HOME': '/home/cltbld', 12:52:10 INFO - 'LANG': 'en_US.UTF-8', 12:52:10 INFO - 'LANGUAGE': 'en_US:en', 12:52:10 INFO - 'LOGNAME': 'cltbld', 12:52:10 INFO - 'MAIL': '/var/mail/cltbld', 12:52:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:10 INFO - 'MOZ_NO_REMOTE': '1', 12:52:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:10 INFO - 'NO_EM_RESTART': '1', 12:52:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:52:10 INFO - 'PWD': '/builds/slave/test-pgo', 12:52:10 INFO - 'SHELL': '/bin/bash', 12:52:10 INFO - 'SHLVL': '1', 12:52:10 INFO - 'TERM': 'linux', 12:52:10 INFO - 'TMOUT': '86400', 12:52:10 INFO - 'USER': 'cltbld', 12:52:10 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1455914880.598177-993953364', 12:52:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:10 INFO - '_': '/tools/buildbot/bin/python'} 12:52:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:10 INFO - Downloading/unpacking psutil>=0.7.1 12:52:10 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 12:52:10 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 12:52:10 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 12:52:10 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 12:52:10 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 12:52:10 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 12:52:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 12:52:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:52:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:52:12 INFO - Installing collected packages: psutil 12:52:12 INFO - Running setup.py install for psutil 12:52:12 INFO - building 'psutil._psutil_linux' extension 12:52:12 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 12:52:12 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 12:52:12 INFO - building 'psutil._psutil_posix' extension 12:52:12 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 12:52:12 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 12:52:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:52:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:52:12 INFO - Successfully installed psutil 12:52:12 INFO - Cleaning up... 12:52:12 INFO - Return code: 0 12:52:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 12:52:12 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')]} 12:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:12 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')]} 12:52:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:12 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 0x7fdae635df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x159a8c0>, '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 0x159b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159bc50>, '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': '6dbc10da6d83fee962c624be000001a8-1455914880.598177-993953364', '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 12:52:12 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 12:52:12 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 12:52:12 INFO - Using env: {'DISPLAY': ':0', 12:52:12 INFO - 'HOME': '/home/cltbld', 12:52:12 INFO - 'LANG': 'en_US.UTF-8', 12:52:12 INFO - 'LANGUAGE': 'en_US:en', 12:52:12 INFO - 'LOGNAME': 'cltbld', 12:52:12 INFO - 'MAIL': '/var/mail/cltbld', 12:52:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:12 INFO - 'MOZ_NO_REMOTE': '1', 12:52:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:12 INFO - 'NO_EM_RESTART': '1', 12:52:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:52:12 INFO - 'PWD': '/builds/slave/test-pgo', 12:52:12 INFO - 'SHELL': '/bin/bash', 12:52:12 INFO - 'SHLVL': '1', 12:52:12 INFO - 'TERM': 'linux', 12:52:12 INFO - 'TMOUT': '86400', 12:52:12 INFO - 'USER': 'cltbld', 12:52:12 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1455914880.598177-993953364', 12:52:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:12 INFO - '_': '/tools/buildbot/bin/python'} 12:52:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:52:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:52:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:52:14 INFO - Installing collected packages: mozsystemmonitor 12:52:14 INFO - Running setup.py install for mozsystemmonitor 12:52:14 INFO - Successfully installed mozsystemmonitor 12:52:14 INFO - Cleaning up... 12:52:14 INFO - Return code: 0 12:52:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 12: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')]} 12:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12: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')]} 12:52:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:14 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 0x7fdae635df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x159a8c0>, '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 0x159b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159bc50>, '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': '6dbc10da6d83fee962c624be000001a8-1455914880.598177-993953364', '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 12:52:14 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 12:52:14 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 12:52:14 INFO - Using env: {'DISPLAY': ':0', 12:52:14 INFO - 'HOME': '/home/cltbld', 12:52:14 INFO - 'LANG': 'en_US.UTF-8', 12:52:14 INFO - 'LANGUAGE': 'en_US:en', 12:52:14 INFO - 'LOGNAME': 'cltbld', 12:52:14 INFO - 'MAIL': '/var/mail/cltbld', 12:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:14 INFO - 'MOZ_NO_REMOTE': '1', 12:52:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:14 INFO - 'NO_EM_RESTART': '1', 12:52:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:52:14 INFO - 'PWD': '/builds/slave/test-pgo', 12:52:14 INFO - 'SHELL': '/bin/bash', 12:52:14 INFO - 'SHLVL': '1', 12:52:14 INFO - 'TERM': 'linux', 12:52:14 INFO - 'TMOUT': '86400', 12:52:14 INFO - 'USER': 'cltbld', 12:52:14 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1455914880.598177-993953364', 12:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:14 INFO - '_': '/tools/buildbot/bin/python'} 12:52:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:15 INFO - Downloading/unpacking blobuploader==1.2.4 12:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:16 INFO - Downloading blobuploader-1.2.4.tar.gz 12:52:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:52:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:52:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 12:52:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:52:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:17 INFO - Downloading docopt-0.6.1.tar.gz 12:52:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 12:52:17 INFO - Installing collected packages: blobuploader, requests, docopt 12:52:17 INFO - Running setup.py install for blobuploader 12:52:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:52:17 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 12:52:17 INFO - Running setup.py install for requests 12:52:18 INFO - Running setup.py install for docopt 12:52:18 INFO - Successfully installed blobuploader requests docopt 12:52:18 INFO - Cleaning up... 12:52:18 INFO - Return code: 0 12:52:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:18 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 0x7fdae635df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x159a8c0>, '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 0x159b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159bc50>, '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': '6dbc10da6d83fee962c624be000001a8-1455914880.598177-993953364', '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 12:52:18 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 12:52:18 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 12:52:18 INFO - Using env: {'DISPLAY': ':0', 12:52:18 INFO - 'HOME': '/home/cltbld', 12:52:18 INFO - 'LANG': 'en_US.UTF-8', 12:52:18 INFO - 'LANGUAGE': 'en_US:en', 12:52:18 INFO - 'LOGNAME': 'cltbld', 12:52:18 INFO - 'MAIL': '/var/mail/cltbld', 12:52:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:18 INFO - 'MOZ_NO_REMOTE': '1', 12:52:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:18 INFO - 'NO_EM_RESTART': '1', 12:52:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:52:18 INFO - 'PWD': '/builds/slave/test-pgo', 12:52:18 INFO - 'SHELL': '/bin/bash', 12:52:18 INFO - 'SHLVL': '1', 12:52:18 INFO - 'TERM': 'linux', 12:52:18 INFO - 'TMOUT': '86400', 12:52:18 INFO - 'USER': 'cltbld', 12:52:18 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1455914880.598177-993953364', 12:52:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:18 INFO - '_': '/tools/buildbot/bin/python'} 12:52:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:52:18 INFO - Running setup.py (path:/tmp/pip-VuUAnp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:52:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:52:18 INFO - Running setup.py (path:/tmp/pip-5hhuLz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:52:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:52:18 INFO - Running setup.py (path:/tmp/pip-zB54n9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:52:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:52:18 INFO - Running setup.py (path:/tmp/pip-1M4unq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:52:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:52:18 INFO - Running setup.py (path:/tmp/pip-CboYGE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:52:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:52:18 INFO - Running setup.py (path:/tmp/pip-FIGkH2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:52:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:52:18 INFO - Running setup.py (path:/tmp/pip-tw4UuI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:52:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:52:19 INFO - Running setup.py (path:/tmp/pip-tCW3WD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:52:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:52:19 INFO - Running setup.py (path:/tmp/pip-8ryNZn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:52:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:52:19 INFO - Running setup.py (path:/tmp/pip-dv16Oj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:52:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:52:19 INFO - Running setup.py (path:/tmp/pip-pfTqCN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:52:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:52:19 INFO - Running setup.py (path:/tmp/pip-wxPI5v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:52:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:52:19 INFO - Running setup.py (path:/tmp/pip-jRAqDr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:52:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:52:19 INFO - Running setup.py (path:/tmp/pip-ZGFcFa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:52:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:52:19 INFO - Running setup.py (path:/tmp/pip-6lVeTj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:52:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:52:19 INFO - Running setup.py (path:/tmp/pip-aepQku-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:52:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:52:19 INFO - Running setup.py (path:/tmp/pip-TYKvxl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:52:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:52:19 INFO - Running setup.py install for manifestparser 12:52:19 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 12:52:19 INFO - Running setup.py install for mozcrash 12:52:19 INFO - Running setup.py install for mozdebug 12:52:20 INFO - Running setup.py install for mozdevice 12:52:20 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 12:52:20 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 12:52:20 INFO - Running setup.py install for mozfile 12:52:20 INFO - Running setup.py install for mozhttpd 12:52:20 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 12:52:20 INFO - Running setup.py install for mozinfo 12:52:20 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 12:52:20 INFO - Running setup.py install for mozInstall 12:52:20 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 12:52:20 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 12:52:20 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 12:52:20 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 12:52:20 INFO - Running setup.py install for mozleak 12:52:20 INFO - Running setup.py install for mozlog 12:52:20 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 12:52:20 INFO - Running setup.py install for moznetwork 12:52:20 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 12:52:20 INFO - Running setup.py install for mozprocess 12:52:20 INFO - Running setup.py install for mozprofile 12:52:21 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 12:52:21 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 12:52:21 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 12:52:21 INFO - Running setup.py install for mozrunner 12:52:21 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 12:52:21 INFO - Running setup.py install for mozscreenshot 12:52:21 INFO - Running setup.py install for moztest 12:52:21 INFO - Running setup.py install for mozversion 12:52:21 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 12:52:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:52:21 INFO - Cleaning up... 12:52:21 INFO - Return code: 0 12:52:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:52:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:21 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 0x7fdae635df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x159a8c0>, '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 0x159b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159bc50>, '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': '6dbc10da6d83fee962c624be000001a8-1455914880.598177-993953364', '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 12:52:21 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 12:52:21 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 12:52:21 INFO - Using env: {'DISPLAY': ':0', 12:52:21 INFO - 'HOME': '/home/cltbld', 12:52:21 INFO - 'LANG': 'en_US.UTF-8', 12:52:21 INFO - 'LANGUAGE': 'en_US:en', 12:52:21 INFO - 'LOGNAME': 'cltbld', 12:52:21 INFO - 'MAIL': '/var/mail/cltbld', 12:52:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:21 INFO - 'MOZ_NO_REMOTE': '1', 12:52:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:21 INFO - 'NO_EM_RESTART': '1', 12:52:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:52:21 INFO - 'PWD': '/builds/slave/test-pgo', 12:52:21 INFO - 'SHELL': '/bin/bash', 12:52:21 INFO - 'SHLVL': '1', 12:52:21 INFO - 'TERM': 'linux', 12:52:21 INFO - 'TMOUT': '86400', 12:52:21 INFO - 'USER': 'cltbld', 12:52:21 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1455914880.598177-993953364', 12:52:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:21 INFO - '_': '/tools/buildbot/bin/python'} 12:52:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:52:21 INFO - Running setup.py (path:/tmp/pip-ZlsNLH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:52:21 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)) 12:52:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:52:21 INFO - Running setup.py (path:/tmp/pip-QTuFTL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:52:21 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)) 12:52:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:52:21 INFO - Running setup.py (path:/tmp/pip-vHAXko-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:52:21 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)) 12:52:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:52:21 INFO - Running setup.py (path:/tmp/pip-Kpo8s5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:52:22 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)) 12:52:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:52:22 INFO - Running setup.py (path:/tmp/pip-0lT_BT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:52:22 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)) 12:52:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:52:22 INFO - Running setup.py (path:/tmp/pip-0oQvvs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:52:22 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)) 12:52:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:52:22 INFO - Running setup.py (path:/tmp/pip-ZXOn4K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:52:22 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)) 12:52:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:52:22 INFO - Running setup.py (path:/tmp/pip-7Yv4Yp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:52:22 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)) 12:52:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:52:22 INFO - Running setup.py (path:/tmp/pip-_yfYLk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:52:22 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)) 12:52:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:52:22 INFO - Running setup.py (path:/tmp/pip-AYkPll-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:52:22 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)) 12:52:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:52:22 INFO - Running setup.py (path:/tmp/pip-u8ZF_Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:52:22 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)) 12:52:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:52:22 INFO - Running setup.py (path:/tmp/pip-V0r9Zs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:52:22 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)) 12:52:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:52:22 INFO - Running setup.py (path:/tmp/pip-301vcV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:52:22 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)) 12:52:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:52:22 INFO - Running setup.py (path:/tmp/pip-p9BdK7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:52:22 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)) 12:52:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:52:22 INFO - Running setup.py (path:/tmp/pip-vMtCk2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:52:22 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)) 12:52:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:52:22 INFO - Running setup.py (path:/tmp/pip-NgDm9C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:52:22 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)) 12:52:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:52:22 INFO - Running setup.py (path:/tmp/pip-GOG2Nf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:52:22 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)) 12:52:22 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)) 12:52:22 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)) 12:52:22 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)) 12:52:22 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)) 12:52:22 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)) 12:52:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 12:52:23 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 12:52:23 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 12:52:23 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 12:52:23 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 12:52:23 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 12:52:23 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 12:52:24 INFO - Downloading blessings-1.6.tar.gz 12:52:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 12:52:24 INFO - Installing collected packages: blessings 12:52:24 INFO - Running setup.py install for blessings 12:52:24 INFO - Successfully installed blessings 12:52:24 INFO - Cleaning up... 12:52:25 INFO - Return code: 0 12:52:25 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 12:52:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:52:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:52:25 INFO - Reading from file tmpfile_stdout 12:52:25 INFO - Current package versions: 12:52:25 INFO - argparse == 1.2.1 12:52:25 INFO - blessings == 1.6 12:52:25 INFO - blobuploader == 1.2.4 12:52:25 INFO - docopt == 0.6.1 12:52:25 INFO - manifestparser == 1.1 12:52:25 INFO - mozInstall == 1.12 12:52:25 INFO - mozcrash == 0.16 12:52:25 INFO - mozdebug == 0.1 12:52:25 INFO - mozdevice == 0.48 12:52:25 INFO - mozfile == 1.2 12:52:25 INFO - mozhttpd == 0.7 12:52:25 INFO - mozinfo == 0.9 12:52:25 INFO - mozleak == 0.1 12:52:25 INFO - mozlog == 3.1 12:52:25 INFO - moznetwork == 0.27 12:52:25 INFO - mozprocess == 0.22 12:52:25 INFO - mozprofile == 0.28 12:52:25 INFO - mozrunner == 6.11 12:52:25 INFO - mozscreenshot == 0.1 12:52:25 INFO - mozsystemmonitor == 0.0 12:52:25 INFO - moztest == 0.7 12:52:25 INFO - mozversion == 1.4 12:52:25 INFO - psutil == 3.1.1 12:52:25 INFO - requests == 1.2.3 12:52:25 INFO - wsgiref == 0.1.2 12:52:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:52:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:25 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 0x7fdae635df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x159a8c0>, '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 0x159b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159bc50>, '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': '6dbc10da6d83fee962c624be000001a8-1455914880.598177-993953364', '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 12:52:25 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 12:52:25 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 12:52:25 INFO - Using env: {'DISPLAY': ':0', 12:52:25 INFO - 'HOME': '/home/cltbld', 12:52:25 INFO - 'LANG': 'en_US.UTF-8', 12:52:25 INFO - 'LANGUAGE': 'en_US:en', 12:52:25 INFO - 'LOGNAME': 'cltbld', 12:52:25 INFO - 'MAIL': '/var/mail/cltbld', 12:52:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:25 INFO - 'MOZ_NO_REMOTE': '1', 12:52:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:25 INFO - 'NO_EM_RESTART': '1', 12:52:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:52:25 INFO - 'PWD': '/builds/slave/test-pgo', 12:52:25 INFO - 'SHELL': '/bin/bash', 12:52:25 INFO - 'SHLVL': '1', 12:52:25 INFO - 'TERM': 'linux', 12:52:25 INFO - 'TMOUT': '86400', 12:52:25 INFO - 'USER': 'cltbld', 12:52:25 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1455914880.598177-993953364', 12:52:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:25 INFO - '_': '/tools/buildbot/bin/python'} 12:52:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:25 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)) 12:52:25 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)) 12:52:25 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)) 12:52:25 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)) 12:52:25 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)) 12:52:25 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)) 12:52:25 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)) 12:52:25 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)) 12:52:25 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)) 12:52:25 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)) 12:52:25 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)) 12:52:25 INFO - Cleaning up... 12:52:25 INFO - Return code: 0 12:52:25 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 12:52:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdae635df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x159a8c0>, '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 0x159b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159bc50>, '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': '6dbc10da6d83fee962c624be000001a8-1455914880.598177-993953364', '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 12:52:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 12:52:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:52:25 INFO - Using env: {'DISPLAY': ':0', 12:52:25 INFO - 'HOME': '/home/cltbld', 12:52:25 INFO - 'LANG': 'en_US.UTF-8', 12:52:25 INFO - 'LANGUAGE': 'en_US:en', 12:52:25 INFO - 'LOGNAME': 'cltbld', 12:52:25 INFO - 'MAIL': '/var/mail/cltbld', 12:52:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:25 INFO - 'MOZ_NO_REMOTE': '1', 12:52:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:25 INFO - 'NO_EM_RESTART': '1', 12:52:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:52:25 INFO - 'PWD': '/builds/slave/test-pgo', 12:52:25 INFO - 'SHELL': '/bin/bash', 12:52:25 INFO - 'SHLVL': '1', 12:52:25 INFO - 'TERM': 'linux', 12:52:25 INFO - 'TMOUT': '86400', 12:52:25 INFO - 'USER': 'cltbld', 12:52:25 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1455914880.598177-993953364', 12:52:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:25 INFO - '_': '/tools/buildbot/bin/python'} 12:52:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:25 INFO - Downloading/unpacking jsonschema 12:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:52:27 INFO - Downloading/unpacking functools32 (from jsonschema) 12:52:27 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 12:52:27 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 12:52:27 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 12:52:27 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 12:52:27 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 12:52:27 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 12:52:27 INFO - Downloading functools32-3.2.3-2.tar.gz 12:52:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 12:52:27 INFO - warning: no files found matching '*.txt' 12:52:27 INFO - no previously-included directories found matching 'build' 12:52:27 INFO - no previously-included directories found matching 'dist' 12:52:27 INFO - no previously-included directories found matching '.git*' 12:52:27 INFO - Installing collected packages: jsonschema, functools32 12:52:27 INFO - Running setup.py install for functools32 12:52:27 INFO - warning: no files found matching '*.txt' 12:52:27 INFO - no previously-included directories found matching 'build' 12:52:27 INFO - no previously-included directories found matching 'dist' 12:52:27 INFO - no previously-included directories found matching '.git*' 12:52:27 INFO - Successfully installed jsonschema functools32 12:52:27 INFO - Cleaning up... 12:52:28 INFO - Return code: 0 12:52:28 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 12:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:28 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdae635df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x159a8c0>, '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 0x159b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159bc50>, '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': '6dbc10da6d83fee962c624be000001a8-1455914880.598177-993953364', '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 12:52:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 12:52:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:52:28 INFO - Using env: {'DISPLAY': ':0', 12:52:28 INFO - 'HOME': '/home/cltbld', 12:52:28 INFO - 'LANG': 'en_US.UTF-8', 12:52:28 INFO - 'LANGUAGE': 'en_US:en', 12:52:28 INFO - 'LOGNAME': 'cltbld', 12:52:28 INFO - 'MAIL': '/var/mail/cltbld', 12:52:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:28 INFO - 'MOZ_NO_REMOTE': '1', 12:52:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:28 INFO - 'NO_EM_RESTART': '1', 12:52:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:52:28 INFO - 'PWD': '/builds/slave/test-pgo', 12:52:28 INFO - 'SHELL': '/bin/bash', 12:52:28 INFO - 'SHLVL': '1', 12:52:28 INFO - 'TERM': 'linux', 12:52:28 INFO - 'TMOUT': '86400', 12:52:28 INFO - 'USER': 'cltbld', 12:52:28 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1455914880.598177-993953364', 12:52:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:28 INFO - '_': '/tools/buildbot/bin/python'} 12:52:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:28 INFO - Downloading/unpacking flake8 12:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:52:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:52:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 12:52:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:52:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:52:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:52:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:52:30 INFO - no previously-included directories found matching 'docs/_build' 12:52:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:52:30 INFO - Running setup.py install for pep8 12:52:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:52:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:52:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:52:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:52:30 INFO - no previously-included directories found matching 'docs/_build' 12:52:30 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 12:52:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:52:30 INFO - Cleaning up... 12:52:30 INFO - Return code: 0 12:52:30 INFO - Running post-action listener: _resource_record_post_action 12:52:30 INFO - Running post-action listener: _start_resource_monitoring 12:52:31 INFO - Starting resource monitoring. 12:52:31 INFO - ##### 12:52:31 INFO - ##### Running install step. 12:52:31 INFO - ##### 12:52:31 INFO - Running pre-action listener: _resource_record_pre_action 12:52:31 INFO - Running main action method: install 12:52:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:52:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:52:31 INFO - Reading from file tmpfile_stdout 12:52:31 INFO - Detecting whether we're running mozinstall >=1.0... 12:52:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 12:52:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 12:52:31 INFO - Reading from file tmpfile_stdout 12:52:31 INFO - Output received: 12:52:31 INFO - Usage: mozinstall [options] installer 12:52:31 INFO - Options: 12:52:31 INFO - -h, --help show this help message and exit 12:52:31 INFO - -d DEST, --destination=DEST 12:52:31 INFO - Directory to install application into. [default: 12:52:31 INFO - "/builds/slave/test-pgo"] 12:52:31 INFO - --app=APP Application being installed. [default: firefox] 12:52:31 INFO - mkdir: /builds/slave/test-pgo/build/application 12:52:31 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'] 12:52:31 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 12:52:47 INFO - Reading from file tmpfile_stdout 12:52:47 INFO - Output received: 12:52:47 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 12:52:47 INFO - Running post-action listener: _resource_record_post_action 12:52:47 INFO - ##### 12:52:47 INFO - ##### Running run-tests step. 12:52:47 INFO - ##### 12:52:47 INFO - Running pre-action listener: _resource_record_pre_action 12:52:47 INFO - Running main action method: run_tests 12:52:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 12:52:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 12:52:47 INFO - Python 2.7.3 12:52:47 INFO - Return code: 0 12:52:47 INFO - grabbing minidump binary from tooltool 12:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:47 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 0x159a8c0>, '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 0x159b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159bc50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 12:52:47 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 12:52:47 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 12:52:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:52:47 INFO - Return code: 0 12:52:47 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 12:52:47 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 12:52:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 12:52:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 12:52:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 12:52:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 12:52:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 12:52:48 INFO - Return code: 0 12:52:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Tfa2so9DTV--qfZQCoeSvw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 12:52:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Tfa2so9DTV--qfZQCoeSvw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 12:52:48 INFO - Using env: {'DISPLAY': ':0', 12:52:48 INFO - 'HOME': '/home/cltbld', 12:52:48 INFO - 'LANG': 'en_US.UTF-8', 12:52:48 INFO - 'LANGUAGE': 'en_US:en', 12:52:48 INFO - 'LOGNAME': 'cltbld', 12:52:48 INFO - 'MAIL': '/var/mail/cltbld', 12:52:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:52:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 12:52:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:48 INFO - 'MOZ_NO_REMOTE': '1', 12:52:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:52:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:48 INFO - 'NO_EM_RESTART': '1', 12:52:48 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:52:48 INFO - 'PWD': '/builds/slave/test-pgo', 12:52:48 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 12:52:48 INFO - 'SHELL': '/bin/bash', 12:52:48 INFO - 'SHLVL': '1', 12:52:48 INFO - 'TERM': 'linux', 12:52:48 INFO - 'TMOUT': '86400', 12:52:48 INFO - 'USER': 'cltbld', 12:52:48 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1455914880.598177-993953364', 12:52:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:48 INFO - '_': '/tools/buildbot/bin/python'} 12:52:48 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Tfa2so9DTV--qfZQCoeSvw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 12:52:48 INFO - mozversion application_buildid: 20160219103113 12:52:48 INFO - mozversion application_changeset: 69ec3dc408a2a720cb2b8210fea33e3504aeec22 12:52:48 INFO - mozversion application_display_name: Nightly 12:52:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:52:48 INFO - mozversion application_name: Firefox 12:52:48 INFO - mozversion application_remotingname: firefox 12:52:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:52:48 INFO - mozversion application_vendor: Mozilla 12:52:48 INFO - mozversion application_version: 47.0a1 12:52:48 INFO - mozversion platform_buildid: 20160219103113 12:52:48 INFO - mozversion platform_changeset: 69ec3dc408a2a720cb2b8210fea33e3504aeec22 12:52:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:52:48 INFO - mozversion platform_version: 47.0a1 12:52:48 INFO - using testdate: 1455915168 12:52:48 INFO - actual date: 1455915168 12:52:48 INFO - starting webserver on 'localhost:55690' 12:52:48 INFO - SUITE-START | Running 2 tests 12:52:48 INFO - TEST-START | dromaeo_css 12:52:48 INFO - operating with platform_type : linux_ 12:52:48 INFO - Initialising browser for dromaeo_css test... 12:52:49 INFO - TEST-INFO | started process 4182 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1n0kZM/profile http://localhost:55690/getInfo.html) 12:52:52 INFO - PROCESS | 4182 | __metrics Screen width/height:1600/1200 12:52:52 INFO - PROCESS | 4182 | colorDepth:24 12:52:52 INFO - PROCESS | 4182 | Browser inner width/height: 1024/697 12:52:52 INFO - PROCESS | 4182 | __metrics 12:52:54 INFO - PROCESS | 4182 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:52:54 INFO - TEST-INFO | 4182: exit 0 12:52:54 INFO - Browser initialized. 12:52:54 INFO - Running cycle 1/1 for dromaeo_css test... 12:52:54 INFO - TEST-INFO | started process 4277 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1n0kZM/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:53:06 INFO - PROCESS | 4277 | RSS: Main: 147771392 12:53:06 INFO - PROCESS | 4277 | 12:53:57 INFO - PROCESS | 4277 | 1455915237966 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] 12:56:06 INFO - PROCESS | 4277 | Cycle 1(1): loaded http://localhost:55690/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55690/tests/dromaeo/cssquery-ext.html) 12:56:06 INFO - PROCESS | 4277 | RSS: Main: 222904320 12:56:06 INFO - PROCESS | 4277 | 12:59:09 INFO - PROCESS | 4277 | Cycle 1(1): loaded http://localhost:55690/tests/dromaeo/cssquery-ext.html (next: http://localhost:55690/tests/dromaeo/cssquery-jquery.html) 12:59:09 INFO - PROCESS | 4277 | RSS: Main: 241545216 12:59:09 INFO - PROCESS | 4277 | 13:02:11 INFO - PROCESS | 4277 | Cycle 1(1): loaded http://localhost:55690/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55690/tests/dromaeo/cssquery-mootools.html) 13:02:12 INFO - PROCESS | 4277 | RSS: Main: 247484416 13:02:12 INFO - PROCESS | 4277 | 13:05:14 INFO - PROCESS | 4277 | Cycle 1(1): loaded http://localhost:55690/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55690/tests/dromaeo/cssquery-prototype.html) 13:05:14 INFO - PROCESS | 4277 | RSS: Main: 214523904 13:05:14 INFO - PROCESS | 4277 | 13:08:17 INFO - PROCESS | 4277 | Cycle 1(1): loaded http://localhost:55690/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55690/tests/dromaeo/cssquery-yui.html) 13:08:17 INFO - PROCESS | 4277 | RSS: Main: 195203072 13:08:17 INFO - PROCESS | 4277 | 13:11:20 INFO - PROCESS | 4277 | Cycle 1(1): loaded http://localhost:55690/tests/dromaeo/cssquery-yui.html (next: http://localhost:55690/tests/dromaeo/cssquery-dojo.html) 13:11:20 INFO - PROCESS | 4277 | RSS: Main: 376705024 13:11:20 INFO - PROCESS | 4277 | 13:11:20 INFO - PROCESS | 4277 | __start_tp_report 13:11:20 INFO - PROCESS | 4277 | _x_x_mozilla_page_load 13:11:20 INFO - PROCESS | 4277 | _x_x_mozilla_page_load_details 13:11:20 INFO - PROCESS | 4277 | |i|pagename|runs| 13:11:20 INFO - PROCESS | 4277 | |0;dojo.html;3086.73762730168;3099.7210251077427;3140.167855518288;3146.354997225569;3166.9524957125645;5035.370578677665;5046.571041461476;5094.821681241153;5103.055934652092;5130.461301563338;5032.874178145548;5086.821961231349;5090.9236361454605;5094.210397388401;5094.490550944904;4675.953240467603;4727.5272472752795;4774.1645212087915;4795.688280261789;4804.231322988305;4650.441946966369;4684.765761711918;4742.928856067162;4749.358836557055;4858.0283943211325;4725.267583524559;4729.881752956169;4734.289856521515;4745.501722319142;4780.37855078841;4723.220668589679;4730.645201609893;4740.265258884879;4741.051789642051;4762.857114286577;4632.953670463286;4669.813207471697;4701.036287561042;4703.482616912137;4716.103940251342;4897.436794768611;4898.093852637274;4908.190148625473;4909.3126962225315;4915.16442204826;5463.48096930791;5491.176323551459;5571.8607034824045;5597.888042239132;5619.971900140473;5476.863078423032;5480.725963701839;5482.17767334899;5500.614956953015;5515.283013208297;5095.668781529189;5137.897242055175;5144.459831717653;5150.9742451287875;5193.221016847428;5532.695701736363;5620.381758006616;5652.406497317805;5654.5193658538665;5699.088145896637;5372.973135134299;5395.298611180521;5406.648567843077;5436.483534064258;5441.863953401196;5391.541718953855;5455.781768729285;5502.8349149525575;5505.8066321533415;5572.832815015475;5470.097433923358;5483.095289277305;5487.835364939058;5494.313210848644;5496.560275178056;5476.534494568006;5482.780688772485;5483.917741233885;5490.862728431741;5547.084731019337;4230.450041494586;4293.635041021548;4340.956590434055;4352.717073390219;4396.582324679151;3826.789526576065;3847.0574709196426;3863.439801228806;3876.972602260403;3887.4363217333894;5051.090803655304;5138.177891537411;5152.3044389007755;5171.069207542679;5223.634345595848;5475.123980163155;5482.671039737628;5491.423400542965;5502.064649009678;5545.805896793593;5067.163917953497;5120.1039818031695;5120.48795120485;5127.077126117335;5167.328247327899;4616.422947131608;4678.345031695565;4722.409698787652;4771.045790841846;4806.927896081562;5673.205751194836;5687.715614219355;5699.772009119589;5710.143478478261;5727.083666613322;5415.539679127318;5474.069408200536;5483.7806487740045;5489.204065410573;5536.169574563848;5709.058005429224;5748.913766293593;5774.307083150049;5776.566757493289;5839.299284085937;5418.701971391612;5428.240046393429;5431.34823821144;5437.891242175214;5438.864028399322;5410.404855465817;5496.945030549803;5507.201455788968;5556.611037227355;5632.070708333079;5328.866778330573;5332.706701131475;5347.064263753905;5355.410904800547;5357.1696387060065;5355.357357117015;5374.193870919237;5374.973125134349;5381.27352807366;5416.133418652997;5182;5223.555997740083;5293.682379057269;5296.311479507639;5331.866703332447;5306.389765176899;5354.6251762377815;5400.594955378441;5402.783888644567;5419.539339156216;5211.1922651989;5314.734263286898;5318.361796584435;5332.706701131475;5375.247465354775 13:11:20 INFO - PROCESS | 4277 | |1;ext.html;521.9947800521996;529.8701818054577;533.9786408543658;551.9944800551995;583.7548229743508;28673.713262867364;28982.710172898318;29119.56320655189;29135.562966555466;29151.125466236048;29420.705792942117;37605;38046;38064.42903356452;38074.61925380752;8289.129641387657;8471.195236452528;8472.406931514797;8478.364122690791;8481.491110533358;7622.390208783284;8398.958005209965;8533.530655813927;8536.487810731376;10123.949380253125;10099.192064634812;10209.795804083913;10212.591496340137;10218;10225.335353202056;9996.050375214343;10086.848697269474;10105.242106841943;10120.392776433364;10123.493825308742;9947.353422027545;10078.193744500422;10079.395236285847;10082.899171008343;10089.142422894063;37521;37623.811880940695;37967;37994.62005379939;41498;3266.1344743642953;3474.6004209515977;3664.926701465982;3778.659920607131;4008.579099194572;29535.70464295351;29691;30235.848820755757;30608.2347941301;30965.22586935322;3864.8840534784003;3868.2650296443585;3965.0682089709185;3975.6819454443576;3993.1614360984227;291348;291349;291714;291799.9999999979;293463;58901.41098589045;59200.40799592035;59729;59748.70125649344;59803;62054;62175;62363.6881815588;62389.37610623836;62394.376056238856;15076.924615377073;15523.223838808015;15545.922270388575;15554.688906221812;15564.455244066403;9980.101790838859;11712.765744685059;11773.17587768848;11785.941070294593;11788.174827762146;19028.429147125607;19419.39554734107;20106.296279630144;20278.290259840836;20366.89816550908;7783.883241751379;7932.801679958047;8003.8799418008775;8061.919380806235;8077.555734434545;982.8918818929913;986.5708416838698;1026.7022563456662;1033.8397548380012;1048.2033654422694;28914.566281505795;29079.54602269878;29253.817688540672;29755;29884.701152988626;1004.0361253197012;1021.7445638590352;1052.9684109476727;1061.0715623829149;1102.4322473925934;13144.539941102206;13167.868321316855;13358.933205334106;13363.131396459394;13452.730945381038;319875;320871;321128;323154;323235;51314.74342628263;51666.22500662493;51679;51683;51707.224391634154;1400.838903526087;1407.2260256858688;1423.2456797897132;1425.921574313402;1425.942962281497;25168.622470663322;26569.468610628064;26905.730942691105;26916.73083269142;27008.1897543074;42945;43642.56357436512;43686.12627747364;43838.78080609577;43839.12321753611;279016.209837899;288173;289432;289497;290092;26954.460910782065;30549.847250763603;31094.689053109178;31186.844065780435;31510.369792604477;37248;37324.62675373212;38122;38218.808905955295;38475;31136;32077.358452830347;32116.678833212303;32171.195720107185;32430.83784581062;28297.292567685974;31969.68030319667;32415.675843241264;35019;36239.45640815337;32654;32876.50685239676;32946.5058024125;33002.339953201285;33029.33941321208;25858.741412585634;29368.559471607514;30438.517630607043;30483.69516304897;30503.694963050086;24830.875845620656;25051.498970020133;25147.24558263255;25207.621885671364;25538.872305638353 13:11:20 INFO - PROCESS | 4277 | |2;jquery.html;360.8105744484146;363.8017280582083;366.9853205871764;368.10733970122465;373.59278386558645;13860.099093558913;14053;16213.432529861457;16687.582810429747;17511.124443777822;11008.669739907795;11324.03745681618;16936.40722574707;17224.56938576536;17236.310547578083;4829.613630909519;4936.06214819185;4947.876303092416;4950.133726597849;4997.900041999158;3840.5007349044586;4950.876228094308;6456.870862582746;6703.798886033427;6713.69788359525;6596;6601.66991650418;6649.035889795977;6692.23039350476;6769.221539522969;6393;6601.50488713346;6608.480049588574;6669.899951500732;6735.494837887153;6415;6455.096286519891;6458;6461.386168314003;6468.514861385368;22197.22309719152;22586.096556137898;23162.65256021161;23323.650145247833;23480;2430.3559556717482;2849.6580410350684;2918.649762028549;3065.6781037990913;3220.2915358621067;13229.140105893182;13859.168449892937;14346.64133396663;14440.277986100758;14826.777598336033;2002.1690998235715;2023.5685043600265;2059.392479218619;2069.8344132469365;2108.7996640319143;52200.477995220324;64539.354606454275;65246.67376663086;71746.28253717448;73401;14792.482263120954;15490.457833975757;15512.06927584326;15521.534353969399;15533.068015919082;23963.7603623965;23976;24338.148164814145;24421.75578244195;24510.632340514905;7165.6775445105095;7508.924910750932;7531.171571127172;7612.8477430451085;7616.581088040211;7139.464540159405;7449.739259126013;7474.551526908403;7485.812854678567;7515.924840751522;4385.079133381962;4389.319655453346;4435.556444355539;4470.7764611769935;4512.458504979423;1832.8900265984084;1879.9530011749816;1881.4073566826405;1881.4637828218893;1890.810918908098;764.4381379685926;833.1293797981003;837.5226121111031;896.5338024227365;918.4168053286211;15625.453109141126;16278;16296.755548666779;16529.917350413412;16563.585910352336;775.9107702614159;910.9863352049724;948.2840455456225;975.4098770244042;983.8622592837008;8539.786505337417;9070.954645226864;9086.363954523253;9115.407498512708;9198.080191980749;421586;424777;464828;474645;478865;70705.29294706987;72105;75264.62367688127;75317;75809;998.5656239535825;1001.3140998415963;1021.8824835144054;1032.1175395037135;1038.0242571982462;15294.847051529343;15537.223138842786;15644.765328519854;15697.29362178682;15943;25361.365965851;27540.311492212855;32563.837180813945;33021.50467743034;33546.32907341791;42384.364234537126;45498.54501454943;45517.31724024076;45519.54480455153;45633.31550026819;7665;7757.495762775401;7764.34003109742;7834.804129896798;7926.286634202949;10925.726856828325;11401.942990284995;11615;11673.649790506299;12246.510139594673;7782.377409807315;9675.274354423305;9883.061109194616;9951.353162044445;10291.433971131659;10125.898741012496;10174.949125254327;10408.635697750542;10567.94716026415;10695.197860160364;10391.792164156523;10411.167106631603;10485.423301718478;10503.42231177262;10658.307210031324;7728.343090837342;7989.641760900777;7995.840083198187;8037.115917248981;8054.154313796967;9621.326507144433;10707.571697132027;10722.946385268337;10889.128869690247;10927.617533386294 13:11:20 INFO - PROCESS | 4277 | |3;mootools.html;1333.7199188170484;1477.490265858279;1498.3257534109646;1669.6911071451782;1824.1244202782655;6916.6887490062945;7845.568493732842;8053.557054362001;8078;8092.352611791057;7876.724314648988;8035.477693949889;8043.155468675793;8056;8057.516549007064;1967.7146813712004;2227.9554408911813;2290.335802617239;2305.0318866076286;2331.5803155432013;2334.311378143443;2336.5910965581043;2345.812335013195;2347.307544274443;2348.518553696497;2280.5552917181158;2287.6911616931666;2290.3129061281547;2290.679304897316;2291.862488250702;2281.977180228193;2365.929022129339;2369.8815059247054;2370.5495955768347;2370.8458950168183;2328.988355058231;2330.044681680503;2333.5216280662426;2362.4566349739484;2372;6467.288598254188;6632.801015969529;8114.9594252028955;8190.303824174893;8190.4266701330935;4746.572808447222;4848.85453436394;4893.168161412568;4897.6326775491625;4901;3236.4336241157703;3241.1896234442156;3283.835808209604;3384.8646054157803;3478.478228265755;1011.180943435812;1014.0873214107289;1037.305005646219;1053.4416759117603;1061.8566493523354;11441.885581144164;11530.48112834916;11547.769044619145;11583.710407239801;11585.594504192313;4351.8694439166875;4370.453693288339;4419.955800442019;4510.571495707903;4522.366868638327;9955.701328959998;9971.302008859455;9992.750181245381;9992.900070999198;10007.299489035844;4329.19909816685;4907.877303067452;4988.152014157602;5008.874778130576;5071.8985620287385;4505.729656220572;4535.455745310584;4542.227821270392;4550.544945505423;4557.749323787158;3844.500214972036;3871.8838434847;3892.754318618015;3921.5490218624655;3930.1353702185475;1196.3300551691082;1246.8056221050833;1251.8310028146266;1265.3420221484776;1268.2010333489843;1062.8193207154802;1078.1051727066515;1087.8205096159204;1231.8029115341503;1353.5059703208258;7577.16651168371;7660.463767536219;7669.271419215165;7672.539647621161;7827.882581761278;441.79456552703147;453.3766071651479;456.24719213298323;458.0541182458213;461.7875777142552;5775.6823374714795;5846.444587764156;5849.298084229919;5857.531397488191;5886.735096920649;8901.599428025755;9167.17495425415;9187.127222913812;9202.355835091614;9678.661246856467;9120.224780893566;9170.67902623405;9175.908240917639;9176.587053582605;9202;7538.773836784905;7665.156832748393;7669.309762121436;7774.766756997186;7787.649555770004;7605.581693006938;7617.352525035212;7674.155842857393;7683.462157648911;7702.037245344332;8853.291736660924;8867.512286824029;9236.676716314896;9258.35191536586;9284.3036772241;9241.768955776159;9322.813543728951;9527.666531671359;9544.284178686488;9675.661351852652;6224.564280500322;6946.235914049552;6982.511224214256;7025.367716905503;7138.357547820721;7804.609769511615;7811.726589569338;7826.356465142157;7855.293023627901;7864.449488535976;6863.759768408082;7011.824704382431;7012.859742805217;7122.964385178041;7126.608036558039;7076.363127318566;7078.68145933424;7094.53885497441;7176.461765367722;7187.425005999403;6986.580805151707;7143.892841607484;7147.499675022907;7157.64211789398;7392.778216653509;6658.201015878126;6678.83302917431;6705.530612857053;6728.226253980855;6728.932710673026;6408.9038664421005;6559.836004099936;6559.967200163968;6595.703193356407;6599.142111525663 13:11:20 INFO - PROCESS | 4277 | |4;prototype.html;336.07411581094095;336.3525213963121;338.51085181912117;339.8919522357115;347.0213996529785;5788.27646544182;5811.9999999999945;5821.825345239649;5838.503727183189;5854.063349864023;5774.335951365594;5785.595008349417;5792.565557583177;5796.362400135981;5802.912956305659;4526.072155208174;4527.796249168779;4533.9546604534025;4534.705244159128;4535.070310586339;4452.910941781162;4480.215962206617;4514.480834704018;4536.54634536547;4539.659525535598;4405.8237670493145;4428.911421771562;4455.465344158705;4475.910481790363;4480.417545719069;4226.619604235603;4321.135772845443;4481.8207271708925;4486.528914463983;4489.079738653584;3751.3247615429214;3756.5867754547253;3757.28611563802;3841.4621952926614;3958.0302825807576;5446.657937087051;5500.889982200373;5507.339119305709;5514.834554963358;5517.282753242093;5174.818881339135;5182.041322355376;5185.766640501149;5194.506521880416;5196.090684130262;5924.341184468312;6040.124181993587;6130.969345153246;6140;6141.570090093695;4347.217500849846;4356.782160891943;4357.7385356878685;4365.541618130114;4374.6500279977845;6438.549301548894;6443.29123796382;6446.742130314782;6447.709853056624;6448.355164483561;4207.116505533811;4326.783660816946;4337.544557821447;4458.487273963471;4463.486699029589;4365.279728844768;4369.650427965818;4379;4380.496242932039;4388.4733831940375;5081.364829396325;5093.821716239914;5098.311727916758;5105.132127538327;5106.719130447861;6227.501799856001;6240.438360547481;6243.968780156161;6247.2815626202655;6255.093011513305;1529.3601229074952;1535.7542793153266;1540.414642435867;1555.5022392834185;1559.7738327942384;1015.6242190389455;1037.6108959140322;1043.645160645369;1044.8223801953686;1045.4877110216091;5864.179014937912;5875.559333050039;5875.823725288248;5877.38287479817;5879.853003674943;6365.49076073913;6371.139896114058;6375.840603984845;6376.776812811529;6381.585196962183;5852.707364631837;5866.941330586639;5867.618604790675;5868.559858010666;5876.089206172965;3311.718503927145;3342.699157075875;3379.831008449568;3435.793852368866;3445.776024558396;6608.570442921195;6629.237637671729;6638.933610663928;6638.933610663928;6651.667416629246;6487.286398496161;6578.703958321887;6579.440747536417;6579.934200658028;6586.769463068769;6484.902726459107;6665.066890635315;6665.100211471487;6704.865902681919;6711.194656641137;6425.8714825704155;6430.228372595318;6455.354464553507;6464.5798023128345;6469.45009674183;6399.2640846303275;6403.615783053032;6412.1343618612755;6412.551121421456;6415.582987105823;6453.612783233021;6725.630090344882;6740.191177058784;6742.898856517058;6750.6624668767345;4300.720453170659;4323.329883868006;4325.6106950374615;4329.76186309756;4332.805023774001;6437.871242575216;6439.195100612424;6444.645544495098;6452.096706461193;6454.741810327534;6099.2985806632805;6263.6241825490615;6269.62382257066;6283.59156654816;6307.306196318493;6242.406971337716;6253.405926436982;6255.499560035278;6265.530085243534;6269.811905642838;6147.293061298008;6168.907466388097;6170.413810687977;6171.9691401542705;6173.84565385869;6180.721867515883;6288.371162883675;6290.874182516232;6298.748050077946;6308.495320374451;6099.11562823397;6108.08378743192;6123.387661233841;6157.261128664589;6162.044883043135 13:11:20 INFO - PROCESS | 4277 | |5;yui.html;699.087690563814;746.5334166146158;783.2089589514588;798.4371018432003;814.7840822182121;13883.097598656093;13998.720025599481;14083.788743168849;14106.224157671324;14125.011249212559;13181.275029873354;13257.93371033146;13275.203487790739;13291.335433228323;13297.734045319112;664.4020381656524;671.2884342596863;817.7873752824249;820.3232333325001;839.7900524868783;819.2872201184978;821.9589020548979;823.0534884882373;829.2205326992607;829.3738227638124;876.0319846569545;884.2218847414299;884.5179377239419;885.026470882031;885.7298523950193;697.2086681616377;862.1292494580488;876.4390789894472;878.5738916625431;879.1955360844819;649.503130105465;649.6784091874553;649.7011374767612;649.8310439285773;650.0866282872572;13628.11417257885;13640.795388069188;13651.931740341333;13690.589282321545;13706.52027179054;12981;13530.526431574848;13762.105463144864;13867.09863858856;13917.582472525739;10423.68728938133;10792.298500597515;10986.890131098746;11131.387773672444;11725.355105469196;4292.3561465780385;4375.409319741826;4393.275109606911;4465.9106817863785;4467.463904331468;51208;51692;51866.481335186545;51891.48108518904;51927.48072519264;9856.5564549594;9864.556094975744;9914.355566888129;10213.846792298122;10276.383416995004;18322.26710931548;18408.35570755044;18418.263269469073;18427.81572184288;18429.907850460662;7631.732889348847;7738.032745906762;7745.070591529053;7749.4575379724;7936.2857342839425;4258.787060646955;4262.573742625713;4373;4395.230834603932;4443.422355093817;3187.729043031322;3229.564008858774;3241.918952026218;3241.994981555678;3253.902382928516;586.0330454749698;591.6391001489088;605.9303180134341;641.3842710997494;660.3429587560408;603.8460192650933;654.9115869357671;656.6552559906088;691.1498856406648;713.0637443284676;8121.390895682729;8640.740777776677;8678.175573320525;8703.521306328214;8745.650173993095;538.3163382504198;671.5903298987614;690.126989358462;697.1647311998504;717.2719689515146;3957.426173204869;3966.5636779954184;4015.77913214776;4018.4374187613757;4092.3043082676018;54670.453295466534;56065.159022614695;56438.71780641071;56460.43539564634;56563;48839;48948.75525622349;49094;49698;50505.242421363706;44224.55775442269;44967;45046.32430513545;45366.31950520745;46225.537744622794;7695.345895598937;8233.38249631268;8413.032501262189;8612.224899759052;8845.203931646183;32987.505187421724;33210.33579328448;33579.328413432086;34288;34751.304973900886;42416.1516769669;42920.57079429291;42948.1410371797;43058.35412468878;43978.34032489451;11169.497372618089;11197.944010279896;11260.718482038015;11346.432678366215;11723.941380293043;8982.281417486716;12158.209716368408;12562.937185314015;12573;12586;11603.941980290045;11685.474153663276;11743.647690569296;11758.470868810753;11789.174757766874;11273.492692829006;11656.30062196271;11723.237989530653;11801;11851.229670071418;11704.88295117072;11774.587889424172;11777.587784427504;11849.348285844362;11852.348120853436;9865.91474937742;10265.84601230997;10433.582656693647;10441.738956526147;10551.94724026375;8695.478271303742;9044.728658140266;9741.707748767549;9886.456244906312;9955.20358371343 13:11:20 INFO - PROCESS | 4277 | __end_tp_report 13:11:20 INFO - PROCESS | 4277 | __start_cc_report 13:11:20 INFO - PROCESS | 4277 | _x_x_mozilla_cycle_collect,587 13:11:20 INFO - PROCESS | 4277 | __end_cc_report 13:11:20 INFO - PROCESS | 4277 | __startTimestamp1455916280764__endTimestamp 13:11:20 INFO - PROCESS | 4277 | 13:11:20 INFO - PROCESS | 4277 | ------- Summary: start ------- 13:11:20 INFO - PROCESS | 4277 | Number of tests: 6 13:11:20 INFO - PROCESS | 4277 | 13:11:20 INFO - PROCESS | 4277 | [#0] dojo.html Cycles:165 Average:5115.09 Median:5318.36 stddev:547.13 (10.3%) stddev-sans-first:525.16 13:11:20 INFO - PROCESS | 4277 | Values: 3086.7 3099.7 3140.2 3146.4 3167.0 5035.4 5046.6 5094.8 5103.1 5130.5 5032.9 5086.8 5090.9 5094.2 5094.5 4676.0 4727.5 4774.2 4795.7 4804.2 4650.4 4684.8 4742.9 4749.4 4858.0 4725.3 4729.9 4734.3 4745.5 4780.4 4723.2 4730.6 4740.3 4741.1 4762.9 4633.0 4669.8 4701.0 4703.5 4716.1 4897.4 4898.1 4908.2 4909.3 4915.2 5463.5 5491.2 5571.9 5597.9 5620.0 5476.9 5480.7 5482.2 5500.6 5515.3 5095.7 5137.9 5144.5 5151.0 5193.2 5532.7 5620.4 5652.4 5654.5 5699.1 5373.0 5395.3 5406.6 5436.5 5441.9 5391.5 5455.8 5502.8 5505.8 5572.8 5470.1 5483.1 5487.8 5494.3 5496.6 5476.5 5482.8 5483.9 5490.9 5547.1 4230.5 4293.6 4341.0 4352.7 4396.6 3826.8 3847.1 3863.4 3877.0 3887.4 5051.1 5138.2 5152.3 5171.1 5223.6 5475.1 5482.7 5491.4 5502.1 5545.8 5067.2 5120.1 5120.5 5127.1 5167.3 4616.4 4678.3 4722.4 4771.0 4806.9 5673.2 5687.7 5699.8 5710.1 5727.1 5415.5 5474.1 5483.8 5489.2 5536.2 5709.1 5748.9 5774.3 5776.6 5839.3 5418.7 5428.2 5431.3 5437.9 5438.9 5410.4 5496.9 5507.2 5556.6 5632.1 5328.9 5332.7 5347.1 5355.4 5357.2 5355.4 5374.2 5375.0 5381.3 5416.1 5182.0 5223.6 5293.7 5296.3 5331.9 5306.4 5354.6 5400.6 5402.8 5419.5 5211.2 5314.7 5318.4 5332.7 5375.2 13:11:20 INFO - PROCESS | 4277 | 13:11:20 INFO - PROCESS | 4277 | [#1] ext.html Cycles:180 Average:45970.52 Median:31115.34 stddev:78707.48 (253.0%) stddev-sans-first:78854.31 13:11:20 INFO - PROCESS | 4277 | Values: 522.0 529.9 534.0 552.0 583.8 28673.7 28982.7 29119.6 29135.6 29151.1 29420.7 37605.0 38046.0 38064.4 38074.6 8289.1 8471.2 8472.4 8478.4 8481.5 7622.4 8399.0 8533.5 8536.5 10123.9 10099.2 10209.8 10212.6 10218.0 10225.3 9996.1 10086.8 10105.2 10120.4 10123.5 9947.4 10078.2 10079.4 10082.9 10089.1 37521.0 37623.8 37967.0 37994.6 41498.0 3266.1 3474.6 3664.9 3778.7 4008.6 29535.7 29691.0 30235.8 30608.2 30965.2 3864.9 3868.3 3965.1 3975.7 3993.2 291348.0 291349.0 291714.0 291800.0 293463.0 58901.4 59200.4 59729.0 59748.7 59803.0 62054.0 62175.0 62363.7 62389.4 62394.4 15076.9 15523.2 15545.9 15554.7 15564.5 9980.1 11712.8 11773.2 11785.9 11788.2 19028.4 19419.4 20106.3 20278.3 20366.9 7783.9 7932.8 8003.9 8061.9 8077.6 982.9 986.6 1026.7 1033.8 1048.2 28914.6 29079.5 29253.8 29755.0 29884.7 1004.0 1021.7 1053.0 1061.1 1102.4 13144.5 13167.9 13358.9 13363.1 13452.7 319875.0 320871.0 321128.0 323154.0 323235.0 51314.7 51666.2 51679.0 51683.0 51707.2 1400.8 1407.2 1423.2 1425.9 1425.9 25168.6 26569.5 26905.7 26916.7 27008.2 42945.0 43642.6 43686.1 43838.8 43839.1 279016.2 288173.0 289432.0 289497.0 290092.0 26954.5 30549.8 31094.7 31186.8 31510.4 37248.0 37324.6 38122.0 38218.8 38475.0 31136.0 32077.4 32116.7 32171.2 32430.8 28297.3 31969.7 32415.7 35019.0 36239.5 32654.0 32876.5 32946.5 33002.3 33029.3 25858.7 29368.6 30438.5 30483.7 30503.7 24830.9 25051.5 25147.2 25207.6 25538.9 13:11:20 INFO - PROCESS | 4277 | 13:11:20 INFO - PROCESS | 4277 | [#2] jquery.html Cycles:180 Average:26208.79 Median:231985.18 stddev:74259.43 (32.0%) stddev-sans-first:74442.38 13:11:20 INFO - PROCESS | 4277 | Values: 360.8 363.8 367.0 368.1 373.6 13860.1 14053.0 16213.4 16687.6 17511.1 11008.7 11324.0 16936.4 17224.6 17236.3 4829.6 4936.1 4947.9 4950.1 4997.9 3840.5 4950.9 6456.9 6703.8 6713.7 6596.0 6601.7 6649.0 6692.2 6769.2 6393.0 6601.5 6608.5 6669.9 6735.5 6415.0 6455.1 6458.0 6461.4 6468.5 22197.2 22586.1 23162.7 23323.7 23480.0 2430.4 2849.7 2918.6 3065.7 3220.3 13229.1 13859.2 14346.6 14440.3 14826.8 2002.2 2023.6 2059.4 2069.8 2108.8 52200.5 64539.4 65246.7 71746.3 73401.0 14792.5 15490.5 15512.1 15521.5 15533.1 23963.8 23976.0 24338.1 24421.8 24510.6 7165.7 7508.9 7531.2 7612.8 7616.6 7139.5 7449.7 7474.6 7485.8 7515.9 4385.1 4389.3 4435.6 4470.8 4512.5 1832.9 1880.0 1881.4 1881.5 1890.8 764.4 833.1 837.5 896.5 918.4 15625.5 16278.0 16296.8 16529.9 16563.6 775.9 911.0 948.3 975.4 983.9 8539.8 9071.0 9086.4 9115.4 9198.1 421586.0 424777.0 464828.0 474645.0 478865.0 70705.3 72105.0 75264.6 75317.0 75809.0 998.6 1001.3 1021.9 1032.1 1038.0 15294.8 15537.2 15644.8 15697.3 15943.0 25361.4 27540.3 32563.8 33021.5 33546.3 42384.4 45498.5 45517.3 45519.5 45633.3 7665.0 7757.5 7764.3 7834.8 7926.3 10925.7 11401.9 11615.0 11673.6 12246.5 7782.4 9675.3 9883.1 9951.4 10291.4 10125.9 10174.9 10408.6 10567.9 10695.2 10391.8 10411.2 10485.4 10503.4 10658.3 7728.3 7989.6 7995.8 8037.1 8054.2 9621.3 10707.6 10722.9 10889.1 10927.6 13:11:20 INFO - PROCESS | 4277 | 13:11:20 INFO - PROCESS | 4277 | [#3] mootools.html Cycles:180 Average:5634.90 Median:6055.65 stddev:2988.10 (49.3%) stddev-sans-first:2979.00 13:11:20 INFO - PROCESS | 4277 | Values: 1333.7 1477.5 1498.3 1669.7 1824.1 6916.7 7845.6 8053.6 8078.0 8092.4 7876.7 8035.5 8043.2 8056.0 8057.5 1967.7 2228.0 2290.3 2305.0 2331.6 2334.3 2336.6 2345.8 2347.3 2348.5 2280.6 2287.7 2290.3 2290.7 2291.9 2282.0 2365.9 2369.9 2370.5 2370.8 2329.0 2330.0 2333.5 2362.5 2372.0 6467.3 6632.8 8115.0 8190.3 8190.4 4746.6 4848.9 4893.2 4897.6 4901.0 3236.4 3241.2 3283.8 3384.9 3478.5 1011.2 1014.1 1037.3 1053.4 1061.9 11441.9 11530.5 11547.8 11583.7 11585.6 4351.9 4370.5 4420.0 4510.6 4522.4 9955.7 9971.3 9992.8 9992.9 10007.3 4329.2 4907.9 4988.2 5008.9 5071.9 4505.7 4535.5 4542.2 4550.5 4557.7 3844.5 3871.9 3892.8 3921.5 3930.1 1196.3 1246.8 1251.8 1265.3 1268.2 1062.8 1078.1 1087.8 1231.8 1353.5 7577.2 7660.5 7669.3 7672.5 7827.9 441.8 453.4 456.2 458.1 461.8 5775.7 5846.4 5849.3 5857.5 5886.7 8901.6 9167.2 9187.1 9202.4 9678.7 9120.2 9170.7 9175.9 9176.6 9202.0 7538.8 7665.2 7669.3 7774.8 7787.6 7605.6 7617.4 7674.2 7683.5 7702.0 8853.3 8867.5 9236.7 9258.4 9284.3 9241.8 9322.8 9527.7 9544.3 9675.7 6224.6 6946.2 6982.5 7025.4 7138.4 7804.6 7811.7 7826.4 7855.3 7864.4 6863.8 7011.8 7012.9 7123.0 7126.6 7076.4 7078.7 7094.5 7176.5 7187.4 6986.6 7143.9 7147.5 7157.6 7392.8 6658.2 6678.8 6705.5 6728.2 6728.9 6408.9 6559.8 6560.0 6595.7 6599.1 13:11:20 INFO - PROCESS | 4277 | 13:11:20 INFO - PROCESS | 4277 | [#4] prototype.html Cycles:180 Average:5183.19 Median:5859.12 stddev:1577.13 (26.9%) stddev-sans-first:1539.02 13:11:20 INFO - PROCESS | 4277 | Values: 336.1 336.4 338.5 339.9 347.0 5788.3 5812.0 5821.8 5838.5 5854.1 5774.3 5785.6 5792.6 5796.4 5802.9 4526.1 4527.8 4534.0 4534.7 4535.1 4452.9 4480.2 4514.5 4536.5 4539.7 4405.8 4428.9 4455.5 4475.9 4480.4 4226.6 4321.1 4481.8 4486.5 4489.1 3751.3 3756.6 3757.3 3841.5 3958.0 5446.7 5500.9 5507.3 5514.8 5517.3 5174.8 5182.0 5185.8 5194.5 5196.1 5924.3 6040.1 6131.0 6140.0 6141.6 4347.2 4356.8 4357.7 4365.5 4374.7 6438.5 6443.3 6446.7 6447.7 6448.4 4207.1 4326.8 4337.5 4458.5 4463.5 4365.3 4369.7 4379.0 4380.5 4388.5 5081.4 5093.8 5098.3 5105.1 5106.7 6227.5 6240.4 6244.0 6247.3 6255.1 1529.4 1535.8 1540.4 1555.5 1559.8 1015.6 1037.6 1043.6 1044.8 1045.5 5864.2 5875.6 5875.8 5877.4 5879.9 6365.5 6371.1 6375.8 6376.8 6381.6 5852.7 5866.9 5867.6 5868.6 5876.1 3311.7 3342.7 3379.8 3435.8 3445.8 6608.6 6629.2 6638.9 6638.9 6651.7 6487.3 6578.7 6579.4 6579.9 6586.8 6484.9 6665.1 6665.1 6704.9 6711.2 6425.9 6430.2 6455.4 6464.6 6469.5 6399.3 6403.6 6412.1 6412.6 6415.6 6453.6 6725.6 6740.2 6742.9 6750.7 4300.7 4323.3 4325.6 4329.8 4332.8 6437.9 6439.2 6444.6 6452.1 6454.7 6099.3 6263.6 6269.6 6283.6 6307.3 6242.4 6253.4 6255.5 6265.5 6269.8 6147.3 6168.9 6170.4 6172.0 6173.8 6180.7 6288.4 6290.9 6298.7 6308.5 6099.1 6108.1 6123.4 6157.3 6162.0 13:11:20 INFO - PROCESS | 4277 | 13:11:20 INFO - PROCESS | 4277 | [#5] yui.html Cycles:180 Average:13849.84 Median:24717.23 stddev:15718.66 (63.6%) stddev-sans-first:15731.73 13:11:20 INFO - PROCESS | 4277 | Values: 699.1 746.5 783.2 798.4 814.8 13883.1 13998.7 14083.8 14106.2 14125.0 13181.3 13257.9 13275.2 13291.3 13297.7 664.4 671.3 817.8 820.3 839.8 819.3 822.0 823.1 829.2 829.4 876.0 884.2 884.5 885.0 885.7 697.2 862.1 876.4 878.6 879.2 649.5 649.7 649.7 649.8 650.1 13628.1 13640.8 13651.9 13690.6 13706.5 12981.0 13530.5 13762.1 13867.1 13917.6 10423.7 10792.3 10986.9 11131.4 11725.4 4292.4 4375.4 4393.3 4465.9 4467.5 51208.0 51692.0 51866.5 51891.5 51927.5 9856.6 9864.6 9914.4 10213.8 10276.4 18322.3 18408.4 18418.3 18427.8 18429.9 7631.7 7738.0 7745.1 7749.5 7936.3 4258.8 4262.6 4373.0 4395.2 4443.4 3187.7 3229.6 3241.9 3242.0 3253.9 586.0 591.6 605.9 641.4 660.3 603.8 654.9 656.7 691.1 713.1 8121.4 8640.7 8678.2 8703.5 8745.7 538.3 671.6 690.1 697.2 717.3 3957.4 3966.6 4015.8 4018.4 4092.3 54670.5 56065.2 56438.7 56460.4 56563.0 48839.0 48948.8 49094.0 49698.0 50505.2 44224.6 44967.0 45046.3 45366.3 46225.5 7695.3 8233.4 8413.0 8612.2 8845.2 32987.5 33210.3 33579.3 34288.0 34751.3 42416.2 42920.6 42948.1 43058.4 43978.3 11169.5 11197.9 11260.7 11346.4 11723.9 8982.3 12158.2 12562.9 12573.0 12586.0 11603.9 11685.5 11743.6 11758.5 11789.2 11273.5 11656.3 11723.2 11801.0 11851.2 11704.9 11774.6 11777.6 11849.3 11852.3 9865.9 10265.8 10433.6 10441.7 10551.9 8695.5 9044.7 9741.7 9886.5 9955.2 13:11:20 INFO - PROCESS | 4277 | -------- Summary: end -------- 13:11:20 INFO - PROCESS | 4277 | 13:11:21 INFO - TEST-INFO | 4277: exit 0 13:11:21 INFO - TEST-OK | dromaeo_css | took 1112493ms 13:11:21 INFO - TEST-START | kraken 13:11:21 INFO - operating with platform_type : linux_ 13:11:21 INFO - Initialising browser for kraken test... 13:11:21 INFO - TEST-INFO | started process 4459 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRdO0wp/profile http://localhost:55690/getInfo.html) 13:11:25 INFO - PROCESS | 4459 | __metrics Screen width/height:1600/1200 13:11:25 INFO - PROCESS | 4459 | colorDepth:24 13:11:25 INFO - PROCESS | 4459 | Browser inner width/height: 1024/697 13:11:25 INFO - PROCESS | 4459 | __metrics 13:11:26 INFO - PROCESS | 4459 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:11:26 INFO - PROCESS | 4459 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 13:11:27 INFO - TEST-INFO | 4459: exit 0 13:11:27 INFO - Browser initialized. 13:11:27 INFO - Running cycle 1/1 for kraken test... 13:11:27 INFO - TEST-INFO | started process 4542 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRdO0wp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:11:38 INFO - PROCESS | 4542 | RSS: Main: 146968576 13:11:38 INFO - PROCESS | 4542 | 13:11:41 INFO - PROCESS | 4542 | Cycle 1(1): loaded http://localhost:55690/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55690/tests/kraken/driver.html?testName=audio-beat-detection) 13:11:42 INFO - PROCESS | 4542 | RSS: Main: 191143936 13:11:42 INFO - PROCESS | 4542 | 13:11:44 INFO - PROCESS | 4542 | Cycle 1(1): loaded http://localhost:55690/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55690/tests/kraken/driver.html?testName=audio-dft) 13:11:45 INFO - PROCESS | 4542 | RSS: Main: 179847168 13:11:45 INFO - PROCESS | 4542 | 13:11:48 INFO - PROCESS | 4542 | Cycle 1(1): loaded http://localhost:55690/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55690/tests/kraken/driver.html?testName=audio-fft) 13:11:48 INFO - PROCESS | 4542 | RSS: Main: 164499456 13:11:48 INFO - PROCESS | 4542 | 13:11:50 INFO - PROCESS | 4542 | Cycle 1(1): loaded http://localhost:55690/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55690/tests/kraken/driver.html?testName=audio-oscillator) 13:11:51 INFO - PROCESS | 4542 | RSS: Main: 167014400 13:11:51 INFO - PROCESS | 4542 | 13:11:53 INFO - PROCESS | 4542 | Cycle 1(1): loaded http://localhost:55690/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55690/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:11:54 INFO - PROCESS | 4542 | RSS: Main: 168157184 13:11:54 INFO - PROCESS | 4542 | 13:11:57 INFO - PROCESS | 4542 | Cycle 1(1): loaded http://localhost:55690/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55690/tests/kraken/driver.html?testName=imaging-darkroom) 13:11:57 INFO - PROCESS | 4542 | RSS: Main: 167677952 13:11:57 INFO - PROCESS | 4542 | 13:12:01 INFO - PROCESS | 4542 | Cycle 1(1): loaded http://localhost:55690/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55690/tests/kraken/driver.html?testName=imaging-desaturate) 13:12:01 INFO - PROCESS | 4542 | RSS: Main: 169185280 13:12:01 INFO - PROCESS | 4542 | 13:12:04 INFO - PROCESS | 4542 | Cycle 1(1): loaded http://localhost:55690/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55690/tests/kraken/driver.html?testName=json-parse-financial) 13:12:05 INFO - PROCESS | 4542 | RSS: Main: 171143168 13:12:05 INFO - PROCESS | 4542 | 13:12:06 INFO - PROCESS | 4542 | Cycle 1(1): loaded http://localhost:55690/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55690/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:12:07 INFO - PROCESS | 4542 | RSS: Main: 181084160 13:12:07 INFO - PROCESS | 4542 | 13:12:08 INFO - PROCESS | 4542 | Cycle 1(1): loaded http://localhost:55690/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55690/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:12:09 INFO - PROCESS | 4542 | RSS: Main: 178765824 13:12:09 INFO - PROCESS | 4542 | 13:12:11 INFO - PROCESS | 4542 | Cycle 1(1): loaded http://localhost:55690/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55690/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:12:12 INFO - PROCESS | 4542 | RSS: Main: 193236992 13:12:12 INFO - PROCESS | 4542 | 13:12:14 INFO - PROCESS | 4542 | Cycle 1(1): loaded http://localhost:55690/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55690/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:12:15 INFO - PROCESS | 4542 | RSS: Main: 196292608 13:12:15 INFO - PROCESS | 4542 | 13:12:17 INFO - PROCESS | 4542 | Cycle 1(1): loaded http://localhost:55690/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55690/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:12:18 INFO - PROCESS | 4542 | RSS: Main: 195293184 13:12:18 INFO - PROCESS | 4542 | 13:12:20 INFO - PROCESS | 4542 | Cycle 1(1): loaded http://localhost:55690/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55690/tests/kraken/driver.html?testName=ai-astar) 13:12:20 INFO - PROCESS | 4542 | RSS: Main: 254799872 13:12:20 INFO - PROCESS | 4542 | 13:12:20 INFO - PROCESS | 4542 | __start_tp_report 13:12:20 INFO - PROCESS | 4542 | _x_x_mozilla_page_load 13:12:20 INFO - PROCESS | 4542 | _x_x_mozilla_page_load_details 13:12:20 INFO - PROCESS | 4542 | |i|pagename|runs| 13:12:20 INFO - PROCESS | 4542 | |0;ai-astar;111;113;107;111;112;112;101;112;111;112 13:12:20 INFO - PROCESS | 4542 | |1;audio-beat-detection;155;128;159;165;126;163;158;126;169;126 13:12:20 INFO - PROCESS | 4542 | |2;audio-dft;163;161;163;163;164;162;160;165;163;161 13:12:20 INFO - PROCESS | 4542 | |3;audio-fft;73;73;95;93;73;73;73;121;98;72 13:12:20 INFO - PROCESS | 4542 | |4;audio-oscillator;96;96;147;95;95;95;140;96;96;141 13:12:20 INFO - PROCESS | 4542 | |5;imaging-gaussian-blur;120;115;115;115;115;116;115;115;115;115 13:12:20 INFO - PROCESS | 4542 | |6;imaging-darkroom;145;147;146;145;146;147;146;147;146;146 13:12:20 INFO - PROCESS | 4542 | |7;imaging-desaturate;98;96;97;96;97;97;97;97;97;96 13:12:20 INFO - PROCESS | 4542 | |8;json-parse-financial;56;55;55;55;55;56;59;63;53;52 13:12:20 INFO - PROCESS | 4542 | |9;json-stringify-tinderbox;68;69;69;69;68;68;68;68;69;68 13:12:20 INFO - PROCESS | 4542 | |10;stanford-crypto-aes;82;83;83;83;83;83;83;83;83;84 13:12:20 INFO - PROCESS | 4542 | |11;stanford-crypto-ccm;120;117;124;116;131;115;119;115;114;119 13:12:20 INFO - PROCESS | 4542 | |12;stanford-crypto-pbkdf2;152;140;151;154;162;155;139;152;151;152 13:12:20 INFO - PROCESS | 4542 | |13;stanford-crypto-sha256-iterative;69;71;70;71;68;68;70;73;69;71 13:12:20 INFO - PROCESS | 4542 | __end_tp_report 13:12:20 INFO - PROCESS | 4542 | __start_cc_report 13:12:20 INFO - PROCESS | 4542 | _x_x_mozilla_cycle_collect,972 13:12:20 INFO - PROCESS | 4542 | __end_cc_report 13:12:20 INFO - PROCESS | 4542 | __startTimestamp1455916340402__endTimestamp 13:12:20 INFO - PROCESS | 4542 | 13:12:20 INFO - PROCESS | 4542 | ------- Summary: start ------- 13:12:20 INFO - PROCESS | 4542 | Number of tests: 14 13:12:20 INFO - PROCESS | 4542 | 13:12:20 INFO - PROCESS | 4542 | [#0] ai-astar Cycles:10 Average:110.20 Median:112.00 stddev:3.61 (3.2%) stddev-sans-first:3.82 13:12:20 INFO - PROCESS | 4542 | Values: 111.0 113.0 107.0 111.0 112.0 112.0 101.0 112.0 111.0 112.0 13:12:20 INFO - PROCESS | 4542 | 13:12:20 INFO - PROCESS | 4542 | [#1] audio-beat-detection Cycles:10 Average:147.50 Median:158.50 stddev:18.48 (11.7%) stddev-sans-first:19.40 13:12:20 INFO - PROCESS | 4542 | Values: 155.0 128.0 159.0 165.0 126.0 163.0 158.0 126.0 169.0 126.0 13:12:20 INFO - PROCESS | 4542 | 13:12:20 INFO - PROCESS | 4542 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:1.51 (0.9%) stddev-sans-first:1.59 13:12:20 INFO - PROCESS | 4542 | Values: 163.0 161.0 163.0 163.0 164.0 162.0 160.0 165.0 163.0 161.0 13:12:20 INFO - PROCESS | 4542 | 13:12:20 INFO - PROCESS | 4542 | [#3] audio-fft Cycles:10 Average:84.40 Median:73.00 stddev:16.71 (22.9%) stddev-sans-first:17.21 13:12:20 INFO - PROCESS | 4542 | Values: 73.0 73.0 95.0 93.0 73.0 73.0 73.0 121.0 98.0 72.0 13:12:20 INFO - PROCESS | 4542 | 13:12:20 INFO - PROCESS | 4542 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:95.50 stddev:22.82 (23.9%) stddev-sans-first:23.66 13:12:20 INFO - PROCESS | 4542 | Values: 96.0 96.0 147.0 95.0 95.0 95.0 140.0 96.0 96.0 141.0 13:12:20 INFO - PROCESS | 4542 | 13:12:20 INFO - PROCESS | 4542 | [#5] imaging-gaussian-blur Cycles:10 Average:115.60 Median:115.00 stddev:1.58 (1.4%) stddev-sans-first:0.33 13:12:20 INFO - PROCESS | 4542 | Values: 120.0 115.0 115.0 115.0 115.0 116.0 115.0 115.0 115.0 115.0 13:12:20 INFO - PROCESS | 4542 | 13:12:20 INFO - PROCESS | 4542 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 13:12:20 INFO - PROCESS | 4542 | Values: 145.0 147.0 146.0 145.0 146.0 147.0 146.0 147.0 146.0 146.0 13:12:20 INFO - PROCESS | 4542 | 13:12:20 INFO - PROCESS | 4542 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:97.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 13:12:20 INFO - PROCESS | 4542 | Values: 98.0 96.0 97.0 96.0 97.0 97.0 97.0 97.0 97.0 96.0 13:12:20 INFO - PROCESS | 4542 | 13:12:20 INFO - PROCESS | 4542 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:55.50 stddev:3.11 (5.6%) stddev-sans-first:3.30 13:12:20 INFO - PROCESS | 4542 | Values: 56.0 55.0 55.0 55.0 55.0 56.0 59.0 63.0 53.0 52.0 13:12:20 INFO - PROCESS | 4542 | 13:12:20 INFO - PROCESS | 4542 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 13:12:20 INFO - PROCESS | 4542 | Values: 68.0 69.0 69.0 69.0 68.0 68.0 68.0 68.0 69.0 68.0 13:12:20 INFO - PROCESS | 4542 | 13:12:20 INFO - PROCESS | 4542 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:83.00 stddev:0.47 (0.6%) stddev-sans-first:0.33 13:12:20 INFO - PROCESS | 4542 | Values: 82.0 83.0 83.0 83.0 83.0 83.0 83.0 83.0 83.0 84.0 13:12:20 INFO - PROCESS | 4542 | 13:12:20 INFO - PROCESS | 4542 | [#11] stanford-crypto-ccm Cycles:10 Average:119.00 Median:119.00 stddev:5.16 (4.3%) stddev-sans-first:5.46 13:12:20 INFO - PROCESS | 4542 | Values: 120.0 117.0 124.0 116.0 131.0 115.0 119.0 115.0 114.0 119.0 13:12:20 INFO - PROCESS | 4542 | 13:12:20 INFO - PROCESS | 4542 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.80 Median:152.00 stddev:6.78 (4.5%) stddev-sans-first:7.18 13:12:20 INFO - PROCESS | 4542 | Values: 152.0 140.0 151.0 154.0 162.0 155.0 139.0 152.0 151.0 152.0 13:12:20 INFO - PROCESS | 4542 | 13:12:20 INFO - PROCESS | 4542 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.50 stddev:1.56 (2.2%) stddev-sans-first:1.62 13:12:20 INFO - PROCESS | 4542 | Values: 69.0 71.0 70.0 71.0 68.0 68.0 70.0 73.0 69.0 71.0 13:12:20 INFO - PROCESS | 4542 | -------- Summary: end -------- 13:12:20 INFO - PROCESS | 4542 | 13:12:21 INFO - TEST-INFO | 4542: exit 0 13:12:21 INFO - TEST-OK | kraken | took 59873ms 13:12:21 INFO - SUITE-END | took 1172s 13:12:21 INFO - Completed test suite (00:19:32) 13:12:21 INFO - Working with test: dromaeo_css 13:12:21 INFO - Generating results file: dromaeo_css 13:12:21 INFO - Working with test: kraken 13:12:21 INFO - Generating results file: kraken 13:12:21 INFO - javascript benchmark 13:12:21 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:12:21 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 13:12:21 INFO - process_Request line: dromaeo_css 6921.85 graph.html#tests=[[72,1,35]] 13:12:21 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:12:21 INFO - process_Request line: kraken 1519.90 graph.html#tests=[[232,1,35]] 13:12:21 INFO - RETURN: dromaeo_css: 6921.85 13:12:21 INFO - RETURN: kraken: 1519.90 13:12:21 INFO - javascript benchmark 13:12:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3086.73762730168, 3099.7210251077427, 3140.167855518288, 3146.354997225569, 3166.9524957125645, 5035.370578677665, 5046.571041461476, 5094.821681241153, 5103.055934652092, 5130.461301563338, 5032.874178145548, 5086.821961231349, 5090.9236361454605, 5094.210397388401, 5094.490550944904, 4675.953240467603, 4727.5272472752795, 4774.1645212087915, 4795.688280261789, 4804.231322988305, 4650.441946966369, 4684.765761711918, 4742.928856067162, 4749.358836557055, 4858.0283943211325, 4725.267583524559, 4729.881752956169, 4734.289856521515, 4745.501722319142, 4780.37855078841, 4723.220668589679, 4730.645201609893, 4740.265258884879, 4741.051789642051, 4762.857114286577, 4632.953670463286, 4669.813207471697, 4701.036287561042, 4703.482616912137, 4716.103940251342, 4897.436794768611, 4898.093852637274, 4908.190148625473, 4909.3126962225315, 4915.16442204826, 5463.48096930791, 5491.176323551459, 5571.8607034824045, 5597.888042239132, 5619.971900140473, 5476.863078423032, 5480.725963701839, 5482.17767334899, 5500.614956953015, 5515.283013208297, 5095.668781529189, 5137.897242055175, 5144.459831717653, 5150.9742451287875, 5193.221016847428, 5532.695701736363, 5620.381758006616, 5652.406497317805, 5654.5193658538665, 5699.088145896637, 5372.973135134299, 5395.298611180521, 5406.648567843077, 5436.483534064258, 5441.863953401196, 5391.541718953855, 5455.781768729285, 5502.8349149525575, 5505.8066321533415, 5572.832815015475, 5470.097433923358, 5483.095289277305, 5487.835364939058, 5494.313210848644, 5496.560275178056, 5476.534494568006, 5482.780688772485, 5483.917741233885, 5490.862728431741, 5547.084731019337, 4230.450041494586, 4293.635041021548, 4340.956590434055, 4352.717073390219, 4396.582324679151, 3826.789526576065, 3847.0574709196426, 3863.439801228806, 3876.972602260403, 3887.4363217333894, 5051.090803655304, 5138.177891537411, 5152.3044389007755, 5171.069207542679, 5223.634345595848, 5475.123980163155, 5482.671039737628, 5491.423400542965, 5502.064649009678, 5545.805896793593, 5067.163917953497, 5120.1039818031695, 5120.48795120485, 5127.077126117335, 5167.328247327899, 4616.422947131608, 4678.345031695565, 4722.409698787652, 4771.045790841846, 4806.927896081562, 5673.205751194836, 5687.715614219355, 5699.772009119589, 5710.143478478261, 5727.083666613322, 5415.539679127318, 5474.069408200536, 5483.7806487740045, 5489.204065410573, 5536.169574563848, 5709.058005429224, 5748.913766293593, 5774.307083150049, 5776.566757493289, 5839.299284085937, 5418.701971391612, 5428.240046393429, 5431.34823821144, 5437.891242175214, 5438.864028399322, 5410.404855465817, 5496.945030549803, 5507.201455788968, 5556.611037227355, 5632.070708333079, 5328.866778330573, 5332.706701131475, 5347.064263753905, 5355.410904800547, 5357.1696387060065, 5355.357357117015, 5374.193870919237, 5374.973125134349, 5381.27352807366, 5416.133418652997, 5182.0, 5223.555997740083, 5293.682379057269, 5296.311479507639, 5331.866703332447, 5306.389765176899, 5354.6251762377815, 5400.594955378441, 5402.783888644567, 5419.539339156216, 5211.1922651989, 5314.734263286898, 5318.361796584435, 5332.706701131475, 5375.247465354775], "unit": "score", "name": "dojo.html", "value": 5081.105777464794}, {"lowerIsBetter": false, "replicates": [521.9947800521996, 529.8701818054577, 533.9786408543658, 551.9944800551995, 583.7548229743508, 28673.713262867364, 28982.710172898318, 29119.56320655189, 29135.562966555466, 29151.125466236048, 29420.705792942117, 37605.0, 38046.0, 38064.42903356452, 38074.61925380752, 8289.129641387657, 8471.195236452528, 8472.406931514797, 8478.364122690791, 8481.491110533358, 7622.390208783284, 8398.958005209965, 8533.530655813927, 8536.487810731376, 10123.949380253125, 10099.192064634812, 10209.795804083913, 10212.591496340137, 10218.0, 10225.335353202056, 9996.050375214343, 10086.848697269474, 10105.242106841943, 10120.392776433364, 10123.493825308742, 9947.353422027545, 10078.193744500422, 10079.395236285847, 10082.899171008343, 10089.142422894063, 37521.0, 37623.811880940695, 37967.0, 37994.62005379939, 41498.0, 3266.1344743642953, 3474.6004209515977, 3664.926701465982, 3778.659920607131, 4008.579099194572, 29535.70464295351, 29691.0, 30235.848820755757, 30608.2347941301, 30965.22586935322, 3864.8840534784003, 3868.2650296443585, 3965.0682089709185, 3975.6819454443576, 3993.1614360984227, 291348.0, 291349.0, 291714.0, 291799.9999999979, 293463.0, 58901.41098589045, 59200.40799592035, 59729.0, 59748.70125649344, 59803.0, 62054.0, 62175.0, 62363.6881815588, 62389.37610623836, 62394.376056238856, 15076.924615377073, 15523.223838808015, 15545.922270388575, 15554.688906221812, 15564.455244066403, 9980.101790838859, 11712.765744685059, 11773.17587768848, 11785.941070294593, 11788.174827762146, 19028.429147125607, 19419.39554734107, 20106.296279630144, 20278.290259840836, 20366.89816550908, 7783.883241751379, 7932.801679958047, 8003.8799418008775, 8061.919380806235, 8077.555734434545, 982.8918818929913, 986.5708416838698, 1026.7022563456662, 1033.8397548380012, 1048.2033654422694, 28914.566281505795, 29079.54602269878, 29253.817688540672, 29755.0, 29884.701152988626, 1004.0361253197012, 1021.7445638590352, 1052.9684109476727, 1061.0715623829149, 1102.4322473925934, 13144.539941102206, 13167.868321316855, 13358.933205334106, 13363.131396459394, 13452.730945381038, 319875.0, 320871.0, 321128.0, 323154.0, 323235.0, 51314.74342628263, 51666.22500662493, 51679.0, 51683.0, 51707.224391634154, 1400.838903526087, 1407.2260256858688, 1423.2456797897132, 1425.921574313402, 1425.942962281497, 25168.622470663322, 26569.468610628064, 26905.730942691105, 26916.73083269142, 27008.1897543074, 42945.0, 43642.56357436512, 43686.12627747364, 43838.78080609577, 43839.12321753611, 279016.209837899, 288173.0, 289432.0, 289497.0, 290092.0, 26954.460910782065, 30549.847250763603, 31094.689053109178, 31186.844065780435, 31510.369792604477, 37248.0, 37324.62675373212, 38122.0, 38218.808905955295, 38475.0, 31136.0, 32077.358452830347, 32116.678833212303, 32171.195720107185, 32430.83784581062, 28297.292567685974, 31969.68030319667, 32415.675843241264, 35019.0, 36239.45640815337, 32654.0, 32876.50685239676, 32946.5058024125, 33002.339953201285, 33029.33941321208, 25858.741412585634, 29368.559471607514, 30438.517630607043, 30483.69516304897, 30503.694963050086, 24830.875845620656, 25051.498970020133, 25147.24558263255, 25207.621885671364, 25538.872305638353], "unit": "score", "name": "ext.html", "value": 18144.013612373194}, {"lowerIsBetter": false, "replicates": [360.8105744484146, 363.8017280582083, 366.9853205871764, 368.10733970122465, 373.59278386558645, 13860.099093558913, 14053.0, 16213.432529861457, 16687.582810429747, 17511.124443777822, 11008.669739907795, 11324.03745681618, 16936.40722574707, 17224.56938576536, 17236.310547578083, 4829.613630909519, 4936.06214819185, 4947.876303092416, 4950.133726597849, 4997.900041999158, 3840.5007349044586, 4950.876228094308, 6456.870862582746, 6703.798886033427, 6713.69788359525, 6596.0, 6601.66991650418, 6649.035889795977, 6692.23039350476, 6769.221539522969, 6393.0, 6601.50488713346, 6608.480049588574, 6669.899951500732, 6735.494837887153, 6415.0, 6455.096286519891, 6458.0, 6461.386168314003, 6468.514861385368, 22197.22309719152, 22586.096556137898, 23162.65256021161, 23323.650145247833, 23480.0, 2430.3559556717482, 2849.6580410350684, 2918.649762028549, 3065.6781037990913, 3220.2915358621067, 13229.140105893182, 13859.168449892937, 14346.64133396663, 14440.277986100758, 14826.777598336033, 2002.1690998235715, 2023.5685043600265, 2059.392479218619, 2069.8344132469365, 2108.7996640319143, 52200.477995220324, 64539.354606454275, 65246.67376663086, 71746.28253717448, 73401.0, 14792.482263120954, 15490.457833975757, 15512.06927584326, 15521.534353969399, 15533.068015919082, 23963.7603623965, 23976.0, 24338.148164814145, 24421.75578244195, 24510.632340514905, 7165.6775445105095, 7508.924910750932, 7531.171571127172, 7612.8477430451085, 7616.581088040211, 7139.464540159405, 7449.739259126013, 7474.551526908403, 7485.812854678567, 7515.924840751522, 4385.079133381962, 4389.319655453346, 4435.556444355539, 4470.7764611769935, 4512.458504979423, 1832.8900265984084, 1879.9530011749816, 1881.4073566826405, 1881.4637828218893, 1890.810918908098, 764.4381379685926, 833.1293797981003, 837.5226121111031, 896.5338024227365, 918.4168053286211, 15625.453109141126, 16278.0, 16296.755548666779, 16529.917350413412, 16563.585910352336, 775.9107702614159, 910.9863352049724, 948.2840455456225, 975.4098770244042, 983.8622592837008, 8539.786505337417, 9070.954645226864, 9086.363954523253, 9115.407498512708, 9198.080191980749, 421586.0, 424777.0, 464828.0, 474645.0, 478865.0, 70705.29294706987, 72105.0, 75264.62367688127, 75317.0, 75809.0, 998.5656239535825, 1001.3140998415963, 1021.8824835144054, 1032.1175395037135, 1038.0242571982462, 15294.847051529343, 15537.223138842786, 15644.765328519854, 15697.29362178682, 15943.0, 25361.365965851, 27540.311492212855, 32563.837180813945, 33021.50467743034, 33546.32907341791, 42384.364234537126, 45498.54501454943, 45517.31724024076, 45519.54480455153, 45633.31550026819, 7665.0, 7757.495762775401, 7764.34003109742, 7834.804129896798, 7926.286634202949, 10925.726856828325, 11401.942990284995, 11615.0, 11673.649790506299, 12246.510139594673, 7782.377409807315, 9675.274354423305, 9883.061109194616, 9951.353162044445, 10291.433971131659, 10125.898741012496, 10174.949125254327, 10408.635697750542, 10567.94716026415, 10695.197860160364, 10391.792164156523, 10411.167106631603, 10485.423301718478, 10503.42231177262, 10658.307210031324, 7728.343090837342, 7989.641760900777, 7995.840083198187, 8037.115917248981, 8054.154313796967, 9621.326507144433, 10707.571697132027, 10722.946385268337, 10889.128869690247, 10927.617533386294], "unit": "score", "name": "jquery.html", "value": 8791.999843423338}, {"lowerIsBetter": false, "replicates": [1333.7199188170484, 1477.490265858279, 1498.3257534109646, 1669.6911071451782, 1824.1244202782655, 6916.6887490062945, 7845.568493732842, 8053.557054362001, 8078.0, 8092.352611791057, 7876.724314648988, 8035.477693949889, 8043.155468675793, 8056.0, 8057.516549007064, 1967.7146813712004, 2227.9554408911813, 2290.335802617239, 2305.0318866076286, 2331.5803155432013, 2334.311378143443, 2336.5910965581043, 2345.812335013195, 2347.307544274443, 2348.518553696497, 2280.5552917181158, 2287.6911616931666, 2290.3129061281547, 2290.679304897316, 2291.862488250702, 2281.977180228193, 2365.929022129339, 2369.8815059247054, 2370.5495955768347, 2370.8458950168183, 2328.988355058231, 2330.044681680503, 2333.5216280662426, 2362.4566349739484, 2372.0, 6467.288598254188, 6632.801015969529, 8114.9594252028955, 8190.303824174893, 8190.4266701330935, 4746.572808447222, 4848.85453436394, 4893.168161412568, 4897.6326775491625, 4901.0, 3236.4336241157703, 3241.1896234442156, 3283.835808209604, 3384.8646054157803, 3478.478228265755, 1011.180943435812, 1014.0873214107289, 1037.305005646219, 1053.4416759117603, 1061.8566493523354, 11441.885581144164, 11530.48112834916, 11547.769044619145, 11583.710407239801, 11585.594504192313, 4351.8694439166875, 4370.453693288339, 4419.955800442019, 4510.571495707903, 4522.366868638327, 9955.701328959998, 9971.302008859455, 9992.750181245381, 9992.900070999198, 10007.299489035844, 4329.19909816685, 4907.877303067452, 4988.152014157602, 5008.874778130576, 5071.8985620287385, 4505.729656220572, 4535.455745310584, 4542.227821270392, 4550.544945505423, 4557.749323787158, 3844.500214972036, 3871.8838434847, 3892.754318618015, 3921.5490218624655, 3930.1353702185475, 1196.3300551691082, 1246.8056221050833, 1251.8310028146266, 1265.3420221484776, 1268.2010333489843, 1062.8193207154802, 1078.1051727066515, 1087.8205096159204, 1231.8029115341503, 1353.5059703208258, 7577.16651168371, 7660.463767536219, 7669.271419215165, 7672.539647621161, 7827.882581761278, 441.79456552703147, 453.3766071651479, 456.24719213298323, 458.0541182458213, 461.7875777142552, 5775.6823374714795, 5846.444587764156, 5849.298084229919, 5857.531397488191, 5886.735096920649, 8901.599428025755, 9167.17495425415, 9187.127222913812, 9202.355835091614, 9678.661246856467, 9120.224780893566, 9170.67902623405, 9175.908240917639, 9176.587053582605, 9202.0, 7538.773836784905, 7665.156832748393, 7669.309762121436, 7774.766756997186, 7787.649555770004, 7605.581693006938, 7617.352525035212, 7674.155842857393, 7683.462157648911, 7702.037245344332, 8853.291736660924, 8867.512286824029, 9236.676716314896, 9258.35191536586, 9284.3036772241, 9241.768955776159, 9322.813543728951, 9527.666531671359, 9544.284178686488, 9675.661351852652, 6224.564280500322, 6946.235914049552, 6982.511224214256, 7025.367716905503, 7138.357547820721, 7804.609769511615, 7811.726589569338, 7826.356465142157, 7855.293023627901, 7864.449488535976, 6863.759768408082, 7011.824704382431, 7012.859742805217, 7122.964385178041, 7126.608036558039, 7076.363127318566, 7078.68145933424, 7094.53885497441, 7176.461765367722, 7187.425005999403, 6986.580805151707, 7143.892841607484, 7147.499675022907, 7157.64211789398, 7392.778216653509, 6658.201015878126, 6678.83302917431, 6705.530612857053, 6728.226253980855, 6728.932710673026, 6408.9038664421005, 6559.836004099936, 6559.967200163968, 6595.703193356407, 6599.142111525663], "unit": "score", "name": "mootools.html", "value": 4518.583566984072}, {"lowerIsBetter": false, "replicates": [336.07411581094095, 336.3525213963121, 338.51085181912117, 339.8919522357115, 347.0213996529785, 5788.27646544182, 5811.9999999999945, 5821.825345239649, 5838.503727183189, 5854.063349864023, 5774.335951365594, 5785.595008349417, 5792.565557583177, 5796.362400135981, 5802.912956305659, 4526.072155208174, 4527.796249168779, 4533.9546604534025, 4534.705244159128, 4535.070310586339, 4452.910941781162, 4480.215962206617, 4514.480834704018, 4536.54634536547, 4539.659525535598, 4405.8237670493145, 4428.911421771562, 4455.465344158705, 4475.910481790363, 4480.417545719069, 4226.619604235603, 4321.135772845443, 4481.8207271708925, 4486.528914463983, 4489.079738653584, 3751.3247615429214, 3756.5867754547253, 3757.28611563802, 3841.4621952926614, 3958.0302825807576, 5446.657937087051, 5500.889982200373, 5507.339119305709, 5514.834554963358, 5517.282753242093, 5174.818881339135, 5182.041322355376, 5185.766640501149, 5194.506521880416, 5196.090684130262, 5924.341184468312, 6040.124181993587, 6130.969345153246, 6140.0, 6141.570090093695, 4347.217500849846, 4356.782160891943, 4357.7385356878685, 4365.541618130114, 4374.6500279977845, 6438.549301548894, 6443.29123796382, 6446.742130314782, 6447.709853056624, 6448.355164483561, 4207.116505533811, 4326.783660816946, 4337.544557821447, 4458.487273963471, 4463.486699029589, 4365.279728844768, 4369.650427965818, 4379.0, 4380.496242932039, 4388.4733831940375, 5081.364829396325, 5093.821716239914, 5098.311727916758, 5105.132127538327, 5106.719130447861, 6227.501799856001, 6240.438360547481, 6243.968780156161, 6247.2815626202655, 6255.093011513305, 1529.3601229074952, 1535.7542793153266, 1540.414642435867, 1555.5022392834185, 1559.7738327942384, 1015.6242190389455, 1037.6108959140322, 1043.645160645369, 1044.8223801953686, 1045.4877110216091, 5864.179014937912, 5875.559333050039, 5875.823725288248, 5877.38287479817, 5879.853003674943, 6365.49076073913, 6371.139896114058, 6375.840603984845, 6376.776812811529, 6381.585196962183, 5852.707364631837, 5866.941330586639, 5867.618604790675, 5868.559858010666, 5876.089206172965, 3311.718503927145, 3342.699157075875, 3379.831008449568, 3435.793852368866, 3445.776024558396, 6608.570442921195, 6629.237637671729, 6638.933610663928, 6638.933610663928, 6651.667416629246, 6487.286398496161, 6578.703958321887, 6579.440747536417, 6579.934200658028, 6586.769463068769, 6484.902726459107, 6665.066890635315, 6665.100211471487, 6704.865902681919, 6711.194656641137, 6425.8714825704155, 6430.228372595318, 6455.354464553507, 6464.5798023128345, 6469.45009674183, 6399.2640846303275, 6403.615783053032, 6412.1343618612755, 6412.551121421456, 6415.582987105823, 6453.612783233021, 6725.630090344882, 6740.191177058784, 6742.898856517058, 6750.6624668767345, 4300.720453170659, 4323.329883868006, 4325.6106950374615, 4329.76186309756, 4332.805023774001, 6437.871242575216, 6439.195100612424, 6444.645544495098, 6452.096706461193, 6454.741810327534, 6099.2985806632805, 6263.6241825490615, 6269.62382257066, 6283.59156654816, 6307.306196318493, 6242.406971337716, 6253.405926436982, 6255.499560035278, 6265.530085243534, 6269.811905642838, 6147.293061298008, 6168.907466388097, 6170.413810687977, 6171.9691401542705, 6173.84565385869, 6180.721867515883, 6288.371162883675, 6290.874182516232, 6298.748050077946, 6308.495320374451, 6099.11562823397, 6108.08378743192, 6123.387661233841, 6157.261128664589, 6162.044883043135], "unit": "score", "name": "prototype.html", "value": 4672.534740163415}, {"lowerIsBetter": false, "replicates": [699.087690563814, 746.5334166146158, 783.2089589514588, 798.4371018432003, 814.7840822182121, 13883.097598656093, 13998.720025599481, 14083.788743168849, 14106.224157671324, 14125.011249212559, 13181.275029873354, 13257.93371033146, 13275.203487790739, 13291.335433228323, 13297.734045319112, 664.4020381656524, 671.2884342596863, 817.7873752824249, 820.3232333325001, 839.7900524868783, 819.2872201184978, 821.9589020548979, 823.0534884882373, 829.2205326992607, 829.3738227638124, 876.0319846569545, 884.2218847414299, 884.5179377239419, 885.026470882031, 885.7298523950193, 697.2086681616377, 862.1292494580488, 876.4390789894472, 878.5738916625431, 879.1955360844819, 649.503130105465, 649.6784091874553, 649.7011374767612, 649.8310439285773, 650.0866282872572, 13628.11417257885, 13640.795388069188, 13651.931740341333, 13690.589282321545, 13706.52027179054, 12981.0, 13530.526431574848, 13762.105463144864, 13867.09863858856, 13917.582472525739, 10423.68728938133, 10792.298500597515, 10986.890131098746, 11131.387773672444, 11725.355105469196, 4292.3561465780385, 4375.409319741826, 4393.275109606911, 4465.9106817863785, 4467.463904331468, 51208.0, 51692.0, 51866.481335186545, 51891.48108518904, 51927.48072519264, 9856.5564549594, 9864.556094975744, 9914.355566888129, 10213.846792298122, 10276.383416995004, 18322.26710931548, 18408.35570755044, 18418.263269469073, 18427.81572184288, 18429.907850460662, 7631.732889348847, 7738.032745906762, 7745.070591529053, 7749.4575379724, 7936.2857342839425, 4258.787060646955, 4262.573742625713, 4373.0, 4395.230834603932, 4443.422355093817, 3187.729043031322, 3229.564008858774, 3241.918952026218, 3241.994981555678, 3253.902382928516, 586.0330454749698, 591.6391001489088, 605.9303180134341, 641.3842710997494, 660.3429587560408, 603.8460192650933, 654.9115869357671, 656.6552559906088, 691.1498856406648, 713.0637443284676, 8121.390895682729, 8640.740777776677, 8678.175573320525, 8703.521306328214, 8745.650173993095, 538.3163382504198, 671.5903298987614, 690.126989358462, 697.1647311998504, 717.2719689515146, 3957.426173204869, 3966.5636779954184, 4015.77913214776, 4018.4374187613757, 4092.3043082676018, 54670.453295466534, 56065.159022614695, 56438.71780641071, 56460.43539564634, 56563.0, 48839.0, 48948.75525622349, 49094.0, 49698.0, 50505.242421363706, 44224.55775442269, 44967.0, 45046.32430513545, 45366.31950520745, 46225.537744622794, 7695.345895598937, 8233.38249631268, 8413.032501262189, 8612.224899759052, 8845.203931646183, 32987.505187421724, 33210.33579328448, 33579.328413432086, 34288.0, 34751.304973900886, 42416.1516769669, 42920.57079429291, 42948.1410371797, 43058.35412468878, 43978.34032489451, 11169.497372618089, 11197.944010279896, 11260.718482038015, 11346.432678366215, 11723.941380293043, 8982.281417486716, 12158.209716368408, 12562.937185314015, 12573.0, 12586.0, 11603.941980290045, 11685.474153663276, 11743.647690569296, 11758.470868810753, 11789.174757766874, 11273.492692829006, 11656.30062196271, 11723.237989530653, 11801.0, 11851.229670071418, 11704.88295117072, 11774.587889424172, 11777.587784427504, 11849.348285844362, 11852.348120853436, 9865.91474937742, 10265.84601230997, 10433.582656693647, 10441.738956526147, 10551.94724026375, 8695.478271303742, 9044.728658140266, 9741.707748767549, 9886.456244906312, 9955.20358371343], "unit": "score", "name": "yui.html", "value": 6426.2858165628595}], "name": "dromaeo_css", "value": 6921.850114261724}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 107.0, 111.0, 112.0, 112.0, 101.0, 112.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.2}, {"lowerIsBetter": true, "replicates": [155.0, 128.0, 159.0, 165.0, 126.0, 163.0, 158.0, 126.0, 169.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 147.5}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 163.0, 163.0, 164.0, 162.0, 160.0, 165.0, 163.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.5}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 95.0, 93.0, 73.0, 73.0, 73.0, 121.0, 98.0, 72.0], "unit": "score", "name": "audio-fft", "value": 84.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 147.0, 95.0, 95.0, 95.0, 140.0, 96.0, 96.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 109.7}, {"lowerIsBetter": true, "replicates": [120.0, 115.0, 115.0, 115.0, 115.0, 116.0, 115.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.6}, {"lowerIsBetter": true, "replicates": [145.0, 147.0, 146.0, 145.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [98.0, 96.0, 97.0, 96.0, 97.0, 97.0, 97.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.8}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 55.0, 55.0, 55.0, 56.0, 59.0, 63.0, 53.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.9}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 69.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 83.0, 83.0, 83.0, 83.0, 83.0, 83.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.0}, {"lowerIsBetter": true, "replicates": [120.0, 117.0, 124.0, 116.0, 131.0, 115.0, 119.0, 115.0, 114.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.0}, {"lowerIsBetter": true, "replicates": [152.0, 140.0, 151.0, 154.0, 162.0, 155.0, 139.0, 152.0, 151.0, 152.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.8}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 70.0, 71.0, 68.0, 68.0, 70.0, 73.0, 69.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.0}], "name": "kraken", "value": 1519.9}]} 13:12:21 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1519.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6921.85"}}} 13:12:21 INFO - Return code: 0 13:12:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 13:12:21 INFO - # TBPL SUCCESS # 13:12:21 INFO - Running post-action listener: _resource_record_post_action 13:12:21 INFO - Running post-run listener: _resource_record_post_run 13:12:22 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 538980352; Read time: 16; Write time: 422084 13:12:22 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 240422912; Read time: 0; Write time: 216488 13:12:22 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 298287104; Read time: 16; Write time: 205560 13:12:22 INFO - Running post-run listener: _upload_blobber_files 13:12:22 INFO - Blob upload gear active. 13:12:22 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 13:12:22 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 13:12:22 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', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 13:12:22 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 Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 13:12:23 INFO - (blobuploader) - INFO - Open directory for files ... 13:12:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:12:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:12:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:12:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:12:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:12:24 INFO - (blobuploader) - INFO - Done attempting. 13:12:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 13:12:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:12:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:12:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:12:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:12:25 INFO - (blobuploader) - INFO - Done attempting. 13:12:25 INFO - (blobuploader) - INFO - Iteration through files over. 13:12:25 INFO - Return code: 0 13:12:25 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 13:12:25 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 13:12:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd9b230445f04e251d114ef0477c2646f200a9b9a45ec23f50659b36381c17ffc3049e76375c98a791901ab94ed8b526b0c229d87046954a748b9104ae172f43", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48753258ad0e27840f4dde9f4ddedd31086e77d51b755613d6baa15ca30ce2a089985d2b6f59a22fc31ee755ea18c06fc979b8a29ec9e3473cf1d933eff787a5"} 13:12:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 13:12:25 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 13:12:25 INFO - Contents: 13:12:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd9b230445f04e251d114ef0477c2646f200a9b9a45ec23f50659b36381c17ffc3049e76375c98a791901ab94ed8b526b0c229d87046954a748b9104ae172f43", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48753258ad0e27840f4dde9f4ddedd31086e77d51b755613d6baa15ca30ce2a089985d2b6f59a22fc31ee755ea18c06fc979b8a29ec9e3473cf1d933eff787a5"} 13:12:25 INFO - Running post-run listener: copy_logs_to_upload_dir 13:12:25 INFO - Copying logs to upload dir... 13:12:25 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 13:12:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.915457 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-02-19 13:12:24.954551) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-19 13:12:24.957734) ========= 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=6dbc10da6d83fee962c624be000001a8-1455914880.598177-993953364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd9b230445f04e251d114ef0477c2646f200a9b9a45ec23f50659b36381c17ffc3049e76375c98a791901ab94ed8b526b0c229d87046954a748b9104ae172f43", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48753258ad0e27840f4dde9f4ddedd31086e77d51b755613d6baa15ca30ce2a089985d2b6f59a22fc31ee755ea18c06fc979b8a29ec9e3473cf1d933eff787a5"} build_url:https://queue.taskcluster.net/v1/task/Tfa2so9DTV--qfZQCoeSvw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011418 build_url: 'https://queue.taskcluster.net/v1/task/Tfa2so9DTV--qfZQCoeSvw/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/Firefox/sha512/bd9b230445f04e251d114ef0477c2646f200a9b9a45ec23f50659b36381c17ffc3049e76375c98a791901ab94ed8b526b0c229d87046954a748b9104ae172f43", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48753258ad0e27840f4dde9f4ddedd31086e77d51b755613d6baa15ca30ce2a089985d2b6f59a22fc31ee755ea18c06fc979b8a29ec9e3473cf1d933eff787a5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-19 13:12:24.982836) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 13:12:24.983254) ========= 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=6dbc10da6d83fee962c624be000001a8-1455914880.598177-993953364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 13:12:25.067284) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-19 13:12:25.067647) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-19 13:12:25.067960) ========= ========= Total master_lag: 0.28 =========