builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-069 starttime: 1453749715.81 results: success (0) buildid: 20160125032407 builduid: 84a569e400f549d78ae6c3dedf0c2ad7 revision: 3bfa5bc61b626761d487b45c170b115259f69d6b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:55.807497) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:55.807994) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:55.808289) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1861a34ebfea852630dec091000001fa-1453749715.475065-1229317293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004929 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:55.829646) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:55.829949) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:55.843198) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:55.843583) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1861a34ebfea852630dec091000001fa-1453749715.475065-1229317293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:55.892516) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:55.892835) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:55.893200) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:55.893484) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1861a34ebfea852630dec091000001fa-1453749715.475065-1229317293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-25 11:21:56-- 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.5M=0s 2016-01-25 11:21:56 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128856 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:56.037361) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:56.037685) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1861a34ebfea852630dec091000001fa-1453749715.475065-1229317293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020083 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:56.087318) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:56.087673) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3bfa5bc61b626761d487b45c170b115259f69d6b --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3bfa5bc61b626761d487b45c170b115259f69d6b --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1861a34ebfea852630dec091000001fa-1453749715.475065-1229317293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-25 11:21:56,439 truncating revision to first 12 chars 2016-01-25 11:21:56,439 Setting DEBUG logging. 2016-01-25 11:21:56,439 attempt 1/10 2016-01-25 11:21:56,439 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3bfa5bc61b62?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-25 11:21:56,688 unpacking tar archive at: mozilla-aurora-3bfa5bc61b62/testing/mozharness/ program finished with exit code 0 elapsedTime=0.545414 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:56.647081) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:56.647496) ========= echo 3bfa5bc61b626761d487b45c170b115259f69d6b in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3bfa5bc61b626761d487b45c170b115259f69d6b'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1861a34ebfea852630dec091000001fa-1453749715.475065-1229317293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 3bfa5bc61b626761d487b45c170b115259f69d6b program finished with exit code 0 elapsedTime=0.004233 script_repo_revision: '3bfa5bc61b626761d487b45c170b115259f69d6b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:56.698928) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:56.699302) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 11:21:56.713028) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-01-25 11:21:56.713419) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1861a34ebfea852630dec091000001fa-1453749715.475065-1229317293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:21:57 INFO - MultiFileLogger online at 20160125 11:21:57 in /builds/slave/test-pgo 11:21:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:21:57 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:21:57 INFO - {'append_to_log': False, 11:21:57 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:21:57 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:21:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:21:57 INFO - 'branch': 'Mozilla-Aurora', 11:21:57 INFO - 'buildbot_json_path': 'buildprops.json', 11:21:57 INFO - 'config_files': ('talos/linux_config.py',), 11:21:57 INFO - 'default_actions': ('clobber', 11:21:57 INFO - 'read-buildbot-config', 11:21:57 INFO - 'download-and-extract', 11:21:57 INFO - 'populate-webroot', 11:21:57 INFO - 'create-virtualenv', 11:21:57 INFO - 'install', 11:21:57 INFO - 'run-tests'), 11:21:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:21:57 INFO - 'download_minidump_stackwalk': True, 11:21:57 INFO - 'download_symbols': 'ondemand', 11:21:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:21:57 INFO - 'tooltool.py': '/tools/tooltool.py', 11:21:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:21:57 INFO - '/tools/misc-python/virtualenv.py')}, 11:21:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:21:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:21:57 INFO - 'installer_path': 'installer.exe', 11:21:57 INFO - 'log_level': 'info', 11:21:57 INFO - 'log_name': 'talos', 11:21:57 INFO - 'log_to_console': True, 11:21:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:21:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:21:57 INFO - 'opt_config_files': (), 11:21:57 INFO - 'pip_index': False, 11:21:57 INFO - 'sps_profile': False, 11:21:57 INFO - 'sps_profile_interval': 0, 11:21:57 INFO - 'suite': 'dromaeojs-e10s', 11:21:57 INFO - 'system_bits': '32', 11:21:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:21:57 INFO - 'title': 'talos-linux64-ix-069', 11:21:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:21:57 INFO - 'use_talos_json': True, 11:21:57 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:21:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:21:57 INFO - 'work_dir': 'build'} 11:21:57 INFO - ##### 11:21:57 INFO - ##### Running clobber step. 11:21:57 INFO - ##### 11:21:57 INFO - Running pre-action listener: _resource_record_pre_action 11:21:57 INFO - Running main action method: clobber 11:21:57 INFO - rmtree: /builds/slave/test-pgo/build 11:21:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:21:58 INFO - Running post-action listener: _resource_record_post_action 11:21:58 INFO - ##### 11:21:58 INFO - ##### Running read-buildbot-config step. 11:21:58 INFO - ##### 11:21:58 INFO - Running pre-action listener: _resource_record_pre_action 11:21:58 INFO - Running main action method: read_buildbot_config 11:21:58 INFO - Using buildbot properties: 11:21:58 INFO - { 11:21:58 INFO - "properties": { 11:21:58 INFO - "buildnumber": 90, 11:21:58 INFO - "product": "firefox", 11:21:58 INFO - "script_repo_revision": "production", 11:21:58 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 11:21:58 INFO - "repository": "", 11:21:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 11:21:58 INFO - "buildid": "20160125032407", 11:21:58 INFO - "slavename": "talos-linux64-ix-069", 11:21:58 INFO - "pgo_build": "True", 11:21:58 INFO - "basedir": "/builds/slave/test-pgo", 11:21:58 INFO - "project": "", 11:21:58 INFO - "platform": "ubuntu64_hw", 11:21:58 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:21:58 INFO - "slavebuilddir": "test", 11:21:58 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:21:58 INFO - "branch": "mozilla-aurora", 11:21:58 INFO - "repo_path": "releases/mozilla-aurora", 11:21:58 INFO - "stage_platform": "linux64-pgo", 11:21:58 INFO - "builduid": "84a569e400f549d78ae6c3dedf0c2ad7", 11:21:58 INFO - "revision": "3bfa5bc61b626761d487b45c170b115259f69d6b" 11:21:58 INFO - }, 11:21:58 INFO - "sourcestamp": { 11:21:58 INFO - "repository": "", 11:21:58 INFO - "hasPatch": false, 11:21:58 INFO - "project": "", 11:21:58 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 11:21:58 INFO - "changes": [ 11:21:58 INFO - { 11:21:58 INFO - "category": null, 11:21:58 INFO - "files": [ 11:21:58 INFO - { 11:21:58 INFO - "url": null, 11:21:58 INFO - "name": "https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 11:21:58 INFO - } 11:21:58 INFO - ], 11:21:58 INFO - "repository": "", 11:21:58 INFO - "rev": "3bfa5bc61b626761d487b45c170b115259f69d6b", 11:21:58 INFO - "who": "cbook@mozilla.com", 11:21:58 INFO - "when": 1453730728, 11:21:58 INFO - "number": 7510949, 11:21:58 INFO - "comments": "Bug 1234675 - Ability to disable e10s for users with addons. r=Mossop, a=sylvestre", 11:21:58 INFO - "project": "", 11:21:58 INFO - "at": "Mon 25 Jan 2016 06:05:28", 11:21:58 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 11:21:58 INFO - "revlink": "", 11:21:58 INFO - "properties": [ 11:21:58 INFO - [ 11:21:58 INFO - "buildid", 11:21:58 INFO - "20160125032407", 11:21:58 INFO - "Change" 11:21:58 INFO - ], 11:21:58 INFO - [ 11:21:58 INFO - "builduid", 11:21:58 INFO - "84a569e400f549d78ae6c3dedf0c2ad7", 11:21:58 INFO - "Change" 11:21:58 INFO - ], 11:21:58 INFO - [ 11:21:58 INFO - "pgo_build", 11:21:58 INFO - "True", 11:21:58 INFO - "Change" 11:21:58 INFO - ] 11:21:58 INFO - ], 11:21:58 INFO - "revision": "3bfa5bc61b626761d487b45c170b115259f69d6b" 11:21:58 INFO - } 11:21:58 INFO - ], 11:21:58 INFO - "revision": "3bfa5bc61b626761d487b45c170b115259f69d6b" 11:21:58 INFO - } 11:21:58 INFO - } 11:21:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 11:21:58 INFO - Running post-action listener: _resource_record_post_action 11:21:58 INFO - ##### 11:21:58 INFO - ##### Running download-and-extract step. 11:21:58 INFO - ##### 11:21:58 INFO - Running pre-action listener: _resource_record_pre_action 11:21:58 INFO - Running main action method: download_and_extract 11:21:58 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:58 INFO - https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:21:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/test_packages.json 11:21:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/test_packages.json 11:21:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 11:21:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 11:21:58 INFO - Downloaded 1302 bytes. 11:21:58 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 11:21:58 INFO - Using the following test package requirements: 11:21:58 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 11:21:58 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:21:58 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:21:58 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:21:58 INFO - u'jsshell-linux-x86_64.zip'], 11:21:58 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:21:58 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:21:58 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 11:21:58 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:21:58 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:21:58 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:21:58 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:21:58 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:21:58 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:21:58 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 11:21:58 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:21:58 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:21:58 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:58 INFO - https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:21:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:21:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:21:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:21:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:21:59 INFO - Downloaded 21579043 bytes. 11:21:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 11:21:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:21:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:22:00 INFO - Return code: 0 11:22:00 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:22:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:00 INFO - https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:22:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:22:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:22:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:22:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:22:02 INFO - Downloaded 21579043 bytes. 11:22:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 11:22:02 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:22:02 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:22:03 INFO - Return code: 0 11:22: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')]} 11:22:03 INFO - https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:22:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 11:22:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 11:22:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 11:22:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:22:11 INFO - Downloaded 11132038 bytes. 11:22:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 11:22:11 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 11:22:11 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 11:22:11 INFO - Return code: 0 11:22:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:11 INFO - https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:22:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:22:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:22:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:22:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:22:14 INFO - Downloaded 58070235 bytes. 11:22:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:22:14 INFO - mkdir: /builds/slave/test-pgo/properties 11:22:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:22:14 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:22:14 INFO - Contents: 11:22:14 INFO - build_url:https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:22:14 INFO - Running post-action listener: _resource_record_post_action 11:22:14 INFO - Running post-action listener: set_extra_try_arguments 11:22:14 INFO - ##### 11:22:14 INFO - ##### Running populate-webroot step. 11:22:14 INFO - ##### 11:22:14 INFO - Running pre-action listener: _resource_record_pre_action 11:22:14 INFO - Running main action method: populate_webroot 11:22:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:22:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:22:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:22:14 INFO - '--tppagecycles', 11:22:14 INFO - '7'], 11:22:14 INFO - 'tests': ['tsvgm']}}, 11:22:14 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:22:14 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:22:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:22:14 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:22:14 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:22:14 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:22:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:22:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:14 INFO - 'talos_options': ['--e10s'], 11:22:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:22:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:14 INFO - 'tests': ['damp', 'tps']}, 11:22:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:14 INFO - 'talos_options': ['--e10s'], 11:22:14 INFO - 'tests': ['damp', 'tps']}, 11:22:14 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:22:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:22:14 INFO - 'other': {'tests': ['a11yr', 11:22:14 INFO - 'ts_paint', 11:22:14 INFO - 'tpaint', 11:22:14 INFO - 'sessionrestore', 11:22:14 INFO - 'sessionrestore_no_auto_restore']}, 11:22:14 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:22:14 INFO - 'tests': ['a11yr', 11:22:14 INFO - 'ts_paint', 11:22:14 INFO - 'tpaint', 11:22:14 INFO - 'sessionrestore', 11:22:14 INFO - 'sessionrestore_no_auto_restore']}, 11:22:14 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:22:14 INFO - 'tests': ['a11yr', 11:22:14 INFO - 'ts_paint', 11:22:14 INFO - 'tpaint', 11:22:14 INFO - 'sessionrestore', 11:22:14 INFO - 'sessionrestore_no_auto_restore']}, 11:22:14 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:22:14 INFO - 'tests': ['a11yr', 11:22:14 INFO - 'ts_paint', 11:22:14 INFO - 'tpaint', 11:22:14 INFO - 'sessionrestore', 11:22:14 INFO - 'sessionrestore_no_auto_restore']}, 11:22:14 INFO - 'other_l64': {'tests': ['a11yr', 11:22:14 INFO - 'ts_paint', 11:22:14 INFO - 'tpaint', 11:22:14 INFO - 'sessionrestore', 11:22:14 INFO - 'sessionrestore_no_auto_restore']}, 11:22:14 INFO - 'other_nol64': {'tests': ['a11yr', 11:22:14 INFO - 'ts_paint', 11:22:14 INFO - 'tpaint', 11:22:14 INFO - 'sessionrestore', 11:22:14 INFO - 'sessionrestore_no_auto_restore']}, 11:22:14 INFO - 'svgr': {'tests': ['tsvgx', 11:22:14 INFO - 'tsvgr_opacity', 11:22:14 INFO - 'tart', 11:22:14 INFO - 'tscrollx', 11:22:14 INFO - 'cart']}, 11:22:14 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:22:14 INFO - 'tests': ['tsvgx', 11:22:14 INFO - 'tsvgr_opacity', 11:22:14 INFO - 'tart', 11:22:14 INFO - 'tscrollx', 11:22:14 INFO - 'cart']}, 11:22:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:14 INFO - 'tests': ['tp5o']}, 11:22:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:14 INFO - 'talos_options': ['--e10s'], 11:22:14 INFO - 'tests': ['tp5o']}, 11:22:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:14 INFO - 'talos_options': ['--xperf_path', 11:22:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:22:14 INFO - 'tests': ['tp5n']}, 11:22:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:14 INFO - 'talos_options': ['--e10s', 11:22:14 INFO - '--xperf_path', 11:22:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:22:14 INFO - 'tests': ['tp5n']}}, 11:22:14 INFO - 'talos.zip': {'path': '', 11:22:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:22:14 INFO - Running post-action listener: _resource_record_post_action 11:22:14 INFO - ##### 11:22:14 INFO - ##### Running create-virtualenv step. 11:22:14 INFO - ##### 11:22:14 INFO - Running pre-action listener: _resource_record_pre_action 11:22:14 INFO - Running main action method: create_virtualenv 11:22:14 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:22:14 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 11:22:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:22:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:22:14 INFO - Using real prefix '/usr' 11:22:14 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:22:14 INFO - Installing distribute.............................................................................................................................................................................................done. 11:22:16 INFO - Installing pip.................done. 11:22:16 INFO - Return code: 0 11:22:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2b6d607f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda7450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe39a50>, '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 0xda5550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda59e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453749715.475065-1229317293', '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 11:22:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 11:22:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:22:16 INFO - Using env: {'DISPLAY': ':0', 11:22:16 INFO - 'HOME': '/home/cltbld', 11:22:16 INFO - 'LANG': 'en_US.UTF-8', 11:22:16 INFO - 'LANGUAGE': 'en_US:en', 11:22:16 INFO - 'LOGNAME': 'cltbld', 11:22:16 INFO - 'MAIL': '/var/mail/cltbld', 11:22:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:16 INFO - 'MOZ_NO_REMOTE': '1', 11:22:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:16 INFO - 'NO_EM_RESTART': '1', 11:22:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:16 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:16 INFO - 'SHELL': '/bin/bash', 11:22:16 INFO - 'SHLVL': '1', 11:22:16 INFO - 'TERM': 'linux', 11:22:16 INFO - 'TMOUT': '86400', 11:22:16 INFO - 'USER': 'cltbld', 11:22:16 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453749715.475065-1229317293', 11:22:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:16 INFO - '_': '/tools/buildbot/bin/python'} 11:22:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:16 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 11:22:16 INFO - Cleaning up... 11:22:16 INFO - Return code: 0 11:22:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2b6d607f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda7450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe39a50>, '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 0xda5550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda59e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453749715.475065-1229317293', '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 11:22:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 11:22:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:22:16 INFO - Using env: {'DISPLAY': ':0', 11:22:16 INFO - 'HOME': '/home/cltbld', 11:22:16 INFO - 'LANG': 'en_US.UTF-8', 11:22:16 INFO - 'LANGUAGE': 'en_US:en', 11:22:16 INFO - 'LOGNAME': 'cltbld', 11:22:16 INFO - 'MAIL': '/var/mail/cltbld', 11:22:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:16 INFO - 'MOZ_NO_REMOTE': '1', 11:22:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:16 INFO - 'NO_EM_RESTART': '1', 11:22:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:16 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:16 INFO - 'SHELL': '/bin/bash', 11:22:16 INFO - 'SHLVL': '1', 11:22:16 INFO - 'TERM': 'linux', 11:22:16 INFO - 'TMOUT': '86400', 11:22:16 INFO - 'USER': 'cltbld', 11:22:16 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453749715.475065-1229317293', 11:22:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:16 INFO - '_': '/tools/buildbot/bin/python'} 11:22:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:17 INFO - Downloading/unpacking psutil>=0.7.1 11:22: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 11:22: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 11:22: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 11:22: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 11:22: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 11:22: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 11:22:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:22:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:22:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:22:19 INFO - Installing collected packages: psutil 11:22:19 INFO - Running setup.py install for psutil 11:22:19 INFO - building 'psutil._psutil_linux' extension 11:22:19 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 11:22:19 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 11:22:19 INFO - building 'psutil._psutil_posix' extension 11:22:19 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 11:22:19 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 11:22:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:22:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:22:19 INFO - Successfully installed psutil 11:22:19 INFO - Cleaning up... 11:22:19 INFO - Return code: 0 11:22:19 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:22:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:19 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 0x7f2b6d607f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda7450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe39a50>, '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 0xda5550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda59e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453749715.475065-1229317293', '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 11:22:19 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 11:22:19 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 11:22:19 INFO - Using env: {'DISPLAY': ':0', 11:22:19 INFO - 'HOME': '/home/cltbld', 11:22:19 INFO - 'LANG': 'en_US.UTF-8', 11:22:19 INFO - 'LANGUAGE': 'en_US:en', 11:22:19 INFO - 'LOGNAME': 'cltbld', 11:22:19 INFO - 'MAIL': '/var/mail/cltbld', 11:22:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:19 INFO - 'MOZ_NO_REMOTE': '1', 11:22:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:19 INFO - 'NO_EM_RESTART': '1', 11:22:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:19 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:19 INFO - 'SHELL': '/bin/bash', 11:22:19 INFO - 'SHLVL': '1', 11:22:19 INFO - 'TERM': 'linux', 11:22:19 INFO - 'TMOUT': '86400', 11:22:19 INFO - 'USER': 'cltbld', 11:22:19 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453749715.475065-1229317293', 11:22:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:19 INFO - '_': '/tools/buildbot/bin/python'} 11:22:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:19 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:21 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:22:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:22:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:22:21 INFO - Installing collected packages: mozsystemmonitor 11:22:21 INFO - Running setup.py install for mozsystemmonitor 11:22:21 INFO - Successfully installed mozsystemmonitor 11:22:21 INFO - Cleaning up... 11:22:21 INFO - Return code: 0 11:22:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:22: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')]} 11:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22: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')]} 11:22:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:21 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 0x7f2b6d607f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda7450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe39a50>, '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 0xda5550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda59e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453749715.475065-1229317293', '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 11:22:21 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 11:22:21 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 11:22:21 INFO - Using env: {'DISPLAY': ':0', 11:22:21 INFO - 'HOME': '/home/cltbld', 11:22:21 INFO - 'LANG': 'en_US.UTF-8', 11:22:21 INFO - 'LANGUAGE': 'en_US:en', 11:22:21 INFO - 'LOGNAME': 'cltbld', 11:22:21 INFO - 'MAIL': '/var/mail/cltbld', 11:22:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:21 INFO - 'MOZ_NO_REMOTE': '1', 11:22:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:21 INFO - 'NO_EM_RESTART': '1', 11:22:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:21 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:21 INFO - 'SHELL': '/bin/bash', 11:22:21 INFO - 'SHLVL': '1', 11:22:21 INFO - 'TERM': 'linux', 11:22:21 INFO - 'TMOUT': '86400', 11:22:21 INFO - 'USER': 'cltbld', 11:22:21 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453749715.475065-1229317293', 11:22:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:21 INFO - '_': '/tools/buildbot/bin/python'} 11:22:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:22 INFO - Downloading/unpacking blobuploader==1.2.4 11:22:22 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 11:22:22 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 11:22:22 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 11:22:22 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 11:22:22 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 11:22:22 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 11:22:23 INFO - Downloading blobuploader-1.2.4.tar.gz 11:22:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:22:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:22: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 11:22: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 11:22: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 11:22: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 11:22: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 11:22: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 11:22:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:22:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:22:24 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 11:22:24 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 11:22:24 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 11:22:24 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 11:22:24 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 11:22:24 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 11:22:24 INFO - Downloading docopt-0.6.1.tar.gz 11:22:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:22:24 INFO - Installing collected packages: blobuploader, requests, docopt 11:22:24 INFO - Running setup.py install for blobuploader 11:22:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:22:24 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:22:24 INFO - Running setup.py install for requests 11:22:24 INFO - Running setup.py install for docopt 11:22:25 INFO - Successfully installed blobuploader requests docopt 11:22:25 INFO - Cleaning up... 11:22:25 INFO - Return code: 0 11:22:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:22: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')]} 11:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22: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')]} 11:22:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:25 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 0x7f2b6d607f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda7450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe39a50>, '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 0xda5550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda59e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453749715.475065-1229317293', '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 11:22:25 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 11:22:25 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 11:22:25 INFO - Using env: {'DISPLAY': ':0', 11:22:25 INFO - 'HOME': '/home/cltbld', 11:22:25 INFO - 'LANG': 'en_US.UTF-8', 11:22:25 INFO - 'LANGUAGE': 'en_US:en', 11:22:25 INFO - 'LOGNAME': 'cltbld', 11:22:25 INFO - 'MAIL': '/var/mail/cltbld', 11:22:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:25 INFO - 'MOZ_NO_REMOTE': '1', 11:22:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:25 INFO - 'NO_EM_RESTART': '1', 11:22:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:25 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:25 INFO - 'SHELL': '/bin/bash', 11:22:25 INFO - 'SHLVL': '1', 11:22:25 INFO - 'TERM': 'linux', 11:22:25 INFO - 'TMOUT': '86400', 11:22:25 INFO - 'USER': 'cltbld', 11:22:25 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453749715.475065-1229317293', 11:22:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:25 INFO - '_': '/tools/buildbot/bin/python'} 11:22:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:22:25 INFO - Running setup.py (path:/tmp/pip-wdltfL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:22:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:22:25 INFO - Running setup.py (path:/tmp/pip-rPxkhn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:22:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:22:25 INFO - Running setup.py (path:/tmp/pip-JyRFNZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:22:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:22:25 INFO - Running setup.py (path:/tmp/pip-2vUqSW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:22:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:22:25 INFO - Running setup.py (path:/tmp/pip-ep9sSG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:22:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:22:25 INFO - Running setup.py (path:/tmp/pip-bD9gEe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:22:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:22:25 INFO - Running setup.py (path:/tmp/pip-iBz0Rn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:22:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:22:25 INFO - Running setup.py (path:/tmp/pip-DLf_jv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:22:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:22:25 INFO - Running setup.py (path:/tmp/pip-HitPHl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:22:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:22:25 INFO - Running setup.py (path:/tmp/pip-S79NQX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:22:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:22:26 INFO - Running setup.py (path:/tmp/pip-AXi4s1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:22:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:22:26 INFO - Running setup.py (path:/tmp/pip-rjWEcm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:22:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:22:26 INFO - Running setup.py (path:/tmp/pip-JpyL4z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:22:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:22:26 INFO - Running setup.py (path:/tmp/pip-uvCKQY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:22:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:22:26 INFO - Running setup.py (path:/tmp/pip-wCNqRy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:22:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:22:26 INFO - Running setup.py (path:/tmp/pip-lgCc7p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:22:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:22:26 INFO - Running setup.py (path:/tmp/pip-NVIsfE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:22:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:22:26 INFO - Running setup.py install for manifestparser 11:22:26 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:22:26 INFO - Running setup.py install for mozcrash 11:22:26 INFO - Running setup.py install for mozdebug 11:22:26 INFO - Running setup.py install for mozdevice 11:22:26 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:22:26 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:22:26 INFO - Running setup.py install for mozfile 11:22:27 INFO - Running setup.py install for mozhttpd 11:22:27 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:22:27 INFO - Running setup.py install for mozinfo 11:22:27 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:22:27 INFO - Running setup.py install for mozInstall 11:22:27 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:22:27 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:22:27 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:22:27 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:22:27 INFO - Running setup.py install for mozleak 11:22:27 INFO - Running setup.py install for mozlog 11:22:27 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:22:27 INFO - Running setup.py install for moznetwork 11:22:27 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:22:27 INFO - Running setup.py install for mozprocess 11:22:27 INFO - Running setup.py install for mozprofile 11:22:27 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:22:27 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:22:27 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:22:27 INFO - Running setup.py install for mozrunner 11:22:28 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:22:28 INFO - Running setup.py install for mozscreenshot 11:22:28 INFO - Running setup.py install for moztest 11:22:28 INFO - Running setup.py install for mozversion 11:22:28 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:22:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:22:28 INFO - Cleaning up... 11:22:28 INFO - Return code: 0 11:22:28 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:22: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')]} 11:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22: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')]} 11:22:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:28 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 0x7f2b6d607f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda7450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe39a50>, '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 0xda5550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda59e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453749715.475065-1229317293', '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 11:22:28 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 11:22:28 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 11:22:28 INFO - Using env: {'DISPLAY': ':0', 11:22:28 INFO - 'HOME': '/home/cltbld', 11:22:28 INFO - 'LANG': 'en_US.UTF-8', 11:22:28 INFO - 'LANGUAGE': 'en_US:en', 11:22:28 INFO - 'LOGNAME': 'cltbld', 11:22:28 INFO - 'MAIL': '/var/mail/cltbld', 11:22:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:28 INFO - 'MOZ_NO_REMOTE': '1', 11:22:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:28 INFO - 'NO_EM_RESTART': '1', 11:22:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:28 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:28 INFO - 'SHELL': '/bin/bash', 11:22:28 INFO - 'SHLVL': '1', 11:22:28 INFO - 'TERM': 'linux', 11:22:28 INFO - 'TMOUT': '86400', 11:22:28 INFO - 'USER': 'cltbld', 11:22:28 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453749715.475065-1229317293', 11:22:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:28 INFO - '_': '/tools/buildbot/bin/python'} 11:22:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:22:28 INFO - Running setup.py (path:/tmp/pip-bf_MeP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:22:28 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)) 11:22:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:22:28 INFO - Running setup.py (path:/tmp/pip-y5jGON-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:22:28 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)) 11:22:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:22:28 INFO - Running setup.py (path:/tmp/pip-fC20Nb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:22:28 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)) 11:22:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:22:28 INFO - Running setup.py (path:/tmp/pip-xJIDFx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:22:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 11:22:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:22:28 INFO - Running setup.py (path:/tmp/pip-qFt4gm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:22:28 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)) 11:22:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:22:28 INFO - Running setup.py (path:/tmp/pip-XevWO4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:22:29 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)) 11:22:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:22:29 INFO - Running setup.py (path:/tmp/pip-rK20H7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:22:29 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)) 11:22:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:22:29 INFO - Running setup.py (path:/tmp/pip-xfnC7z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:22:29 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)) 11:22:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:22:29 INFO - Running setup.py (path:/tmp/pip-kvfW6M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:22:29 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)) 11:22:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:22:29 INFO - Running setup.py (path:/tmp/pip-fbXLx5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:22:29 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)) 11:22:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:22:29 INFO - Running setup.py (path:/tmp/pip-1I3U_R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:22:29 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)) 11:22:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:22:29 INFO - Running setup.py (path:/tmp/pip-blrpgv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:22:29 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)) 11:22:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:22:29 INFO - Running setup.py (path:/tmp/pip-kXGTpt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:22:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 11:22:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:22:29 INFO - Running setup.py (path:/tmp/pip-KeCOkN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:22:29 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)) 11:22:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:22:29 INFO - Running setup.py (path:/tmp/pip-sob_Zy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:22:29 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)) 11:22:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:22:29 INFO - Running setup.py (path:/tmp/pip-7uUv1K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:22:29 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)) 11:22:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:22:29 INFO - Running setup.py (path:/tmp/pip-U4eIsQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:22:29 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)) 11:22:29 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)) 11:22:29 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)) 11:22:29 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)) 11:22:29 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:22:29 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:22:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:22:29 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 11:22:29 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 11:22:29 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 11:22:29 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 11:22:29 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 11:22:29 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 11:22:31 INFO - Downloading blessings-1.6.tar.gz 11:22:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:22:31 INFO - Installing collected packages: blessings 11:22:31 INFO - Running setup.py install for blessings 11:22:31 INFO - Successfully installed blessings 11:22:31 INFO - Cleaning up... 11:22:31 INFO - Return code: 0 11:22:31 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:22:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:22:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:22:32 INFO - Reading from file tmpfile_stdout 11:22:32 INFO - Current package versions: 11:22:32 INFO - argparse == 1.2.1 11:22:32 INFO - blessings == 1.6 11:22:32 INFO - blobuploader == 1.2.4 11:22:32 INFO - docopt == 0.6.1 11:22:32 INFO - manifestparser == 1.1 11:22:32 INFO - mozInstall == 1.12 11:22:32 INFO - mozcrash == 0.16 11:22:32 INFO - mozdebug == 0.1 11:22:32 INFO - mozdevice == 0.47 11:22:32 INFO - mozfile == 1.2 11:22:32 INFO - mozhttpd == 0.7 11:22:32 INFO - mozinfo == 0.9 11:22:32 INFO - mozleak == 0.1 11:22:32 INFO - mozlog == 3.1 11:22:32 INFO - moznetwork == 0.27 11:22:32 INFO - mozprocess == 0.22 11:22:32 INFO - mozprofile == 0.27 11:22:32 INFO - mozrunner == 6.11 11:22:32 INFO - mozscreenshot == 0.1 11:22:32 INFO - mozsystemmonitor == 0.0 11:22:32 INFO - moztest == 0.7 11:22:32 INFO - mozversion == 1.4 11:22:32 INFO - psutil == 3.1.1 11:22:32 INFO - requests == 1.2.3 11:22:32 INFO - wsgiref == 0.1.2 11:22:32 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:22:32 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')]} 11:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:32 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')]} 11:22:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:32 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 0x7f2b6d607f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda7450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe39a50>, '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 0xda5550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda59e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453749715.475065-1229317293', '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 11:22:32 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 11:22:32 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 11:22:32 INFO - Using env: {'DISPLAY': ':0', 11:22:32 INFO - 'HOME': '/home/cltbld', 11:22:32 INFO - 'LANG': 'en_US.UTF-8', 11:22:32 INFO - 'LANGUAGE': 'en_US:en', 11:22:32 INFO - 'LOGNAME': 'cltbld', 11:22:32 INFO - 'MAIL': '/var/mail/cltbld', 11:22:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:32 INFO - 'MOZ_NO_REMOTE': '1', 11:22:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:32 INFO - 'NO_EM_RESTART': '1', 11:22:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:32 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:32 INFO - 'SHELL': '/bin/bash', 11:22:32 INFO - 'SHLVL': '1', 11:22:32 INFO - 'TERM': 'linux', 11:22:32 INFO - 'TMOUT': '86400', 11:22:32 INFO - 'USER': 'cltbld', 11:22:32 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453749715.475065-1229317293', 11:22:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:32 INFO - '_': '/tools/buildbot/bin/python'} 11:22:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:32 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 1)) 11:22:32 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 2)) 11:22:32 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 3)) 11:22:32 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 4)) 11:22:32 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 5)) 11:22:32 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 6)) 11:22:32 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 7)) 11:22:32 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 8)) 11:22:32 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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 11:22:32 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 3)) 11:22:32 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.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 11:22:32 INFO - Cleaning up... 11:22:32 INFO - Return code: 0 11:22:32 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:22:32 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')]} 11:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:32 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')]} 11:22:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:32 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 0x7f2b6d607f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda7450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe39a50>, '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 0xda5550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda59e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453749715.475065-1229317293', '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 11:22:32 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 11:22:32 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 11:22:32 INFO - Using env: {'DISPLAY': ':0', 11:22:32 INFO - 'HOME': '/home/cltbld', 11:22:32 INFO - 'LANG': 'en_US.UTF-8', 11:22:32 INFO - 'LANGUAGE': 'en_US:en', 11:22:32 INFO - 'LOGNAME': 'cltbld', 11:22:32 INFO - 'MAIL': '/var/mail/cltbld', 11:22:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:32 INFO - 'MOZ_NO_REMOTE': '1', 11:22:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:32 INFO - 'NO_EM_RESTART': '1', 11:22:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:32 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:32 INFO - 'SHELL': '/bin/bash', 11:22:32 INFO - 'SHLVL': '1', 11:22:32 INFO - 'TERM': 'linux', 11:22:32 INFO - 'TMOUT': '86400', 11:22:32 INFO - 'USER': 'cltbld', 11:22:32 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453749715.475065-1229317293', 11:22:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:32 INFO - '_': '/tools/buildbot/bin/python'} 11:22:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:32 INFO - Downloading/unpacking jsonschema 11:22:32 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 11:22:32 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 11:22:32 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 11:22:32 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 11:22:32 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 11:22:32 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 11:22:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:22:34 INFO - Downloading/unpacking functools32 (from jsonschema) 11:22:34 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 11:22:34 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 11:22:34 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 11:22:34 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 11:22:34 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 11:22:34 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 11:22:34 INFO - Downloading functools32-3.2.3-2.tar.gz 11:22:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:22:34 INFO - warning: no files found matching '*.txt' 11:22:34 INFO - no previously-included directories found matching 'build' 11:22:34 INFO - no previously-included directories found matching 'dist' 11:22:34 INFO - no previously-included directories found matching '.git*' 11:22:34 INFO - Installing collected packages: jsonschema, functools32 11:22:34 INFO - Running setup.py install for functools32 11:22:34 INFO - warning: no files found matching '*.txt' 11:22:34 INFO - no previously-included directories found matching 'build' 11:22:34 INFO - no previously-included directories found matching 'dist' 11:22:34 INFO - no previously-included directories found matching '.git*' 11:22:34 INFO - Successfully installed jsonschema functools32 11:22:34 INFO - Cleaning up... 11:22:34 INFO - Return code: 0 11:22:34 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:34 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2b6d607f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda7450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe39a50>, '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 0xda5550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda59e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453749715.475065-1229317293', '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 11:22:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 11:22:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:22:34 INFO - Using env: {'DISPLAY': ':0', 11:22:34 INFO - 'HOME': '/home/cltbld', 11:22:34 INFO - 'LANG': 'en_US.UTF-8', 11:22:34 INFO - 'LANGUAGE': 'en_US:en', 11:22:34 INFO - 'LOGNAME': 'cltbld', 11:22:34 INFO - 'MAIL': '/var/mail/cltbld', 11:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:34 INFO - 'MOZ_NO_REMOTE': '1', 11:22:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:34 INFO - 'NO_EM_RESTART': '1', 11:22:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:34 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:34 INFO - 'SHELL': '/bin/bash', 11:22:34 INFO - 'SHLVL': '1', 11:22:34 INFO - 'TERM': 'linux', 11:22:34 INFO - 'TMOUT': '86400', 11:22:34 INFO - 'USER': 'cltbld', 11:22:34 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453749715.475065-1229317293', 11:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:34 INFO - '_': '/tools/buildbot/bin/python'} 11:22:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:35 INFO - Downloading/unpacking flake8 11:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:22:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:22:36 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 11:22:36 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 11:22:36 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 11:22:36 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 11:22:36 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 11:22:36 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 11:22:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:22:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:22:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:22:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:22:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:22:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:22:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:22:37 INFO - no previously-included directories found matching 'docs/_build' 11:22:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:22:37 INFO - Running setup.py install for pep8 11:22:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:22:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:22:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:22:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:22:37 INFO - no previously-included directories found matching 'docs/_build' 11:22:37 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:22:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:22:37 INFO - Cleaning up... 11:22:37 INFO - Return code: 0 11:22:37 INFO - Running post-action listener: _resource_record_post_action 11:22:37 INFO - Running post-action listener: _start_resource_monitoring 11:22:37 INFO - Starting resource monitoring. 11:22:37 INFO - ##### 11:22:37 INFO - ##### Running install step. 11:22:37 INFO - ##### 11:22:37 INFO - Running pre-action listener: _resource_record_pre_action 11:22:37 INFO - Running main action method: install 11:22:37 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:22:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:22:38 INFO - Reading from file tmpfile_stdout 11:22:38 INFO - Detecting whether we're running mozinstall >=1.0... 11:22:38 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:22:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:22:38 INFO - Reading from file tmpfile_stdout 11:22:38 INFO - Output received: 11:22:38 INFO - Usage: mozinstall [options] installer 11:22:38 INFO - Options: 11:22:38 INFO - -h, --help show this help message and exit 11:22:38 INFO - -d DEST, --destination=DEST 11:22:38 INFO - Directory to install application into. [default: 11:22:38 INFO - "/builds/slave/test-pgo"] 11:22:38 INFO - --app=APP Application being installed. [default: firefox] 11:22:38 INFO - mkdir: /builds/slave/test-pgo/build/application 11:22:38 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 11:22:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 11:22:52 INFO - Reading from file tmpfile_stdout 11:22:52 INFO - Output received: 11:22:52 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:22:52 INFO - Running post-action listener: _resource_record_post_action 11:22:52 INFO - ##### 11:22:52 INFO - ##### Running run-tests step. 11:22:52 INFO - ##### 11:22:52 INFO - Running pre-action listener: _resource_record_pre_action 11:22:52 INFO - Running main action method: run_tests 11:22:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:22:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:22:52 INFO - Python 2.7.3 11:22:52 INFO - Return code: 0 11:22:52 INFO - grabbing minidump binary from tooltool 11:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:52 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 0xe39a50>, '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 0xda5550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda59e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:22:52 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 11:22:52 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 11:22:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:22:52 INFO - Return code: 0 11:22:52 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:22:52 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:22:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:22:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:22:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:22:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:22:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:22:53 INFO - Return code: 0 11:22:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 11:22:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --webServer localhost 11:22:53 INFO - Using env: {'DISPLAY': ':0', 11:22:53 INFO - 'HOME': '/home/cltbld', 11:22:53 INFO - 'LANG': 'en_US.UTF-8', 11:22:53 INFO - 'LANGUAGE': 'en_US:en', 11:22:53 INFO - 'LOGNAME': 'cltbld', 11:22:53 INFO - 'MAIL': '/var/mail/cltbld', 11:22:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:22:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:53 INFO - 'MOZ_NO_REMOTE': '1', 11:22:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:22:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:53 INFO - 'NO_EM_RESTART': '1', 11:22:53 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:53 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:53 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:22:53 INFO - 'SHELL': '/bin/bash', 11:22:53 INFO - 'SHLVL': '1', 11:22:53 INFO - 'TERM': 'linux', 11:22:53 INFO - 'TMOUT': '86400', 11:22:53 INFO - 'USER': 'cltbld', 11:22:53 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1453749715.475065-1229317293', 11:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:53 INFO - '_': '/tools/buildbot/bin/python'} 11:22:53 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost'] with output_timeout 3600 11:22:54 INFO - mozversion INFO | application_buildid: 20160125032407 11:22:54 INFO - mozversion INFO | application_changeset: 3bfa5bc61b626761d487b45c170b115259f69d6b 11:22:54 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 11:22:54 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:22:54 INFO - mozversion INFO | application_name: Firefox 11:22:54 INFO - mozversion INFO | application_remotingname: firefox-dev 11:22:54 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:22:54 INFO - mozversion INFO | application_vendor: Mozilla 11:22:54 INFO - mozversion INFO | application_version: 45.0a2 11:22:54 INFO - mozversion INFO | platform_buildid: 20160125032407 11:22:54 INFO - mozversion INFO | platform_changeset: 3bfa5bc61b626761d487b45c170b115259f69d6b 11:22:54 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:22:54 INFO - mozversion INFO | platform_version: 45.0a2 11:22:54 INFO - 2016-01-25 11:22:54,026 DEBUG : using testdate: 1453749774 11:22:54 INFO - 2016-01-25 11:22:54,026 DEBUG : actual date: 1453749774 11:22:54 INFO - 2016-01-25 11:22:54,034 INFO : starting webserver on 'localhost:33106' 11:22:54 INFO - 2016-01-25 11:22:54,035 INFO : Starting test suite talos-linux64-ix-069.e 11:22:54 INFO - 2016-01-25 11:22:54,035 INFO : Starting test dromaeo_css 11:22:54 INFO - 2016-01-25 11:22:54,035 DEBUG : operating with platform_type : linux_ 11:22:54 INFO - 2016-01-25 11:22:54,036 INFO : Initialising browser for dromaeo_css test... 11:22:54 INFO - 2016-01-25 11:22:54,048 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpe0ocDR/profile http://localhost:33106/getInfo.html 11:22:58 INFO - 2016-01-25 11:22:58,289 DEBUG : BROWSER_OUTPUT: 11:22:58 INFO - 2016-01-25 11:22:58,289 DEBUG : BROWSER_OUTPUT: (process:29938): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:22:59 INFO - 2016-01-25 11:22:59,274 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:22:59 INFO - 2016-01-25 11:22:59,274 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:22:59 INFO - 2016-01-25 11:22:59,275 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:22:59 INFO - 2016-01-25 11:22:59,275 DEBUG : BROWSER_OUTPUT: __metrics 11:23:00 INFO - 2016-01-25 11:23:00,292 INFO : Browser initialized. 11:23:00 INFO - 2016-01-25 11:23:00,293 INFO : Running cycle 1/1 for dromaeo_css test... 11:23:00 INFO - 2016-01-25 11:23:00,293 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpe0ocDR/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:23:01 INFO - 2016-01-25 11:23:01,588 DEBUG : BROWSER_OUTPUT: 11:23:01 INFO - 2016-01-25 11:23:01,588 DEBUG : BROWSER_OUTPUT: (process:30050): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:23:12 INFO - 2016-01-25 11:23:12,092 DEBUG : BROWSER_OUTPUT: RSS: Main: 138055680 11:23:12 INFO - 2016-01-25 11:23:12,093 DEBUG : BROWSER_OUTPUT: 11:24:01 INFO - 2016-01-25 11:24:01,690 DEBUG : BROWSER_OUTPUT: 1453749841688 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] 11:26:09 INFO - 2016-01-25 11:26:09,550 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33106/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33106/tests/dromaeo/cssquery-ext.html) 11:26:10 INFO - 2016-01-25 11:26:10,897 DEBUG : BROWSER_OUTPUT: RSS: Main: 142233600 11:26:10 INFO - 2016-01-25 11:26:10,897 DEBUG : BROWSER_OUTPUT: 11:29:12 INFO - 2016-01-25 11:29:12,778 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33106/tests/dromaeo/cssquery-ext.html (next: http://localhost:33106/tests/dromaeo/cssquery-jquery.html) 11:29:13 INFO - 2016-01-25 11:29:13,364 DEBUG : BROWSER_OUTPUT: RSS: Main: 139956224 11:29:13 INFO - 2016-01-25 11:29:13,364 DEBUG : BROWSER_OUTPUT: 11:32:15 INFO - 2016-01-25 11:32:15,013 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33106/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33106/tests/dromaeo/cssquery-mootools.html) 11:32:15 INFO - 2016-01-25 11:32:15,599 DEBUG : BROWSER_OUTPUT: RSS: Main: 138260480 11:32:15 INFO - 2016-01-25 11:32:15,599 DEBUG : BROWSER_OUTPUT: 11:35:17 INFO - 2016-01-25 11:35:17,199 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33106/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33106/tests/dromaeo/cssquery-prototype.html) 11:35:17 INFO - 2016-01-25 11:35:17,786 DEBUG : BROWSER_OUTPUT: RSS: Main: 139079680 11:35:17 INFO - 2016-01-25 11:35:17,786 DEBUG : BROWSER_OUTPUT: 11:38:20 INFO - 2016-01-25 11:38:20,026 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33106/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33106/tests/dromaeo/cssquery-yui.html) 11:38:20 INFO - 2016-01-25 11:38:20,653 DEBUG : BROWSER_OUTPUT: RSS: Main: 139067392 11:38:20 INFO - 2016-01-25 11:38:20,653 DEBUG : BROWSER_OUTPUT: 11:41:22 INFO - 2016-01-25 11:41:22,563 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33106/tests/dromaeo/cssquery-yui.html (next: http://localhost:33106/tests/dromaeo/cssquery-dojo.html) 11:41:22 INFO - 2016-01-25 11:41:22,808 DEBUG : BROWSER_OUTPUT: RSS: Main: 141828096 11:41:22 INFO - 2016-01-25 11:41:22,808 DEBUG : BROWSER_OUTPUT: 11:41:22 INFO - 2016-01-25 11:41:22,808 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:41:22 INFO - 2016-01-25 11:41:22,809 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:41:22 INFO - 2016-01-25 11:41:22,809 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:41:22 INFO - 2016-01-25 11:41:22,809 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:41:22 INFO - 2016-01-25 11:41:22,810 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3228.20908877325;3245.350929814036;3277.0660361796895;3278.5737854078966;3289.342131573686;5384.461553844613;5390.757415916283;5402.459754024596;5433.402325744165;5462.562994960404;5540.168974653804;5562.193481945115;5570.164475328703;5574.10814269717;5628.690422026787;5072.79708811648;5088.084144853925;5151.76817043232;5163.896722065557;5171.456997015315;4897.3878265216845;5058.342415485981;5061.746912654371;5063.721495317756;5083.898322033557;5037.647364684473;5068.847934561969;5150.150225212836;5164.690118592896;5173.689578625294;5085.898282034357;5122.615803814691;5141.665791723526;5148.433672296044;5177.870553236162;4833.540813622701;5047.621428392885;5106.004329155816;5106.5659418949435;5138.997895410396;5313.787448502056;5316.7075810830775;5334.466553344673;5341.919871201935;5357.383900851413;5811.535077193815;5876.206712093898;5884.558658100659;5890.97054514729;5918.881622367571;5823.155642431866;5929.495992840613;5930.0511918093325;5935.821925342247;5971.373005834368;5519.503244707996;5573.191887176336;5598.972005139948;5623.690697011703;5637.408072152406;6027.45752882234;6048.969755151196;6060.545459090586;6072.817815465543;6076.0278355462915;5776.133579963039;5801.448862358154;5868.618539794899;5876;5895.734691938787;5983.072623743326;6078.696065196723;6086.878262434727;6089.208402907594;6105.755769769159;5959.642421454727;5976.73104710289;5984.162217289496;5989.371116032841;5992.370801065913;5781.82654520365;5846.386129456346;5872.207252020922;5943.9598070337515;5996.280446346379;4587.288970209623;4629.814807407666;4632.513586073481;4632.559906808848;4675;4135.234981528427;4136.21411931732;4136.462259906253;4156.189543039079;4168.437260969791;5544.722763861791;5602.831915042555;5630.183623374588;5751.7411716472025;5772.769089236467;5885.61743486672;5915.970420147958;5943.851403714942;5969.582129250911;5979.133025711248;5608.607397482218;5654.264945557051;5660.603757737002;5662.433756624305;5701.2018317435595;5005.34930459038;5038.269450929668;5188.403333616607;5196.714180720097;5244.737763111905;6071.066191831001;6138.14066030756;6159.260888693296;6159.260888693386;6160.815175544741;5988.461038506555;6010.729517171825;6011.098335249748;6044.304904935812;6046.939530604637;5859.94140058594;6007.669578173242;6130.601510901777;6147.231596050494;6163.7842675506145;5877.588568800143;5923.141144534105;5928.49607783326;5936.703164841654;5946;6013.729382177725;6016.759329626766;6019.849503762266;6021.729022193924;6032.969835150796;5664.631798933056;5787.479126878601;5788.9131663024245;5791.797287094932;5828.6211396259105;5719.656820590778;5883.558733094949;5977.491913187428;5981.863445945257;6017.548683848641;5730.656160630376;5784.4504772046585;5794.565407594531;5811.912821307768;5817.650940943557;5632.971835140798;5700.401457846866;5854.648721076749;5858.736356864037;5888.998870191992;5665.461781130951;5721.771129154954;5738.598298119092;5740.454656807597;5747.109198074305 11:41:22 INFO - 2016-01-25 11:41:22,811 DEBUG : BROWSER_OUTPUT: |1;ext.html;585.9062549992002;617.8393617659408;623.0560700538684;629.1977728396291;630.1555915073801;40162.799186004064;40597.7970110149;40873.7956310218;41100.794496027556;41146.58853411465;46303.768481157545;46933;46971.530284697146;47035.52964470354;47115.528844711545;9087.77280567986;9195.21840643546;9262.675806346779;9268.860967085498;9277.768055798591;9016.41393309436;9111.544422778868;9139.223166030895;9159.954200229024;9164.312676549253;9085.591148398338;9102.453852768855;9125.224355929753;9169.541522923828;9175.54122293886;8979.102089791035;8999.41503802254;9052.683156089572;9055.139761722692;9068.727938161866;8925.553722313858;9024.142706442943;9044.7286581402;9057.094290570956;9089.63641454341;42969.35545966813;43371.132577348595;43470;43486;43522;3599.6760291573623;3678.1356381250384;3772.75477093988;3858.8070596470066;4155.97922010391;31472.370552589047;31489.84255078733;31705.365892682017;32129.678703213136;32748.345033099205;3608.1520842601967;3618.5295911531334;3629.5281613390353;3641.3809652358896;3702.7593206441493;282629;282984;283301;283647;284026;45048.3242751359;45423;45605.31592026122;45756.3136552952;45767.084658307314;43756.56243437525;43889.34165987513;43921.34117988233;43990.12019759587;44086.7795661026;15266.313015914311;15359.462418815512;15455.922720386327;15472.767908481383;15529.068255904682;12539.373031348396;12628.11603187768;12651.873481265253;12754.234745915275;12890.935545322214;15478.303476343592;15482.458113965957;15522.379104835905;15544.222788860512;15579.454719084777;5855.707214639337;6070.908936365958;6090.543209259324;6138.232720909887;6158.076288556752;991.8115558043949;1019.3679918450459;1093.371311495893;1096.309325125166;1104.9613263535737;29322.706772932423;29519.55720664192;29696.554551681744;30492.390152196833;30778.384432311228;1069.385103565453;1081.1783044885785;1115.8158903780786;1157.9247348922293;1166.9941650291694;14942.775858362133;15028.699426011419;15159.166245856584;15370.308336124901;15479.458218962282;579312;591983;592037;592434;820900;60835;61043.6947815267;61167.388326117056;61463;61576;1449.3188201545256;1449.8477659845564;1461.9342129604192;1475.955721328362;1486.6060493968891;30768.692313077478;31256.374872502878;31594.210144746565;31984.45324762725;32285.35429291448;50173.74913125411;50815;50843.23735143902;50854;50957.74521127519;348976;350485;350507;351264;351283;34356.65643343634;34455.827720861234;34811.129721757155;34813.82593087018;35307.29385412329;46298.30552541647;46375;46731.29903051389;47087.058258833946;47536.286955695;39912.40131397973;40148;40365.39451908165;40844.59155408408;40990.590094098676;44700.77649611731;44818.55181448144;46673.066538669715;47142.29286560636;48428.273575895684;38991.80504097575;39528.60471395249;39784;39844.601553985245;39983.80008099941;33809.15477113092;34571.30857382889;35027.82486087553;35295.82352088223;35297.29405411929;26845.463090738467;27459.31351716223;27737.44525109527;27856.16431507058;27881.860590696917 11:41:22 INFO - 2016-01-25 11:41:22,813 DEBUG : BROWSER_OUTPUT: |2;jquery.html;379.0693846606581;386.25452875949424;388.9591592882749;390.20787800764447;390.25266614433343;15593.298301576428;16921.492355229348;17904.55238619032;17953.28186872527;17980;16904.66190676189;17238.482845514623;17290.481285561422;17410.738838917427;18304.08479576019;5116.155834287348;5319.468053194688;5483.369412517572;5493.066178749622;5496.697681627509;5324.094903866352;5482.205080263359;5483.7806487740645;5503.642263252896;5513.035218836708;5373.677579345252;5415.187721841736;5468.9726551367185;5513.173024046385;5723.227364305828;5649.293838270196;5665.631733937281;5672.177534257551;5677.517411020068;5695.3735089139955;5366.973165134188;5464.4262352452815;5472.398036216013;5488.780448782084;5534.08687566551;12402.13185077045;12472.189307695062;12690.619281421572;16153.434629788018;22163.556728865493;2219.7225346831647;2222.4777177363308;2238.446686751464;2318.2929206591984;2344;10225;10432.634857779942;10436.582536698523;14009.369578368998;14033.578992630237;505;506.1370363530209;1826.3242600237863;1888;1891.6878715012006;67888.66055669739;68265;70814.99999999949;71345.64327178383;71692.64153679251;10068.39589624625;10207.234457415723;10262.846057309147;10277.229207809294;10305.381677099398;13205;13233.9412846972;13269.336533173302;13291.401886914919;13310.334483275798;8119.431639785276;8127.106018337978;8127.455783401135;8144.063432705315;8228.42401031922;7913;7997.960010199912;8026.317762990211;8064.032316122103;8069.919300807034;4148.709590328648;4221.6833737469815;4253.085586598834;8176.713815016565;8397.28623067034;3049.5883055787626;3135.2005238663996;3177.777555571134;3230.2731885325616;3260.527223552619;888.1473785166313;910.0822841280883;920.9815803684023;978.3640633588225;1079.4764539198482;15825.762613560806;17865.464036078938;17874.28502859897;18301.176447059916;19595.922224277518;936.836053690615;990.4898977026837;1032.4528000159928;1049.6221360310283;1069.8341757027517;9746.561404736804;9995.450250236161;10157.39055656663;10195;10224.13094886943;659220;664929;673205;675480;677374;90733.54633226791;92267.53866230627;92520;94956.52521737348;96261;1181.9822702659467;1182.6688527212393;1192.439553409896;1192.5527927027365;1200.6038007457519;16698;16765.077920714477;16790.412335568195;16818;16985.660286794442;40977;41147.7942610285;41186.79406602948;41194.176116478106;41857.37213941854;51762;52008.21987670112;53498.73250633722;53725.462745372046;58934.11598826107;10166.898331016891;10460.163186944874;10471.633492827714;10522.631707890187;10623.734406639896;18451.16969736392;18596.721049184544;18886.3389781357;19126.426207213804;19250.422487325402;14743.631409214855;14938.327775249922;15049.54851354461;15769.526914192593;16201.270942807838;13477.595672129852;13973.790393143907;15181.240937953278;15416.614584635025;15815.13016784088;15449;15860.44488442899;15892.841071589137;16156.192190390198;16211.756823647891;10220.642277520252;10404.063634272952;10496.317739346918;10503.422311772925;10556.313839600401;11195.160362972647;14658.560243192722;15947.043177409392;16154;16167.919160404123 11:41:22 INFO - 2016-01-25 11:41:22,814 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1491.6047247479419;1511.6296507355698;1687.1058339080291;1787.0707232239236;1849.149391280011;7488.812779680511;7569.621518924046;7789.922100778997;7826.804329891748;7859.764207073783;7831.099423566292;7848.960755196216;7927.1676473970265;7946.602669866498;7967.123616402191;2218.922337718176;2251.75230724621;2253.2001139595454;2254.0758289101473;2256.8533045352083;2161.567686462714;2187.4859408039097;2288.1648198407543;2291.5875142474347;2305.1125316753087;2227.899744511501;2269.375921621551;2277.214361045445;2281.4866655002656;2286.874221917794;2258.853174543666;2261.185973049709;2300.953980920389;2304.412374844421;2309.1917828759883;2258.9548209035893;2282.5549017941507;2282.7717228277206;2283.086765293879;2285.4514916420108;7782.299593036654;7876.488028278143;7879.842403151963;7883.724069657592;7910.841783164362;4601.286800545888;4686.367340409035;4694.155052090622;4706.952930470686;4715.339852420664;3032.9090127296217;3033.2265272355407;3097.132802815215;3108.7668424868225;3157.100226435478;1027.6557353286657;1029.8197815382277;1802.2971041293906;1806.4851517317634;1819.299569665675;10259.948700256526;10543.209259305582;10553.102986246178;10555;10555.261131720783;4038.2327357801923;4101.91796164075;4111.588841115865;4127.2570937231585;4137.358709400048;8660.047394786568;8674.175953284428;8677.783055423539;8692.739217823475;8713.564321783886;4631.907361852812;4644.907101857944;4663.090697313991;4673.836415725434;4681.555252251031;4313.805878735465;4329.047609525899;4334.544872788375;4355.412019377407;4362.498312694017;3357.1439282982683;3394.117529442363;3429.1255729788745;3443.139215196201;3466.046837119812;984.4241118945354;985.5909797434128;987.8221920054316;988.5946761827616;997.9002099790108;1130.949107290174;1132.7791080739341;1186.1400484648734;1385.6328073060647;1450.6881020580627;7135.785926422215;7233.204347521873;7296.087989001375;7311.415086793044;7326.377257933029;1193.7135087579093;1197.437204513877;1197.8562572491358;1203.5486692490317;1234.8271242026124;5937.881242375129;5976.402359763989;5994.400559944058;5997.2803263607775;6015.1278064681255;8567.657293708182;9022.86465703015;9126.634934602675;9214.493202873906;9220.815583688289;8832.602532886036;8919.42023768453;8991.55042247885;9005.459672419676;9017.684381046633;7126.2873712628325;7167.784966451015;7284.562926224444;7296.744613938593;7355.411567074728;7198.89201661965;7223.819404514929;7321.524100933422;7352.080989876265;7378.704851805867;8180.959095204724;8269.586520674062;8360.12218717026;8494.447860889022;8502.44734092282;8365.707200248205;8447.239748422426;8475.321974241922;8523.829523409373;8672.392932494664;6935.722571097302;7025.473089518205;7041.788746337618;7054.365107140382;7056.364927156581;7509.061367329084;7525.88711169322;7538.849223015619;7549.2073332299315;7558.319751222416;6966.616836074065;6993.230744618189;7007.439404847702;7193.640317984185;7201;6563.507736919845;6897.89653155193;6963.408110310477;7012.7545535906;7105.2894710528535;6962.895556566555;6989.33601307875;7052.33002864727;7091.858162836817;7105.431565474853;6261.092141639346;6466.321036291121;6489.805305840832;6513.609183449008;6526.021096835512;6389.4888408926245;6659.001149827371;6664.033715111184;6680.365365290289;6682.930731083004 11:41:22 INFO - 2016-01-25 11:41:22,818 DEBUG : BROWSER_OUTPUT: |4;prototype.html;340.32275771215285;341.86838067344064;343.9570053743282;347.90780443182564;351.76959091794873;6312.779052733155;6394.360563943604;6421.101045853584;6432.131662225598;6484.935150648492;6301.779437719681;6322.209723784527;6332.588381755183;6359.904601430982;6363.809085727424;4811.085893680207;4838.056578967103;4846.0550192712435;4846.563809257166;4847.1517484440255;4858.538438848322;4859.635527335447;4861.61107111432;4866.221404575269;4866.902661946759;4710.670253082269;4802.447718512381;4805.255185446262;4809.735464549449;4814.855554333358;4781.37842080529;4794.280857871329;4798.592119669815;4808.831690890802;4812.133815913135;4147.543770185277;4151.6886233532605;4155.58444155582;4159.064210552631;4167.312393455076;5999;6073.210482637229;6078.635281883101;6082.847928801771;6085.148079268906;5598.496135347838;5603.495685388335;5614.410486898858;5618.606697531174;5622.409646987089;6671.899921501182;6700.363465470772;6728.629925354104;6731.528792984493;6738.35985581369;4586.334981427708;4586.839460618862;4592.2193227151465;4592.471865735416;4596.54034596541;6894.276101009372;6894.655267236618;6929;6937.445004399636;6972.965135174342;4719.339292499053;4756.809727610926;4770.212914869077;4771.5228477152;4774.689645173053;4813.253945638432;4826.686265392738;4827.758612069382;4830.758462076882;4854.2233242681705;5583.357913839879;5584.21820945068;5585.106382978704;5588.776448942078;5613;6545.21457425112;6749.358810913053;6757.256701762803;6758.662066896733;6762.188537375547;1668.8247733987998;1706.5904182995992;1717.0212978602076;1722.939697110595;1724.5085150731982;1154.359330571524;1159.3333833046033;1165.5046605192929;1167.7255844876447;1173.5833779008499;6445.806625801233;6452.806415807533;6456.580322279131;6466.288708242089;6475.6438395887735;6891.689873955684;6898.620575868275;6905.689243984033;6910.412614927787;6913.75801846933;6314.210723659543;6322.083297921776;6323.652199129092;6342.968285158545;6484.513661475408;3805.5729101586903;3842.020284827351;3843.61563843619;3846.5576458707046;3850.634189751969;7302.415806735448;7306.415486761046;7310.415166786751;7313.12242530889;7330.047093877868;7090;7235.710571577183;7238.819029524304;7261.273872612696;7282.672279747424;7237.095363079615;7252.89120663201;7266.418686505067;7301.525400848928;7312.853742925218;6981.476389270927;7018.403435708022;7023.894641580483;7025.051618031501;7026.789196324118;6762.763303284361;6910.447164226749;6911.136107986502;6918.792436226921;6920.480963927826;7275.599842008741;7294.270572942663;7301.160366557701;7304.4156467483535;7314.670839812327;4733.455652599995;4746.762661866824;4753.073150735573;4754.833580824655;4763.333133361263;6875.965620172067;6934.06390137325;7050.964745176241;7052.9647351762915;7053.964730176316;6785.016172655036;6805.761798337233;6836.726530938707;6849;6857.382835544825;6772.458203343819;6802.931970680428;6836.623985680835;6841;6843.760468383782;6548.47612191014;6664.566803157779;6686.465082793462;6714.0600315954825;6720.294369091371;6877.89683154743;6881.65591720422;6897.7585784497305;6907.6891539879825;6910.965445172742;6668.299828517936;6709.563878347892;6713.865722685617;6729.966350168218;6733.158355205599 11:41:22 INFO - 2016-01-25 11:41:22,818 DEBUG : BROWSER_OUTPUT: |5;yui.html;798.8641930871751;805.7260531419316;807.2169995104746;807.2895851650549;811.8011087283612;14025.649358766035;14318.785218221708;14462.566123016313;14497.347619357128;14539.127652340867;14424.711505769877;14490.42038318466;14512.274386280671;14517.128972261671;14555.1994640295;905.7373361725108;927.2581934452445;941.4492521874712;946.7727745341103;949.3829011142778;917.9816403671922;923.3859483443503;926.36081104038;928.7770934975591;930.9767255818591;978.0512902484578;979.3193730357405;984.5323471351122;984.9901500985006;992.2458931212294;971.1745016735754;972.1348000279756;979.0307595480459;982.2387649571639;985.6599473181741;726.8037629839966;728.2571776787647;730.0946825935854;730.4996077686801;731.381982225019;14257.144571325754;14361.066530675576;14494.42022319106;14496.85503144976;14533.636659083502;12197.39013049344;12944.482220711161;12994.935025324907;13380.598582042554;13452.327383630876;9808.313418060667;10979.17656175782;11023.283486573348;11043.83434248487;11633.534658613646;3767.6797472214894;3780.451834484012;3808.314503389389;3883.184531248413;3970.50368703912;52704.736476317754;52792.472075279526;53198.73400633011;53282.73358633221;53347.19979200315;9316.44101353921;9518;9705.854412183822;10509.159267258601;10895.455227238606;19638.705419418435;19779.30772422987;19793.802061979197;19809.40571782849;19835.504112397306;8078.757637270891;8144.918550814535;8145.307648849795;8255.174482551696;8473.70342038038;4469.642428605704;4598.471175814757;4631.397918270671;4679.578837904605;4734.100520901018;3290.243244053881;3322.152851023022;3336.3160552086765;3344.347852168804;3357.8992630221132;597.8355952113203;604.5647134063468;604.5647134063468;604.6493034040246;604.9758009679564;548.1914176589498;558.6675927822939;716.9103862017248;731.9268073192638;733.7028503456108;8840.33697472692;9571.569279382444;9613.423194608346;9634.181094606896;9989.40063596172;628.4532456762554;663.7112855907695;678.4078305373062;715.7745310227261;736.4955005820923;4266.552012038691;4431.881177240292;4432.224360736858;4434.955650443519;4479.664025198123;60642;61723.691381542805;61756.38243617507;62014.37985620176;62201.68899155475;55041;55831.44168558263;56048;56505;56717.43282567204;48023.75988120037;49322.753386233555;49691.25463118056;49920.50079499231;50698;8567.785805354666;8897.110288971051;8998.68504602362;9058.456492610465;9060.139286767746;35934.82032589925;36130.8193459031;36774;37226.8138659305;37433.81283093676;44028;44193.33709994417;48383.51616483931;48563.75718121528;49169;9207.355485115977;9726.173275271682;10665.520051597541;11040.116790656568;11408.885911140782;12437.875621244033;12497.25016499013;12633.178843375152;12901.806472903101;12985.805212921625;11711.297322160697;12139.75720485603;12181.269123852597;12331.50673973031;12472;11755.412229388325;11820.0543956485;11827;11938;12012.159148859497;10523.684289471023;10655.263262943508;10678.62624808128;10727.141828653534;10732;9821.5089245536;10174.491275436347;10232.23258255619;10240.231982601485;10280.845787313046;9709.271804614824;9958.15355694774;9961.551730172305;10221.080102790784;10304.948475257575 11:41:22 INFO - 2016-01-25 11:41:22,818 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:41:22 INFO - 2016-01-25 11:41:22,818 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:41:22 INFO - 2016-01-25 11:41:22,818 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,296 11:41:22 INFO - 2016-01-25 11:41:22,818 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:41:22 INFO - 2016-01-25 11:41:22,818 DEBUG : BROWSER_OUTPUT: __startTimestamp1453750882807__endTimestamp 11:41:22 INFO - 2016-01-25 11:41:22,818 DEBUG : BROWSER_OUTPUT: 11:41:22 INFO - 2016-01-25 11:41:22,818 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:41:22 INFO - 2016-01-25 11:41:22,819 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:41:22 INFO - 2016-01-25 11:41:22,819 DEBUG : BROWSER_OUTPUT: 11:41:22 INFO - 2016-01-25 11:41:22,819 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5533.07 Median:5747.11 stddev:611.71 (10.6%) stddev-sans-first:586.26 11:41:22 INFO - 2016-01-25 11:41:22,819 DEBUG : BROWSER_OUTPUT: Values: 3228.2 3245.4 3277.1 3278.6 3289.3 5384.5 5390.8 5402.5 5433.4 5462.6 5540.2 5562.2 5570.2 5574.1 5628.7 5072.8 5088.1 5151.8 5163.9 5171.5 4897.4 5058.3 5061.7 5063.7 5083.9 5037.6 5068.8 5150.2 5164.7 5173.7 5085.9 5122.6 5141.7 5148.4 5177.9 4833.5 5047.6 5106.0 5106.6 5139.0 5313.8 5316.7 5334.5 5341.9 5357.4 5811.5 5876.2 5884.6 5891.0 5918.9 5823.2 5929.5 5930.1 5935.8 5971.4 5519.5 5573.2 5599.0 5623.7 5637.4 6027.5 6049.0 6060.5 6072.8 6076.0 5776.1 5801.4 5868.6 5876.0 5895.7 5983.1 6078.7 6086.9 6089.2 6105.8 5959.6 5976.7 5984.2 5989.4 5992.4 5781.8 5846.4 5872.2 5944.0 5996.3 4587.3 4629.8 4632.5 4632.6 4675.0 4135.2 4136.2 4136.5 4156.2 4168.4 5544.7 5602.8 5630.2 5751.7 5772.8 5885.6 5916.0 5943.9 5969.6 5979.1 5608.6 5654.3 5660.6 5662.4 5701.2 5005.3 5038.3 5188.4 5196.7 5244.7 6071.1 6138.1 6159.3 6159.3 6160.8 5988.5 6010.7 6011.1 6044.3 6046.9 5859.9 6007.7 6130.6 6147.2 6163.8 5877.6 5923.1 5928.5 5936.7 5946.0 6013.7 6016.8 6019.8 6021.7 6033.0 5664.6 5787.5 5788.9 5791.8 5828.6 5719.7 5883.6 5977.5 5981.9 6017.5 5730.7 5784.5 5794.6 5811.9 5817.7 5633.0 5700.4 5854.6 5858.7 5889.0 5665.5 5721.8 5738.6 5740.5 5747.1 11:41:22 INFO - 2016-01-25 11:41:22,819 DEBUG : BROWSER_OUTPUT: 11:41:22 INFO - 2016-01-25 11:41:22,819 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:57985.64 Median:40264.10 stddev:121146.61 (300.9%) stddev-sans-first:121409.80 11:41:22 INFO - 2016-01-25 11:41:22,819 DEBUG : BROWSER_OUTPUT: Values: 585.9 617.8 623.1 629.2 630.2 40162.8 40597.8 40873.8 41100.8 41146.6 46303.8 46933.0 46971.5 47035.5 47115.5 9087.8 9195.2 9262.7 9268.9 9277.8 9016.4 9111.5 9139.2 9160.0 9164.3 9085.6 9102.5 9125.2 9169.5 9175.5 8979.1 8999.4 9052.7 9055.1 9068.7 8925.6 9024.1 9044.7 9057.1 9089.6 42969.4 43371.1 43470.0 43486.0 43522.0 3599.7 3678.1 3772.8 3858.8 4156.0 31472.4 31489.8 31705.4 32129.7 32748.3 3608.2 3618.5 3629.5 3641.4 3702.8 282629.0 282984.0 283301.0 283647.0 284026.0 45048.3 45423.0 45605.3 45756.3 45767.1 43756.6 43889.3 43921.3 43990.1 44086.8 15266.3 15359.5 15455.9 15472.8 15529.1 12539.4 12628.1 12651.9 12754.2 12890.9 15478.3 15482.5 15522.4 15544.2 15579.5 5855.7 6070.9 6090.5 6138.2 6158.1 991.8 1019.4 1093.4 1096.3 1105.0 29322.7 29519.6 29696.6 30492.4 30778.4 1069.4 1081.2 1115.8 1157.9 1167.0 14942.8 15028.7 15159.2 15370.3 15479.5 579312.0 591983.0 592037.0 592434.0 820900.0 60835.0 61043.7 61167.4 61463.0 61576.0 1449.3 1449.8 1461.9 1476.0 1486.6 30768.7 31256.4 31594.2 31984.5 32285.4 50173.7 50815.0 50843.2 50854.0 50957.7 348976.0 350485.0 350507.0 351264.0 351283.0 34356.7 34455.8 34811.1 34813.8 35307.3 46298.3 46375.0 46731.3 47087.1 47536.3 39912.4 40148.0 40365.4 40844.6 40990.6 44700.8 44818.6 46673.1 47142.3 48428.3 38991.8 39528.6 39784.0 39844.6 39983.8 33809.2 34571.3 35027.8 35295.8 35297.3 26845.5 27459.3 27737.4 27856.2 27881.9 11:41:22 INFO - 2016-01-25 11:41:22,819 DEBUG : BROWSER_OUTPUT: 11:41:22 INFO - 2016-01-25 11:41:22,819 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:33861.10 Median:2221.10 stddev:109569.31 (4933.1%) stddev-sans-first:109847.83 11:41:22 INFO - 2016-01-25 11:41:22,819 DEBUG : BROWSER_OUTPUT: Values: 379.1 386.3 389.0 390.2 390.3 15593.3 16921.5 17904.6 17953.3 17980.0 16904.7 17238.5 17290.5 17410.7 18304.1 5116.2 5319.5 5483.4 5493.1 5496.7 5324.1 5482.2 5483.8 5503.6 5513.0 5373.7 5415.2 5469.0 5513.2 5723.2 5649.3 5665.6 5672.2 5677.5 5695.4 5367.0 5464.4 5472.4 5488.8 5534.1 12402.1 12472.2 12690.6 16153.4 22163.6 2219.7 2222.5 2238.4 2318.3 2344.0 10225.0 10432.6 10436.6 14009.4 14033.6 505.0 506.1 1826.3 1888.0 1891.7 67888.7 68265.0 70815.0 71345.6 71692.6 10068.4 10207.2 10262.8 10277.2 10305.4 13205.0 13233.9 13269.3 13291.4 13310.3 8119.4 8127.1 8127.5 8144.1 8228.4 7913.0 7998.0 8026.3 8064.0 8069.9 4148.7 4221.7 4253.1 8176.7 8397.3 3049.6 3135.2 3177.8 3230.3 3260.5 888.1 910.1 921.0 978.4 1079.5 15825.8 17865.5 17874.3 18301.2 19595.9 936.8 990.5 1032.5 1049.6 1069.8 9746.6 9995.5 10157.4 10195.0 10224.1 659220.0 664929.0 673205.0 675480.0 677374.0 90733.5 92267.5 92520.0 94956.5 96261.0 1182.0 1182.7 1192.4 1192.6 1200.6 16698.0 16765.1 16790.4 16818.0 16985.7 40977.0 41147.8 41186.8 41194.2 41857.4 51762.0 52008.2 53498.7 53725.5 58934.1 10166.9 10460.2 10471.6 10522.6 10623.7 18451.2 18596.7 18886.3 19126.4 19250.4 14743.6 14938.3 15049.5 15769.5 16201.3 13477.6 13973.8 15181.2 15416.6 15815.1 15449.0 15860.4 15892.8 16156.2 16211.8 10220.6 10404.1 10496.3 10503.4 10556.3 11195.2 14658.6 15947.0 16154.0 16167.9 11:41:22 INFO - 2016-01-25 11:41:22,819 DEBUG : BROWSER_OUTPUT: 11:41:22 INFO - 2016-01-25 11:41:22,819 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5448.82 Median:6544.76 stddev:2761.08 (42.2%) stddev-sans-first:2752.81 11:41:22 INFO - 2016-01-25 11:41:22,821 DEBUG : BROWSER_OUTPUT: Values: 1491.6 1511.6 1687.1 1787.1 1849.1 7488.8 7569.6 7789.9 7826.8 7859.8 7831.1 7849.0 7927.2 7946.6 7967.1 2218.9 2251.8 2253.2 2254.1 2256.9 2161.6 2187.5 2288.2 2291.6 2305.1 2227.9 2269.4 2277.2 2281.5 2286.9 2258.9 2261.2 2301.0 2304.4 2309.2 2259.0 2282.6 2282.8 2283.1 2285.5 7782.3 7876.5 7879.8 7883.7 7910.8 4601.3 4686.4 4694.2 4707.0 4715.3 3032.9 3033.2 3097.1 3108.8 3157.1 1027.7 1029.8 1802.3 1806.5 1819.3 10259.9 10543.2 10553.1 10555.0 10555.3 4038.2 4101.9 4111.6 4127.3 4137.4 8660.0 8674.2 8677.8 8692.7 8713.6 4631.9 4644.9 4663.1 4673.8 4681.6 4313.8 4329.0 4334.5 4355.4 4362.5 3357.1 3394.1 3429.1 3443.1 3466.0 984.4 985.6 987.8 988.6 997.9 1130.9 1132.8 1186.1 1385.6 1450.7 7135.8 7233.2 7296.1 7311.4 7326.4 1193.7 1197.4 1197.9 1203.5 1234.8 5937.9 5976.4 5994.4 5997.3 6015.1 8567.7 9022.9 9126.6 9214.5 9220.8 8832.6 8919.4 8991.6 9005.5 9017.7 7126.3 7167.8 7284.6 7296.7 7355.4 7198.9 7223.8 7321.5 7352.1 7378.7 8181.0 8269.6 8360.1 8494.4 8502.4 8365.7 8447.2 8475.3 8523.8 8672.4 6935.7 7025.5 7041.8 7054.4 7056.4 7509.1 7525.9 7538.8 7549.2 7558.3 6966.6 6993.2 7007.4 7193.6 7201.0 6563.5 6897.9 6963.4 7012.8 7105.3 6962.9 6989.3 7052.3 7091.9 7105.4 6261.1 6466.3 6489.8 6513.6 6526.0 6389.5 6659.0 6664.0 6680.4 6682.9 11:41:22 INFO - 2016-01-25 11:41:22,821 DEBUG : BROWSER_OUTPUT: 11:41:22 INFO - 2016-01-25 11:41:22,821 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5650.97 Median:6407.73 stddev:1717.42 (26.8%) stddev-sans-first:1675.35 11:41:22 INFO - 2016-01-25 11:41:22,821 DEBUG : BROWSER_OUTPUT: Values: 340.3 341.9 344.0 347.9 351.8 6312.8 6394.4 6421.1 6432.1 6484.9 6301.8 6322.2 6332.6 6359.9 6363.8 4811.1 4838.1 4846.1 4846.6 4847.2 4858.5 4859.6 4861.6 4866.2 4866.9 4710.7 4802.4 4805.3 4809.7 4814.9 4781.4 4794.3 4798.6 4808.8 4812.1 4147.5 4151.7 4155.6 4159.1 4167.3 5999.0 6073.2 6078.6 6082.8 6085.1 5598.5 5603.5 5614.4 5618.6 5622.4 6671.9 6700.4 6728.6 6731.5 6738.4 4586.3 4586.8 4592.2 4592.5 4596.5 6894.3 6894.7 6929.0 6937.4 6973.0 4719.3 4756.8 4770.2 4771.5 4774.7 4813.3 4826.7 4827.8 4830.8 4854.2 5583.4 5584.2 5585.1 5588.8 5613.0 6545.2 6749.4 6757.3 6758.7 6762.2 1668.8 1706.6 1717.0 1722.9 1724.5 1154.4 1159.3 1165.5 1167.7 1173.6 6445.8 6452.8 6456.6 6466.3 6475.6 6891.7 6898.6 6905.7 6910.4 6913.8 6314.2 6322.1 6323.7 6343.0 6484.5 3805.6 3842.0 3843.6 3846.6 3850.6 7302.4 7306.4 7310.4 7313.1 7330.0 7090.0 7235.7 7238.8 7261.3 7282.7 7237.1 7252.9 7266.4 7301.5 7312.9 6981.5 7018.4 7023.9 7025.1 7026.8 6762.8 6910.4 6911.1 6918.8 6920.5 7275.6 7294.3 7301.2 7304.4 7314.7 4733.5 4746.8 4753.1 4754.8 4763.3 6876.0 6934.1 7051.0 7053.0 7054.0 6785.0 6805.8 6836.7 6849.0 6857.4 6772.5 6802.9 6836.6 6841.0 6843.8 6548.5 6664.6 6686.5 6714.1 6720.3 6877.9 6881.7 6897.8 6907.7 6911.0 6668.3 6709.6 6713.9 6730.0 6733.2 11:41:22 INFO - 2016-01-25 11:41:22,821 DEBUG : BROWSER_OUTPUT: 11:41:22 INFO - 2016-01-25 11:41:22,821 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14693.46 Median:49245.88 stddev:17191.88 (34.9%) stddev-sans-first:17208.44 11:41:22 INFO - 2016-01-25 11:41:22,821 DEBUG : BROWSER_OUTPUT: Values: 798.9 805.7 807.2 807.3 811.8 14025.6 14318.8 14462.6 14497.3 14539.1 14424.7 14490.4 14512.3 14517.1 14555.2 905.7 927.3 941.4 946.8 949.4 918.0 923.4 926.4 928.8 931.0 978.1 979.3 984.5 985.0 992.2 971.2 972.1 979.0 982.2 985.7 726.8 728.3 730.1 730.5 731.4 14257.1 14361.1 14494.4 14496.9 14533.6 12197.4 12944.5 12994.9 13380.6 13452.3 9808.3 10979.2 11023.3 11043.8 11633.5 3767.7 3780.5 3808.3 3883.2 3970.5 52704.7 52792.5 53198.7 53282.7 53347.2 9316.4 9518.0 9705.9 10509.2 10895.5 19638.7 19779.3 19793.8 19809.4 19835.5 8078.8 8144.9 8145.3 8255.2 8473.7 4469.6 4598.5 4631.4 4679.6 4734.1 3290.2 3322.2 3336.3 3344.3 3357.9 597.8 604.6 604.6 604.6 605.0 548.2 558.7 716.9 731.9 733.7 8840.3 9571.6 9613.4 9634.2 9989.4 628.5 663.7 678.4 715.8 736.5 4266.6 4431.9 4432.2 4435.0 4479.7 60642.0 61723.7 61756.4 62014.4 62201.7 55041.0 55831.4 56048.0 56505.0 56717.4 48023.8 49322.8 49691.3 49920.5 50698.0 8567.8 8897.1 8998.7 9058.5 9060.1 35934.8 36130.8 36774.0 37226.8 37433.8 44028.0 44193.3 48383.5 48563.8 49169.0 9207.4 9726.2 10665.5 11040.1 11408.9 12437.9 12497.3 12633.2 12901.8 12985.8 11711.3 12139.8 12181.3 12331.5 12472.0 11755.4 11820.1 11827.0 11938.0 12012.2 10523.7 10655.3 10678.6 10727.1 10732.0 9821.5 10174.5 10232.2 10240.2 10280.8 9709.3 9958.2 9961.6 10221.1 10304.9 11:41:22 INFO - 2016-01-25 11:41:22,821 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:41:22 INFO - 2016-01-25 11:41:22,821 DEBUG : BROWSER_OUTPUT: 11:41:23 INFO - 2016-01-25 11:41:23,533 INFO : Browser exited with error code: 0 11:41:23 INFO - 2016-01-25 11:41:23,554 INFO : Completed test dromaeo_css (00:18:29) 11:41:23 INFO - 2016-01-25 11:41:23,554 INFO : Starting test kraken 11:41:23 INFO - 2016-01-25 11:41:23,554 DEBUG : operating with platform_type : linux_ 11:41:23 INFO - 2016-01-25 11:41:23,554 INFO : Initialising browser for kraken test... 11:41:23 INFO - 2016-01-25 11:41:23,560 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqFo25W/profile http://localhost:33106/getInfo.html 11:41:27 INFO - 2016-01-25 11:41:27,437 DEBUG : BROWSER_OUTPUT: 11:41:27 INFO - 2016-01-25 11:41:27,437 DEBUG : BROWSER_OUTPUT: (process:30318): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:41:28 INFO - 2016-01-25 11:41:28,373 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:41:28 INFO - 2016-01-25 11:41:28,374 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:41:28 INFO - 2016-01-25 11:41:28,374 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:41:28 INFO - 2016-01-25 11:41:28,374 DEBUG : BROWSER_OUTPUT: __metrics 11:41:29 INFO - 2016-01-25 11:41:29,344 INFO : Browser initialized. 11:41:29 INFO - 2016-01-25 11:41:29,345 INFO : Running cycle 1/1 for kraken test... 11:41:29 INFO - 2016-01-25 11:41:29,345 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqFo25W/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:41:30 INFO - 2016-01-25 11:41:30,561 DEBUG : BROWSER_OUTPUT: 11:41:30 INFO - 2016-01-25 11:41:30,561 DEBUG : BROWSER_OUTPUT: (process:30433): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:41:41 INFO - 2016-01-25 11:41:41,069 DEBUG : BROWSER_OUTPUT: RSS: Main: 135868416 11:41:41 INFO - 2016-01-25 11:41:41,069 DEBUG : BROWSER_OUTPUT: 11:41:43 INFO - 2016-01-25 11:41:43,565 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33106/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33106/tests/kraken/driver.html?testName=audio-beat-detection) 11:41:44 INFO - 2016-01-25 11:41:44,167 DEBUG : BROWSER_OUTPUT: RSS: Main: 139112448 11:41:44 INFO - 2016-01-25 11:41:44,167 DEBUG : BROWSER_OUTPUT: 11:41:46 INFO - 2016-01-25 11:41:46,785 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33106/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33106/tests/kraken/driver.html?testName=audio-dft) 11:41:47 INFO - 2016-01-25 11:41:47,374 DEBUG : BROWSER_OUTPUT: RSS: Main: 138100736 11:41:47 INFO - 2016-01-25 11:41:47,374 DEBUG : BROWSER_OUTPUT: 11:41:50 INFO - 2016-01-25 11:41:50,201 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33106/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33106/tests/kraken/driver.html?testName=audio-fft) 11:41:50 INFO - 2016-01-25 11:41:50,787 DEBUG : BROWSER_OUTPUT: RSS: Main: 138412032 11:41:50 INFO - 2016-01-25 11:41:50,787 DEBUG : BROWSER_OUTPUT: 11:41:52 INFO - 2016-01-25 11:41:52,801 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33106/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33106/tests/kraken/driver.html?testName=audio-oscillator) 11:41:53 INFO - 2016-01-25 11:41:53,394 DEBUG : BROWSER_OUTPUT: RSS: Main: 139075584 11:41:53 INFO - 2016-01-25 11:41:53,394 DEBUG : BROWSER_OUTPUT: 11:41:55 INFO - 2016-01-25 11:41:55,593 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33106/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33106/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:41:56 INFO - 2016-01-25 11:41:56,166 DEBUG : BROWSER_OUTPUT: RSS: Main: 138100736 11:41:56 INFO - 2016-01-25 11:41:56,166 DEBUG : BROWSER_OUTPUT: 11:41:59 INFO - 2016-01-25 11:41:59,097 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33106/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33106/tests/kraken/driver.html?testName=imaging-darkroom) 11:41:59 INFO - 2016-01-25 11:41:59,684 DEBUG : BROWSER_OUTPUT: RSS: Main: 138948608 11:41:59 INFO - 2016-01-25 11:41:59,684 DEBUG : BROWSER_OUTPUT: 11:42:03 INFO - 2016-01-25 11:42:03,030 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33106/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33106/tests/kraken/driver.html?testName=imaging-desaturate) 11:42:03 INFO - 2016-01-25 11:42:03,616 DEBUG : BROWSER_OUTPUT: RSS: Main: 139509760 11:42:03 INFO - 2016-01-25 11:42:03,616 DEBUG : BROWSER_OUTPUT: 11:42:06 INFO - 2016-01-25 11:42:06,375 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33106/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33106/tests/kraken/driver.html?testName=json-parse-financial) 11:42:06 INFO - 2016-01-25 11:42:06,961 DEBUG : BROWSER_OUTPUT: RSS: Main: 137998336 11:42:06 INFO - 2016-01-25 11:42:06,962 DEBUG : BROWSER_OUTPUT: 11:42:08 INFO - 2016-01-25 11:42:08,495 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33106/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33106/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:42:09 INFO - 2016-01-25 11:42:09,069 DEBUG : BROWSER_OUTPUT: RSS: Main: 138027008 11:42:09 INFO - 2016-01-25 11:42:09,069 DEBUG : BROWSER_OUTPUT: 11:42:10 INFO - 2016-01-25 11:42:10,819 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33106/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33106/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:42:11 INFO - 2016-01-25 11:42:11,426 DEBUG : BROWSER_OUTPUT: RSS: Main: 138223616 11:42:11 INFO - 2016-01-25 11:42:11,426 DEBUG : BROWSER_OUTPUT: 11:42:13 INFO - 2016-01-25 11:42:13,443 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33106/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33106/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:42:14 INFO - 2016-01-25 11:42:14,029 DEBUG : BROWSER_OUTPUT: RSS: Main: 139046912 11:42:14 INFO - 2016-01-25 11:42:14,029 DEBUG : BROWSER_OUTPUT: 11:42:16 INFO - 2016-01-25 11:42:16,365 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33106/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33106/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:42:16 INFO - 2016-01-25 11:42:16,967 DEBUG : BROWSER_OUTPUT: RSS: Main: 139309056 11:42:16 INFO - 2016-01-25 11:42:16,967 DEBUG : BROWSER_OUTPUT: 11:42:19 INFO - 2016-01-25 11:42:19,502 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33106/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33106/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:42:20 INFO - 2016-01-25 11:42:20,084 DEBUG : BROWSER_OUTPUT: RSS: Main: 139579392 11:42:20 INFO - 2016-01-25 11:42:20,084 DEBUG : BROWSER_OUTPUT: 11:42:21 INFO - 2016-01-25 11:42:21,738 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33106/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33106/tests/kraken/driver.html?testName=ai-astar) 11:42:21 INFO - 2016-01-25 11:42:21,989 DEBUG : BROWSER_OUTPUT: RSS: Main: 139407360 11:42:21 INFO - 2016-01-25 11:42:21,989 DEBUG : BROWSER_OUTPUT: 11:42:21 INFO - 2016-01-25 11:42:21,990 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:42:21 INFO - 2016-01-25 11:42:21,991 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:42:21 INFO - 2016-01-25 11:42:21,991 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:42:21 INFO - 2016-01-25 11:42:21,991 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:42:21 INFO - 2016-01-25 11:42:21,991 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;105;113;112;112;122;111;110;111;111 11:42:21 INFO - 2016-01-25 11:42:21,992 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;122;151;155;124;145;146;125;165;124 11:42:21 INFO - 2016-01-25 11:42:21,992 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;162;162;162;161;162;161;161;166;164 11:42:21 INFO - 2016-01-25 11:42:21,992 DEBUG : BROWSER_OUTPUT: |3;audio-fft;78;73;74;159;72;73;71;73;165;73 11:42:21 INFO - 2016-01-25 11:42:21,992 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;93;147;92;93;93;130;93;94;143 11:42:21 INFO - 2016-01-25 11:42:21,992 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;110;110;110;110;110;110 11:42:21 INFO - 2016-01-25 11:42:21,993 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;147;147;149;146;146;147;147;149 11:42:21 INFO - 2016-01-25 11:42:21,993 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;96;97;96;100;96;96;96 11:42:21 INFO - 2016-01-25 11:42:21,993 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;62;58;58;59;58;60;61;57;57 11:42:21 INFO - 2016-01-25 11:42:21,993 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;63;63;63;64;63;63;63;63 11:42:21 INFO - 2016-01-25 11:42:21,994 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;80;91;82;80;81;83;82;83;81 11:42:21 INFO - 2016-01-25 11:42:21,994 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;112;115;111;114;111;123;114;117;121;117 11:42:21 INFO - 2016-01-25 11:42:21,994 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;154;154;150;141;143;142;150;155;148 11:42:21 INFO - 2016-01-25 11:42:21,994 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;66;65;67;70;70;66;66;67;68 11:42:21 INFO - 2016-01-25 11:42:21,994 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:42:21 INFO - 2016-01-25 11:42:21,995 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:42:21 INFO - 2016-01-25 11:42:21,995 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,697 11:42:21 INFO - 2016-01-25 11:42:21,995 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:42:21 INFO - 2016-01-25 11:42:21,995 DEBUG : BROWSER_OUTPUT: __startTimestamp1453750941989__endTimestamp 11:42:21 INFO - 2016-01-25 11:42:21,995 DEBUG : BROWSER_OUTPUT: 11:42:21 INFO - 2016-01-25 11:42:21,999 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:42:21 INFO - 2016-01-25 11:42:21,999 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:42:22 INFO - 2016-01-25 11:42:21,999 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:21,999 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.20 Median:112.00 stddev:4.29 (3.8%) stddev-sans-first:4.43 11:42:22 INFO - 2016-01-25 11:42:21,999 DEBUG : BROWSER_OUTPUT: Values: 115.0 105.0 113.0 112.0 112.0 122.0 111.0 110.0 111.0 111.0 11:42:22 INFO - 2016-01-25 11:42:22,000 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,000 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.70 Median:148.00 stddev:15.59 (10.5%) stddev-sans-first:16.17 11:42:22 INFO - 2016-01-25 11:42:22,000 DEBUG : BROWSER_OUTPUT: Values: 150.0 122.0 151.0 155.0 124.0 145.0 146.0 125.0 165.0 124.0 11:42:22 INFO - 2016-01-25 11:42:22,000 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,000 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.50 Median:162.00 stddev:1.65 (1.0%) stddev-sans-first:1.66 11:42:22 INFO - 2016-01-25 11:42:22,000 DEBUG : BROWSER_OUTPUT: Values: 164.0 162.0 162.0 162.0 161.0 162.0 161.0 161.0 166.0 164.0 11:42:22 INFO - 2016-01-25 11:42:22,000 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,000 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:91.10 Median:73.00 stddev:37.44 (51.3%) stddev-sans-first:39.41 11:42:22 INFO - 2016-01-25 11:42:22,000 DEBUG : BROWSER_OUTPUT: Values: 78.0 73.0 74.0 159.0 72.0 73.0 71.0 73.0 165.0 73.0 11:42:22 INFO - 2016-01-25 11:42:22,000 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,000 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.20 Median:93.00 stddev:23.03 (24.8%) stddev-sans-first:23.92 11:42:22 INFO - 2016-01-25 11:42:22,001 DEBUG : BROWSER_OUTPUT: Values: 94.0 93.0 147.0 92.0 93.0 93.0 130.0 93.0 94.0 143.0 11:42:22 INFO - 2016-01-25 11:42:22,001 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,001 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 11:42:22 INFO - 2016-01-25 11:42:22,001 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 11:42:22 INFO - 2016-01-25 11:42:22,001 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,001 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:1.03 (0.7%) stddev-sans-first:1.09 11:42:22 INFO - 2016-01-25 11:42:22,001 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 147.0 147.0 149.0 146.0 146.0 147.0 147.0 149.0 11:42:22 INFO - 2016-01-25 11:42:22,001 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,001 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:1.35 (1.4%) stddev-sans-first:1.42 11:42:22 INFO - 2016-01-25 11:42:22,001 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 96.0 97.0 96.0 100.0 96.0 96.0 96.0 11:42:22 INFO - 2016-01-25 11:42:22,001 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,001 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.70 Median:58.50 stddev:1.77 (3.0%) stddev-sans-first:1.76 11:42:22 INFO - 2016-01-25 11:42:22,001 DEBUG : BROWSER_OUTPUT: Values: 57.0 62.0 58.0 58.0 59.0 58.0 60.0 61.0 57.0 57.0 11:42:22 INFO - 2016-01-25 11:42:22,002 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,002 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.20 Median:63.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 11:42:22 INFO - 2016-01-25 11:42:22,002 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 63.0 63.0 63.0 64.0 63.0 63.0 63.0 63.0 11:42:22 INFO - 2016-01-25 11:42:22,002 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,002 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:82.50 stddev:3.20 (3.9%) stddev-sans-first:3.36 11:42:22 INFO - 2016-01-25 11:42:22,002 DEBUG : BROWSER_OUTPUT: Values: 84.0 80.0 91.0 82.0 80.0 81.0 83.0 82.0 83.0 81.0 11:42:22 INFO - 2016-01-25 11:42:22,002 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,002 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:115.50 Median:116.00 stddev:4.06 (3.5%) stddev-sans-first:4.11 11:42:22 INFO - 2016-01-25 11:42:22,002 DEBUG : BROWSER_OUTPUT: Values: 112.0 115.0 111.0 114.0 111.0 123.0 114.0 117.0 121.0 117.0 11:42:22 INFO - 2016-01-25 11:42:22,002 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,002 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.80 Median:150.00 stddev:5.65 (3.8%) stddev-sans-first:5.43 11:42:22 INFO - 2016-01-25 11:42:22,002 DEBUG : BROWSER_OUTPUT: Values: 141.0 154.0 154.0 150.0 141.0 143.0 142.0 150.0 155.0 148.0 11:42:22 INFO - 2016-01-25 11:42:22,002 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,002 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.83 (2.7%) stddev-sans-first:1.79 11:42:22 INFO - 2016-01-25 11:42:22,003 DEBUG : BROWSER_OUTPUT: Values: 65.0 66.0 65.0 67.0 70.0 70.0 66.0 66.0 67.0 68.0 11:42:22 INFO - 2016-01-25 11:42:22,003 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:42:22 INFO - 2016-01-25 11:42:22,003 DEBUG : BROWSER_OUTPUT: 11:42:22 INFO - 2016-01-25 11:42:22,853 INFO : Browser exited with error code: 0 11:42:22 INFO - 2016-01-25 11:42:22,904 INFO : Completed test kraken (00:00:59) 11:42:22 INFO - 2016-01-25 11:42:22,904 INFO : Starting test v8_7 11:42:22 INFO - 2016-01-25 11:42:22,904 DEBUG : operating with platform_type : linux_ 11:42:22 INFO - 2016-01-25 11:42:22,904 INFO : Initialising browser for v8_7 test... 11:42:22 INFO - 2016-01-25 11:42:22,910 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfJJMaC/profile http://localhost:33106/getInfo.html 11:42:26 INFO - 2016-01-25 11:42:26,771 DEBUG : BROWSER_OUTPUT: 11:42:26 INFO - 2016-01-25 11:42:26,771 DEBUG : BROWSER_OUTPUT: (process:30744): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:42:27 INFO - 2016-01-25 11:42:27,768 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:42:27 INFO - 2016-01-25 11:42:27,768 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:42:27 INFO - 2016-01-25 11:42:27,768 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:42:27 INFO - 2016-01-25 11:42:27,768 DEBUG : BROWSER_OUTPUT: __metrics 11:42:28 INFO - 2016-01-25 11:42:28,768 INFO : Browser initialized. 11:42:28 INFO - 2016-01-25 11:42:28,769 INFO : Running cycle 1/1 for v8_7 test... 11:42:28 INFO - 2016-01-25 11:42:28,769 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfJJMaC/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:42:30 INFO - 2016-01-25 11:42:30,088 DEBUG : BROWSER_OUTPUT: 11:42:30 INFO - 2016-01-25 11:42:30,088 DEBUG : BROWSER_OUTPUT: (process:30861): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:42:40 INFO - 2016-01-25 11:42:40,592 DEBUG : BROWSER_OUTPUT: RSS: Main: 135970816 11:42:40 INFO - 2016-01-25 11:42:40,592 DEBUG : BROWSER_OUTPUT: 11:43:01 INFO - 2016-01-25 11:43:01,924 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33106/tests/v8_7/run.html (next: http://localhost:33106/tests/v8_7/run.html) 11:43:02 INFO - 2016-01-25 11:43:02,170 DEBUG : BROWSER_OUTPUT: RSS: Main: 136433664 11:43:02 INFO - 2016-01-25 11:43:02,170 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,172 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:43:02 INFO - 2016-01-25 11:43:02,172 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:43:02 INFO - 2016-01-25 11:43:02,172 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:43:02 INFO - 2016-01-25 11:43:02,172 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:43:02 INFO - 2016-01-25 11:43:02,172 DEBUG : BROWSER_OUTPUT: |0;Richards;165.80998176090202 11:43:02 INFO - 2016-01-25 11:43:02,172 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;172.5327812284334 11:43:02 INFO - 2016-01-25 11:43:02,173 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.85495971103086 11:43:02 INFO - 2016-01-25 11:43:02,173 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5159.79381443299 11:43:02 INFO - 2016-01-25 11:43:02,173 DEBUG : BROWSER_OUTPUT: |4;RayTrace;922.509225092251 11:43:02 INFO - 2016-01-25 11:43:02,173 DEBUG : BROWSER_OUTPUT: |5;Earley;549.7526113249038 11:43:02 INFO - 2016-01-25 11:43:02,173 DEBUG : BROWSER_OUTPUT: |6;Boyer;11247.191011235955 11:43:02 INFO - 2016-01-25 11:43:02,174 DEBUG : BROWSER_OUTPUT: |7;RegExp;24047.619047619046 11:43:02 INFO - 2016-01-25 11:43:02,174 DEBUG : BROWSER_OUTPUT: |8;Splay;516.795865633075 11:43:02 INFO - 2016-01-25 11:43:02,174 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 11:43:02 INFO - 2016-01-25 11:43:02,174 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:43:02 INFO - 2016-01-25 11:43:02,175 DEBUG : BROWSER_OUTPUT: __startTimestamp1453750982171__endTimestamp 11:43:02 INFO - 2016-01-25 11:43:02,175 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,175 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:43:02 INFO - 2016-01-25 11:43:02,175 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:43:02 INFO - 2016-01-25 11:43:02,175 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,176 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.81 Median:165.81 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,176 DEBUG : BROWSER_OUTPUT: Values: 165.8 11:43:02 INFO - 2016-01-25 11:43:02,176 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,176 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:172.53 Median:172.53 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,176 DEBUG : BROWSER_OUTPUT: Values: 172.5 11:43:02 INFO - 2016-01-25 11:43:02,176 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,176 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.85 Median:277.85 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,176 DEBUG : BROWSER_OUTPUT: Values: 277.9 11:43:02 INFO - 2016-01-25 11:43:02,177 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,177 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5159.79 Median:5159.79 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,177 DEBUG : BROWSER_OUTPUT: Values: 5159.8 11:43:02 INFO - 2016-01-25 11:43:02,177 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,177 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:922.51 Median:922.51 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,177 DEBUG : BROWSER_OUTPUT: Values: 922.5 11:43:02 INFO - 2016-01-25 11:43:02,177 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,177 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:549.75 Median:549.75 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,177 DEBUG : BROWSER_OUTPUT: Values: 549.8 11:43:02 INFO - 2016-01-25 11:43:02,178 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,178 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11247.19 Median:11247.19 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,178 DEBUG : BROWSER_OUTPUT: Values: 11247.2 11:43:02 INFO - 2016-01-25 11:43:02,178 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,178 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24047.62 Median:24047.62 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,178 DEBUG : BROWSER_OUTPUT: Values: 24047.6 11:43:02 INFO - 2016-01-25 11:43:02,178 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,178 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:516.80 Median:516.80 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,178 DEBUG : BROWSER_OUTPUT: Values: 516.8 11:43:02 INFO - 2016-01-25 11:43:02,178 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,178 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,178 DEBUG : BROWSER_OUTPUT: Values: 4835.7 11:43:02 INFO - 2016-01-25 11:43:02,178 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:43:02 INFO - 2016-01-25 11:43:02,178 DEBUG : BROWSER_OUTPUT: 11:43:03 INFO - 2016-01-25 11:43:03,053 INFO : Browser exited with error code: 0 11:43:03 INFO - 2016-01-25 11:43:03,067 INFO : Completed test v8_7 (00:00:40) 11:43:03 INFO - 2016-01-25 11:43:03,255 INFO : Completed test suite (00:20:09) 11:43:03 INFO - 2016-01-25 11:43:03,255 DEBUG : Working with test: dromaeo_css 11:43:03 INFO - 2016-01-25 11:43:03,255 DEBUG : Generating results file: dromaeo_css 11:43:03 INFO - 2016-01-25 11:43:03,256 DEBUG : Working with test: kraken 11:43:03 INFO - 2016-01-25 11:43:03,256 DEBUG : Generating results file: kraken 11:43:03 INFO - 2016-01-25 11:43:03,257 INFO : javascript benchmark 11:43:03 INFO - 2016-01-25 11:43:03,257 DEBUG : Working with test: v8_7 11:43:03 INFO - 2016-01-25 11:43:03,257 DEBUG : Generating results file: v8_7 11:43:03 INFO - 2016-01-25 11:43:03,257 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:43:03 INFO - 2016-01-25 11:43:03,311 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 11:43:03 INFO - 2016-01-25 11:43:03,311 DEBUG : process_Request line: dromaeo_css 7362.25 graph.html#tests=[[72,52,43]] 11:43:03 INFO - 2016-01-25 11:43:03,311 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:43:03 INFO - 2016-01-25 11:43:03,341 DEBUG : process_Request line: kraken 1502.20 graph.html#tests=[[232,52,43]] 11:43:03 INFO - 2016-01-25 11:43:03,341 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:43:03 INFO - 2016-01-25 11:43:03,372 DEBUG : process_Request line: v8_7 23153.77 graph.html#tests=[[230,52,43]] 11:43:03 INFO - 2016-01-25 11:43:03,373 INFO : javascript benchmark 11:43:03 INFO - 2016-01-25 11:43:03,376 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3228.20908877325, 3245.350929814036, 3277.0660361796895, 3278.5737854078966, 3289.342131573686, 5384.461553844613, 5390.757415916283, 5402.459754024596, 5433.402325744165, 5462.562994960404, 5540.168974653804, 5562.193481945115, 5570.164475328703, 5574.10814269717, 5628.690422026787, 5072.79708811648, 5088.084144853925, 5151.76817043232, 5163.896722065557, 5171.456997015315, 4897.3878265216845, 5058.342415485981, 5061.746912654371, 5063.721495317756, 5083.898322033557, 5037.647364684473, 5068.847934561969, 5150.150225212836, 5164.690118592896, 5173.689578625294, 5085.898282034357, 5122.615803814691, 5141.665791723526, 5148.433672296044, 5177.870553236162, 4833.540813622701, 5047.621428392885, 5106.004329155816, 5106.5659418949435, 5138.997895410396, 5313.787448502056, 5316.7075810830775, 5334.466553344673, 5341.919871201935, 5357.383900851413, 5811.535077193815, 5876.206712093898, 5884.558658100659, 5890.97054514729, 5918.881622367571, 5823.155642431866, 5929.495992840613, 5930.0511918093325, 5935.821925342247, 5971.373005834368, 5519.503244707996, 5573.191887176336, 5598.972005139948, 5623.690697011703, 5637.408072152406, 6027.45752882234, 6048.969755151196, 6060.545459090586, 6072.817815465543, 6076.0278355462915, 5776.133579963039, 5801.448862358154, 5868.618539794899, 5876.0, 5895.734691938787, 5983.072623743326, 6078.696065196723, 6086.878262434727, 6089.208402907594, 6105.755769769159, 5959.642421454727, 5976.73104710289, 5984.162217289496, 5989.371116032841, 5992.370801065913, 5781.82654520365, 5846.386129456346, 5872.207252020922, 5943.9598070337515, 5996.280446346379, 4587.288970209623, 4629.814807407666, 4632.513586073481, 4632.559906808848, 4675.0, 4135.234981528427, 4136.21411931732, 4136.462259906253, 4156.189543039079, 4168.437260969791, 5544.722763861791, 5602.831915042555, 5630.183623374588, 5751.7411716472025, 5772.769089236467, 5885.61743486672, 5915.970420147958, 5943.851403714942, 5969.582129250911, 5979.133025711248, 5608.607397482218, 5654.264945557051, 5660.603757737002, 5662.433756624305, 5701.2018317435595, 5005.34930459038, 5038.269450929668, 5188.403333616607, 5196.714180720097, 5244.737763111905, 6071.066191831001, 6138.14066030756, 6159.260888693296, 6159.260888693386, 6160.815175544741, 5988.461038506555, 6010.729517171825, 6011.098335249748, 6044.304904935812, 6046.939530604637, 5859.94140058594, 6007.669578173242, 6130.601510901777, 6147.231596050494, 6163.7842675506145, 5877.588568800143, 5923.141144534105, 5928.49607783326, 5936.703164841654, 5946.0, 6013.729382177725, 6016.759329626766, 6019.849503762266, 6021.729022193924, 6032.969835150796, 5664.631798933056, 5787.479126878601, 5788.9131663024245, 5791.797287094932, 5828.6211396259105, 5719.656820590778, 5883.558733094949, 5977.491913187428, 5981.863445945257, 6017.548683848641, 5730.656160630376, 5784.4504772046585, 5794.565407594531, 5811.912821307768, 5817.650940943557, 5632.971835140798, 5700.401457846866, 5854.648721076749, 5858.736356864037, 5888.998870191992, 5665.461781130951, 5721.771129154954, 5738.598298119092, 5740.454656807597, 5747.109198074305], "unit": "ms", "name": "dojo.html", "value": 5493.15310295857}, {"lowerIsBetter": false, "replicates": [585.9062549992002, 617.8393617659408, 623.0560700538684, 629.1977728396291, 630.1555915073801, 40162.799186004064, 40597.7970110149, 40873.7956310218, 41100.794496027556, 41146.58853411465, 46303.768481157545, 46933.0, 46971.530284697146, 47035.52964470354, 47115.528844711545, 9087.77280567986, 9195.21840643546, 9262.675806346779, 9268.860967085498, 9277.768055798591, 9016.41393309436, 9111.544422778868, 9139.223166030895, 9159.954200229024, 9164.312676549253, 9085.591148398338, 9102.453852768855, 9125.224355929753, 9169.541522923828, 9175.54122293886, 8979.102089791035, 8999.41503802254, 9052.683156089572, 9055.139761722692, 9068.727938161866, 8925.553722313858, 9024.142706442943, 9044.7286581402, 9057.094290570956, 9089.63641454341, 42969.35545966813, 43371.132577348595, 43470.0, 43486.0, 43522.0, 3599.6760291573623, 3678.1356381250384, 3772.75477093988, 3858.8070596470066, 4155.97922010391, 31472.370552589047, 31489.84255078733, 31705.365892682017, 32129.678703213136, 32748.345033099205, 3608.1520842601967, 3618.5295911531334, 3629.5281613390353, 3641.3809652358896, 3702.7593206441493, 282629.0, 282984.0, 283301.0, 283647.0, 284026.0, 45048.3242751359, 45423.0, 45605.31592026122, 45756.3136552952, 45767.084658307314, 43756.56243437525, 43889.34165987513, 43921.34117988233, 43990.12019759587, 44086.7795661026, 15266.313015914311, 15359.462418815512, 15455.922720386327, 15472.767908481383, 15529.068255904682, 12539.373031348396, 12628.11603187768, 12651.873481265253, 12754.234745915275, 12890.935545322214, 15478.303476343592, 15482.458113965957, 15522.379104835905, 15544.222788860512, 15579.454719084777, 5855.707214639337, 6070.908936365958, 6090.543209259324, 6138.232720909887, 6158.076288556752, 991.8115558043949, 1019.3679918450459, 1093.371311495893, 1096.309325125166, 1104.9613263535737, 29322.706772932423, 29519.55720664192, 29696.554551681744, 30492.390152196833, 30778.384432311228, 1069.385103565453, 1081.1783044885785, 1115.8158903780786, 1157.9247348922293, 1166.9941650291694, 14942.775858362133, 15028.699426011419, 15159.166245856584, 15370.308336124901, 15479.458218962282, 579312.0, 591983.0, 592037.0, 592434.0, 820900.0, 60835.0, 61043.6947815267, 61167.388326117056, 61463.0, 61576.0, 1449.3188201545256, 1449.8477659845564, 1461.9342129604192, 1475.955721328362, 1486.6060493968891, 30768.692313077478, 31256.374872502878, 31594.210144746565, 31984.45324762725, 32285.35429291448, 50173.74913125411, 50815.0, 50843.23735143902, 50854.0, 50957.74521127519, 348976.0, 350485.0, 350507.0, 351264.0, 351283.0, 34356.65643343634, 34455.827720861234, 34811.129721757155, 34813.82593087018, 35307.29385412329, 46298.30552541647, 46375.0, 46731.29903051389, 47087.058258833946, 47536.286955695, 39912.40131397973, 40148.0, 40365.39451908165, 40844.59155408408, 40990.590094098676, 44700.77649611731, 44818.55181448144, 46673.066538669715, 47142.29286560636, 48428.273575895684, 38991.80504097575, 39528.60471395249, 39784.0, 39844.601553985245, 39983.80008099941, 33809.15477113092, 34571.30857382889, 35027.82486087553, 35295.82352088223, 35297.29405411929, 26845.463090738467, 27459.31351716223, 27737.44525109527, 27856.16431507058, 27881.860590696917], "unit": "ms", "name": "ext.html", "value": 19540.278573710544}, {"lowerIsBetter": false, "replicates": [379.0693846606581, 386.25452875949424, 388.9591592882749, 390.20787800764447, 390.25266614433343, 15593.298301576428, 16921.492355229348, 17904.55238619032, 17953.28186872527, 17980.0, 16904.66190676189, 17238.482845514623, 17290.481285561422, 17410.738838917427, 18304.08479576019, 5116.155834287348, 5319.468053194688, 5483.369412517572, 5493.066178749622, 5496.697681627509, 5324.094903866352, 5482.205080263359, 5483.7806487740645, 5503.642263252896, 5513.035218836708, 5373.677579345252, 5415.187721841736, 5468.9726551367185, 5513.173024046385, 5723.227364305828, 5649.293838270196, 5665.631733937281, 5672.177534257551, 5677.517411020068, 5695.3735089139955, 5366.973165134188, 5464.4262352452815, 5472.398036216013, 5488.780448782084, 5534.08687566551, 12402.13185077045, 12472.189307695062, 12690.619281421572, 16153.434629788018, 22163.556728865493, 2219.7225346831647, 2222.4777177363308, 2238.446686751464, 2318.2929206591984, 2344.0, 10225.0, 10432.634857779942, 10436.582536698523, 14009.369578368998, 14033.578992630237, 505.0, 506.1370363530209, 1826.3242600237863, 1888.0, 1891.6878715012006, 67888.66055669739, 68265.0, 70814.99999999949, 71345.64327178383, 71692.64153679251, 10068.39589624625, 10207.234457415723, 10262.846057309147, 10277.229207809294, 10305.381677099398, 13205.0, 13233.9412846972, 13269.336533173302, 13291.401886914919, 13310.334483275798, 8119.431639785276, 8127.106018337978, 8127.455783401135, 8144.063432705315, 8228.42401031922, 7913.0, 7997.960010199912, 8026.317762990211, 8064.032316122103, 8069.919300807034, 4148.709590328648, 4221.6833737469815, 4253.085586598834, 8176.713815016565, 8397.28623067034, 3049.5883055787626, 3135.2005238663996, 3177.777555571134, 3230.2731885325616, 3260.527223552619, 888.1473785166313, 910.0822841280883, 920.9815803684023, 978.3640633588225, 1079.4764539198482, 15825.762613560806, 17865.464036078938, 17874.28502859897, 18301.176447059916, 19595.922224277518, 936.836053690615, 990.4898977026837, 1032.4528000159928, 1049.6221360310283, 1069.8341757027517, 9746.561404736804, 9995.450250236161, 10157.39055656663, 10195.0, 10224.13094886943, 659220.0, 664929.0, 673205.0, 675480.0, 677374.0, 90733.54633226791, 92267.53866230627, 92520.0, 94956.52521737348, 96261.0, 1181.9822702659467, 1182.6688527212393, 1192.439553409896, 1192.5527927027365, 1200.6038007457519, 16698.0, 16765.077920714477, 16790.412335568195, 16818.0, 16985.660286794442, 40977.0, 41147.7942610285, 41186.79406602948, 41194.176116478106, 41857.37213941854, 51762.0, 52008.21987670112, 53498.73250633722, 53725.462745372046, 58934.11598826107, 10166.898331016891, 10460.163186944874, 10471.633492827714, 10522.631707890187, 10623.734406639896, 18451.16969736392, 18596.721049184544, 18886.3389781357, 19126.426207213804, 19250.422487325402, 14743.631409214855, 14938.327775249922, 15049.54851354461, 15769.526914192593, 16201.270942807838, 13477.595672129852, 13973.790393143907, 15181.240937953278, 15416.614584635025, 15815.13016784088, 15449.0, 15860.44488442899, 15892.841071589137, 16156.192190390198, 16211.756823647891, 10220.642277520252, 10404.063634272952, 10496.317739346918, 10503.422311772925, 10556.313839600401, 11195.160362972647, 14658.560243192722, 15947.043177409392, 16154.0, 16167.919160404123], "unit": "ms", "name": "jquery.html", "value": 9555.427358213416}, {"lowerIsBetter": false, "replicates": [1491.6047247479419, 1511.6296507355698, 1687.1058339080291, 1787.0707232239236, 1849.149391280011, 7488.812779680511, 7569.621518924046, 7789.922100778997, 7826.804329891748, 7859.764207073783, 7831.099423566292, 7848.960755196216, 7927.1676473970265, 7946.602669866498, 7967.123616402191, 2218.922337718176, 2251.75230724621, 2253.2001139595454, 2254.0758289101473, 2256.8533045352083, 2161.567686462714, 2187.4859408039097, 2288.1648198407543, 2291.5875142474347, 2305.1125316753087, 2227.899744511501, 2269.375921621551, 2277.214361045445, 2281.4866655002656, 2286.874221917794, 2258.853174543666, 2261.185973049709, 2300.953980920389, 2304.412374844421, 2309.1917828759883, 2258.9548209035893, 2282.5549017941507, 2282.7717228277206, 2283.086765293879, 2285.4514916420108, 7782.299593036654, 7876.488028278143, 7879.842403151963, 7883.724069657592, 7910.841783164362, 4601.286800545888, 4686.367340409035, 4694.155052090622, 4706.952930470686, 4715.339852420664, 3032.9090127296217, 3033.2265272355407, 3097.132802815215, 3108.7668424868225, 3157.100226435478, 1027.6557353286657, 1029.8197815382277, 1802.2971041293906, 1806.4851517317634, 1819.299569665675, 10259.948700256526, 10543.209259305582, 10553.102986246178, 10555.0, 10555.261131720783, 4038.2327357801923, 4101.91796164075, 4111.588841115865, 4127.2570937231585, 4137.358709400048, 8660.047394786568, 8674.175953284428, 8677.783055423539, 8692.739217823475, 8713.564321783886, 4631.907361852812, 4644.907101857944, 4663.090697313991, 4673.836415725434, 4681.555252251031, 4313.805878735465, 4329.047609525899, 4334.544872788375, 4355.412019377407, 4362.498312694017, 3357.1439282982683, 3394.117529442363, 3429.1255729788745, 3443.139215196201, 3466.046837119812, 984.4241118945354, 985.5909797434128, 987.8221920054316, 988.5946761827616, 997.9002099790108, 1130.949107290174, 1132.7791080739341, 1186.1400484648734, 1385.6328073060647, 1450.6881020580627, 7135.785926422215, 7233.204347521873, 7296.087989001375, 7311.415086793044, 7326.377257933029, 1193.7135087579093, 1197.437204513877, 1197.8562572491358, 1203.5486692490317, 1234.8271242026124, 5937.881242375129, 5976.402359763989, 5994.400559944058, 5997.2803263607775, 6015.1278064681255, 8567.657293708182, 9022.86465703015, 9126.634934602675, 9214.493202873906, 9220.815583688289, 8832.602532886036, 8919.42023768453, 8991.55042247885, 9005.459672419676, 9017.684381046633, 7126.2873712628325, 7167.784966451015, 7284.562926224444, 7296.744613938593, 7355.411567074728, 7198.89201661965, 7223.819404514929, 7321.524100933422, 7352.080989876265, 7378.704851805867, 8180.959095204724, 8269.586520674062, 8360.12218717026, 8494.447860889022, 8502.44734092282, 8365.707200248205, 8447.239748422426, 8475.321974241922, 8523.829523409373, 8672.392932494664, 6935.722571097302, 7025.473089518205, 7041.788746337618, 7054.365107140382, 7056.364927156581, 7509.061367329084, 7525.88711169322, 7538.849223015619, 7549.2073332299315, 7558.319751222416, 6966.616836074065, 6993.230744618189, 7007.439404847702, 7193.640317984185, 7201.0, 6563.507736919845, 6897.89653155193, 6963.408110310477, 7012.7545535906, 7105.2894710528535, 6962.895556566555, 6989.33601307875, 7052.33002864727, 7091.858162836817, 7105.431565474853, 6261.092141639346, 6466.321036291121, 6489.805305840832, 6513.609183449008, 6526.021096835512, 6389.4888408926245, 6659.001149827371, 6664.033715111184, 6680.365365290289, 6682.930731083004], "unit": "ms", "name": "mootools.html", "value": 4527.955441378467}, {"lowerIsBetter": false, "replicates": [340.32275771215285, 341.86838067344064, 343.9570053743282, 347.90780443182564, 351.76959091794873, 6312.779052733155, 6394.360563943604, 6421.101045853584, 6432.131662225598, 6484.935150648492, 6301.779437719681, 6322.209723784527, 6332.588381755183, 6359.904601430982, 6363.809085727424, 4811.085893680207, 4838.056578967103, 4846.0550192712435, 4846.563809257166, 4847.1517484440255, 4858.538438848322, 4859.635527335447, 4861.61107111432, 4866.221404575269, 4866.902661946759, 4710.670253082269, 4802.447718512381, 4805.255185446262, 4809.735464549449, 4814.855554333358, 4781.37842080529, 4794.280857871329, 4798.592119669815, 4808.831690890802, 4812.133815913135, 4147.543770185277, 4151.6886233532605, 4155.58444155582, 4159.064210552631, 4167.312393455076, 5999.0, 6073.210482637229, 6078.635281883101, 6082.847928801771, 6085.148079268906, 5598.496135347838, 5603.495685388335, 5614.410486898858, 5618.606697531174, 5622.409646987089, 6671.899921501182, 6700.363465470772, 6728.629925354104, 6731.528792984493, 6738.35985581369, 4586.334981427708, 4586.839460618862, 4592.2193227151465, 4592.471865735416, 4596.54034596541, 6894.276101009372, 6894.655267236618, 6929.0, 6937.445004399636, 6972.965135174342, 4719.339292499053, 4756.809727610926, 4770.212914869077, 4771.5228477152, 4774.689645173053, 4813.253945638432, 4826.686265392738, 4827.758612069382, 4830.758462076882, 4854.2233242681705, 5583.357913839879, 5584.21820945068, 5585.106382978704, 5588.776448942078, 5613.0, 6545.21457425112, 6749.358810913053, 6757.256701762803, 6758.662066896733, 6762.188537375547, 1668.8247733987998, 1706.5904182995992, 1717.0212978602076, 1722.939697110595, 1724.5085150731982, 1154.359330571524, 1159.3333833046033, 1165.5046605192929, 1167.7255844876447, 1173.5833779008499, 6445.806625801233, 6452.806415807533, 6456.580322279131, 6466.288708242089, 6475.6438395887735, 6891.689873955684, 6898.620575868275, 6905.689243984033, 6910.412614927787, 6913.75801846933, 6314.210723659543, 6322.083297921776, 6323.652199129092, 6342.968285158545, 6484.513661475408, 3805.5729101586903, 3842.020284827351, 3843.61563843619, 3846.5576458707046, 3850.634189751969, 7302.415806735448, 7306.415486761046, 7310.415166786751, 7313.12242530889, 7330.047093877868, 7090.0, 7235.710571577183, 7238.819029524304, 7261.273872612696, 7282.672279747424, 7237.095363079615, 7252.89120663201, 7266.418686505067, 7301.525400848928, 7312.853742925218, 6981.476389270927, 7018.403435708022, 7023.894641580483, 7025.051618031501, 7026.789196324118, 6762.763303284361, 6910.447164226749, 6911.136107986502, 6918.792436226921, 6920.480963927826, 7275.599842008741, 7294.270572942663, 7301.160366557701, 7304.4156467483535, 7314.670839812327, 4733.455652599995, 4746.762661866824, 4753.073150735573, 4754.833580824655, 4763.333133361263, 6875.965620172067, 6934.06390137325, 7050.964745176241, 7052.9647351762915, 7053.964730176316, 6785.016172655036, 6805.761798337233, 6836.726530938707, 6849.0, 6857.382835544825, 6772.458203343819, 6802.931970680428, 6836.623985680835, 6841.0, 6843.760468383782, 6548.47612191014, 6664.566803157779, 6686.465082793462, 6714.0600315954825, 6720.294369091371, 6877.89683154743, 6881.65591720422, 6897.7585784497305, 6907.6891539879825, 6910.965445172742, 6668.299828517936, 6709.563878347892, 6713.865722685617, 6729.966350168218, 6733.158355205599], "unit": "ms", "name": "prototype.html", "value": 5090.042563165517}, {"lowerIsBetter": false, "replicates": [798.8641930871751, 805.7260531419316, 807.2169995104746, 807.2895851650549, 811.8011087283612, 14025.649358766035, 14318.785218221708, 14462.566123016313, 14497.347619357128, 14539.127652340867, 14424.711505769877, 14490.42038318466, 14512.274386280671, 14517.128972261671, 14555.1994640295, 905.7373361725108, 927.2581934452445, 941.4492521874712, 946.7727745341103, 949.3829011142778, 917.9816403671922, 923.3859483443503, 926.36081104038, 928.7770934975591, 930.9767255818591, 978.0512902484578, 979.3193730357405, 984.5323471351122, 984.9901500985006, 992.2458931212294, 971.1745016735754, 972.1348000279756, 979.0307595480459, 982.2387649571639, 985.6599473181741, 726.8037629839966, 728.2571776787647, 730.0946825935854, 730.4996077686801, 731.381982225019, 14257.144571325754, 14361.066530675576, 14494.42022319106, 14496.85503144976, 14533.636659083502, 12197.39013049344, 12944.482220711161, 12994.935025324907, 13380.598582042554, 13452.327383630876, 9808.313418060667, 10979.17656175782, 11023.283486573348, 11043.83434248487, 11633.534658613646, 3767.6797472214894, 3780.451834484012, 3808.314503389389, 3883.184531248413, 3970.50368703912, 52704.736476317754, 52792.472075279526, 53198.73400633011, 53282.73358633221, 53347.19979200315, 9316.44101353921, 9518.0, 9705.854412183822, 10509.159267258601, 10895.455227238606, 19638.705419418435, 19779.30772422987, 19793.802061979197, 19809.40571782849, 19835.504112397306, 8078.757637270891, 8144.918550814535, 8145.307648849795, 8255.174482551696, 8473.70342038038, 4469.642428605704, 4598.471175814757, 4631.397918270671, 4679.578837904605, 4734.100520901018, 3290.243244053881, 3322.152851023022, 3336.3160552086765, 3344.347852168804, 3357.8992630221132, 597.8355952113203, 604.5647134063468, 604.5647134063468, 604.6493034040246, 604.9758009679564, 548.1914176589498, 558.6675927822939, 716.9103862017248, 731.9268073192638, 733.7028503456108, 8840.33697472692, 9571.569279382444, 9613.423194608346, 9634.181094606896, 9989.40063596172, 628.4532456762554, 663.7112855907695, 678.4078305373062, 715.7745310227261, 736.4955005820923, 4266.552012038691, 4431.881177240292, 4432.224360736858, 4434.955650443519, 4479.664025198123, 60642.0, 61723.691381542805, 61756.38243617507, 62014.37985620176, 62201.68899155475, 55041.0, 55831.44168558263, 56048.0, 56505.0, 56717.43282567204, 48023.75988120037, 49322.753386233555, 49691.25463118056, 49920.50079499231, 50698.0, 8567.785805354666, 8897.110288971051, 8998.68504602362, 9058.456492610465, 9060.139286767746, 35934.82032589925, 36130.8193459031, 36774.0, 37226.8138659305, 37433.81283093676, 44028.0, 44193.33709994417, 48383.51616483931, 48563.75718121528, 49169.0, 9207.355485115977, 9726.173275271682, 10665.520051597541, 11040.116790656568, 11408.885911140782, 12437.875621244033, 12497.25016499013, 12633.178843375152, 12901.806472903101, 12985.805212921625, 11711.297322160697, 12139.75720485603, 12181.269123852597, 12331.50673973031, 12472.0, 11755.412229388325, 11820.0543956485, 11827.0, 11938.0, 12012.159148859497, 10523.684289471023, 10655.263262943508, 10678.62624808128, 10727.141828653534, 10732.0, 9821.5089245536, 10174.491275436347, 10232.23258255619, 10240.231982601485, 10280.845787313046, 9709.271804614824, 9958.15355694774, 9961.551730172305, 10221.080102790784, 10304.948475257575], "unit": "ms", "name": "yui.html", "value": 6735.954044026555}], "name": "dromaeo_css", "value": 7362.251075481919}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 105.0, 113.0, 112.0, 112.0, 122.0, 111.0, 110.0, 111.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 112.2}, {"lowerIsBetter": true, "replicates": [150.0, 122.0, 151.0, 155.0, 124.0, 145.0, 146.0, 125.0, 165.0, 124.0], "unit": "ms", "name": "audio-beat-detection", "value": 140.7}, {"lowerIsBetter": true, "replicates": [164.0, 162.0, 162.0, 162.0, 161.0, 162.0, 161.0, 161.0, 166.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 162.5}, {"lowerIsBetter": true, "replicates": [78.0, 73.0, 74.0, 159.0, 72.0, 73.0, 71.0, 73.0, 165.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 91.1}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 147.0, 92.0, 93.0, 93.0, 130.0, 93.0, 94.0, 143.0], "unit": "ms", "name": "audio-oscillator", "value": 107.2}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 147.0, 149.0, 146.0, 146.0, 147.0, 147.0, 149.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 97.0, 96.0, 100.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [57.0, 62.0, 58.0, 58.0, 59.0, 58.0, 60.0, 61.0, 57.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 58.7}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 63.0, 63.0, 63.0, 64.0, 63.0, 63.0, 63.0, 63.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.2}, {"lowerIsBetter": true, "replicates": [84.0, 80.0, 91.0, 82.0, 80.0, 81.0, 83.0, 82.0, 83.0, 81.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.7}, {"lowerIsBetter": true, "replicates": [112.0, 115.0, 111.0, 114.0, 111.0, 123.0, 114.0, 117.0, 121.0, 117.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 115.5}, {"lowerIsBetter": true, "replicates": [141.0, 154.0, 154.0, 150.0, 141.0, 143.0, 142.0, 150.0, 155.0, 148.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.8}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 65.0, 67.0, 70.0, 70.0, 66.0, 66.0, 67.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1502.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.80998176090202], "unit": "score", "name": "Richards", "value": 212.90636200000006}, {"lowerIsBetter": false, "replicates": [172.5327812284334], "unit": "score", "name": "DeltaBlue", "value": 383.21992800000015}, {"lowerIsBetter": false, "replicates": [277.85495971103086], "unit": "score", "name": "Encrypt", "value": 957.9854189999998}, {"lowerIsBetter": false, "replicates": [5159.79381443299], "unit": "score", "name": "Decrypt", "value": 51.587526473526495}, {"lowerIsBetter": false, "replicates": [922.509225092251], "unit": "score", "name": "RayTrace", "value": 802.1480759999998}, {"lowerIsBetter": false, "replicates": [549.7526113249038], "unit": "score", "name": "Earley", "value": 1212.296197}, {"lowerIsBetter": false, "replicates": [11247.191011235955], "unit": "score", "name": "Boyer", "value": 59.25595104895108}, {"lowerIsBetter": false, "replicates": [24047.619047619046], "unit": "score", "name": "RegExp", "value": 37.88254455445545}, {"lowerIsBetter": false, "replicates": [516.795865633075], "unit": "score", "name": "Splay", "value": 157.68508499999996}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 23153.774593484803}]} 11:43:03 INFO - RETURN: dromaeo_css: 7362.25 11:43:03 INFO - RETURN: kraken: 1502.20 11:43:03 INFO - RETURN: v8_7: 23153.77 11:43:03 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23153.77"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1502.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7362.25"}}} 11:43:03 INFO - Return code: 0 11:43:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:43:03 INFO - # TBPL SUCCESS # 11:43:03 INFO - Running post-action listener: _resource_record_post_action 11:43:03 INFO - Running post-run listener: _resource_record_post_run 11:43:04 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 0; Write bytes: 384196608; Read time: 0; Write time: 314748 11:43:04 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 108990464; Read time: 0; Write time: 176420 11:43:04 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 0; Write bytes: 274608128; Read time: 0; Write time: 138328 11:43:04 INFO - Running post-run listener: _upload_blobber_files 11:43:04 INFO - Blob upload gear active. 11:43:04 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:43:04 INFO - Copying logs to upload dir... 11:43:04 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1267.588409 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-01-25 11:43:04.297613) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-25 11:43:04.303272) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1861a34ebfea852630dec091000001fa-1453749715.475065-1229317293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010060 build_url: 'https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-25 11:43:04.356286) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:43:04.356651) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1861a34ebfea852630dec091000001fa-1453749715.475065-1229317293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:43:04.406365) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 11:43:04.406709) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 11:43:04.407005) ========= ========= Total master_lag: 0.25 =========