builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-023 starttime: 1453484692.34 results: success (0) buildid: 20160122071931 builduid: 0333fc08884347818290745b35363a58 revision: eff72cafd49d71ee7e530506a99043a8b08751b9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 09:44:52.340767) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 09:44:52.341311) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 09:44:52.341641) ========= 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=6d15e502d8e29d5d2676d664000001c3-1453484691.765222-64653554 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006233 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 09:44:52.364943) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 09:44:52.365307) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 09:44:52.379203) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:44:52.379618) ========= 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=6d15e502d8e29d5d2676d664000001c3-1453484691.765222-64653554 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004619 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:44:52.429139) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 09:44:52.429475) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 09:44:52.429875) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:44:52.430202) ========= 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=6d15e502d8e29d5d2676d664000001c3-1453484691.765222-64653554 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-22 09:44:52-- 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% 83.6M=0s 2016-01-22 09:44:52 (83.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132876 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:44:52.576766) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:44:52.577330) ========= 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=6d15e502d8e29d5d2676d664000001c3-1453484691.765222-64653554 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019049 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:44:52.627475) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:44:52.627859) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev eff72cafd49d71ee7e530506a99043a8b08751b9 --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 eff72cafd49d71ee7e530506a99043a8b08751b9 --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=6d15e502d8e29d5d2676d664000001c3-1453484691.765222-64653554 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-22 09:44:53,019 truncating revision to first 12 chars 2016-01-22 09:44:53,019 Setting DEBUG logging. 2016-01-22 09:44:53,019 attempt 1/10 2016-01-22 09:44:53,019 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/eff72cafd49d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-22 09:44:53,289 unpacking tar archive at: mozilla-aurora-eff72cafd49d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.574893 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:44:53.220419) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 09:44:53.221175) ========= echo eff72cafd49d71ee7e530506a99043a8b08751b9 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'eff72cafd49d71ee7e530506a99043a8b08751b9'] 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=6d15e502d8e29d5d2676d664000001c3-1453484691.765222-64653554 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False eff72cafd49d71ee7e530506a99043a8b08751b9 program finished with exit code 0 elapsedTime=0.004698 script_repo_revision: 'eff72cafd49d71ee7e530506a99043a8b08751b9' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 09:44:53.273611) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 09:44:53.274120) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 09:44:53.284644) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-01-22 09:44:53.284955) ========= /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=6d15e502d8e29d5d2676d664000001c3-1453484691.765222-64653554 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:44:53 INFO - MultiFileLogger online at 20160122 09:44:53 in /builds/slave/test-pgo 09:44:53 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 09:44:53 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:44:53 INFO - {'append_to_log': False, 09:44:53 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:44:53 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:44:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:44:53 INFO - 'branch': 'Mozilla-Aurora', 09:44:53 INFO - 'buildbot_json_path': 'buildprops.json', 09:44:53 INFO - 'config_files': ('talos/linux_config.py',), 09:44:53 INFO - 'default_actions': ('clobber', 09:44:53 INFO - 'read-buildbot-config', 09:44:53 INFO - 'download-and-extract', 09:44:53 INFO - 'populate-webroot', 09:44:53 INFO - 'create-virtualenv', 09:44:53 INFO - 'install', 09:44:53 INFO - 'run-tests'), 09:44:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:44:53 INFO - 'download_minidump_stackwalk': True, 09:44:53 INFO - 'download_symbols': 'ondemand', 09:44:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:44:53 INFO - 'tooltool.py': '/tools/tooltool.py', 09:44:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:44:53 INFO - '/tools/misc-python/virtualenv.py')}, 09:44:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:44:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:44:53 INFO - 'installer_path': 'installer.exe', 09:44:53 INFO - 'log_level': 'info', 09:44:53 INFO - 'log_name': 'talos', 09:44:53 INFO - 'log_to_console': True, 09:44:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:44:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:44:53 INFO - 'opt_config_files': (), 09:44:53 INFO - 'pip_index': False, 09:44:53 INFO - 'sps_profile': False, 09:44:53 INFO - 'sps_profile_interval': 0, 09:44:53 INFO - 'suite': 'dromaeojs-e10s', 09:44:53 INFO - 'system_bits': '32', 09:44:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:44:53 INFO - 'title': 'talos-linux64-ix-023', 09:44:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:44:53 INFO - 'use_talos_json': True, 09:44:53 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:44:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:44:53 INFO - 'work_dir': 'build'} 09:44:53 INFO - ##### 09:44:53 INFO - ##### Running clobber step. 09:44:53 INFO - ##### 09:44:53 INFO - Running pre-action listener: _resource_record_pre_action 09:44:53 INFO - Running main action method: clobber 09:44:53 INFO - rmtree: /builds/slave/test-pgo/build 09:44:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:44:54 INFO - Running post-action listener: _resource_record_post_action 09:44:54 INFO - ##### 09:44:54 INFO - ##### Running read-buildbot-config step. 09:44:54 INFO - ##### 09:44:54 INFO - Running pre-action listener: _resource_record_pre_action 09:44:54 INFO - Running main action method: read_buildbot_config 09:44:54 INFO - Using buildbot properties: 09:44:54 INFO - { 09:44:54 INFO - "properties": { 09:44:54 INFO - "buildnumber": 71, 09:44:54 INFO - "product": "firefox", 09:44:54 INFO - "script_repo_revision": "production", 09:44:54 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 09:44:54 INFO - "repository": "", 09:44:54 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 09:44:54 INFO - "buildid": "20160122071931", 09:44:54 INFO - "slavename": "talos-linux64-ix-023", 09:44:54 INFO - "pgo_build": "True", 09:44:54 INFO - "basedir": "/builds/slave/test-pgo", 09:44:54 INFO - "project": "", 09:44:54 INFO - "platform": "ubuntu64_hw", 09:44:54 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:44:54 INFO - "slavebuilddir": "test", 09:44:54 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:44:54 INFO - "branch": "mozilla-aurora", 09:44:54 INFO - "repo_path": "releases/mozilla-aurora", 09:44:54 INFO - "stage_platform": "linux64-pgo", 09:44:54 INFO - "builduid": "0333fc08884347818290745b35363a58", 09:44:54 INFO - "revision": "eff72cafd49d71ee7e530506a99043a8b08751b9" 09:44:54 INFO - }, 09:44:54 INFO - "sourcestamp": { 09:44:54 INFO - "repository": "", 09:44:54 INFO - "hasPatch": false, 09:44:54 INFO - "project": "", 09:44:54 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 09:44:54 INFO - "changes": [ 09:44:54 INFO - { 09:44:54 INFO - "category": null, 09:44:54 INFO - "files": [ 09:44:54 INFO - { 09:44:54 INFO - "url": null, 09:44:54 INFO - "name": "https://queue.taskcluster.net/v1/task/JrR3iT1URxuYJGrTHUu8rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 09:44:54 INFO - } 09:44:54 INFO - ], 09:44:54 INFO - "repository": "", 09:44:54 INFO - "rev": "eff72cafd49d71ee7e530506a99043a8b08751b9", 09:44:54 INFO - "who": "cbook@mozilla.com", 09:44:54 INFO - "when": 1453484278, 09:44:54 INFO - "number": 7501648, 09:44:54 INFO - "comments": "Bug 1239787 - TabQueueService: Do not clear tabQueueHandler reference. r=ahunt, a=sylvestre", 09:44:54 INFO - "project": "", 09:44:54 INFO - "at": "Fri 22 Jan 2016 09:37:58", 09:44:54 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 09:44:54 INFO - "revlink": "", 09:44:54 INFO - "properties": [ 09:44:54 INFO - [ 09:44:54 INFO - "buildid", 09:44:54 INFO - "20160122071931", 09:44:54 INFO - "Change" 09:44:54 INFO - ], 09:44:54 INFO - [ 09:44:54 INFO - "builduid", 09:44:54 INFO - "0333fc08884347818290745b35363a58", 09:44:54 INFO - "Change" 09:44:54 INFO - ], 09:44:54 INFO - [ 09:44:54 INFO - "pgo_build", 09:44:54 INFO - "True", 09:44:54 INFO - "Change" 09:44:54 INFO - ] 09:44:54 INFO - ], 09:44:54 INFO - "revision": "eff72cafd49d71ee7e530506a99043a8b08751b9" 09:44:54 INFO - } 09:44:54 INFO - ], 09:44:54 INFO - "revision": "eff72cafd49d71ee7e530506a99043a8b08751b9" 09:44:54 INFO - } 09:44:54 INFO - } 09:44:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/JrR3iT1URxuYJGrTHUu8rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 09:44:54 INFO - Running post-action listener: _resource_record_post_action 09:44:54 INFO - ##### 09:44:54 INFO - ##### Running download-and-extract step. 09:44:54 INFO - ##### 09:44:54 INFO - Running pre-action listener: _resource_record_pre_action 09:44:54 INFO - Running main action method: download_and_extract 09:44:54 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:44:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:54 INFO - https://queue.taskcluster.net/v1/task/JrR3iT1URxuYJGrTHUu8rg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:44:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrR3iT1URxuYJGrTHUu8rg/artifacts/public/build/test_packages.json 09:44:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrR3iT1URxuYJGrTHUu8rg/artifacts/public/build/test_packages.json 09:44:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrR3iT1URxuYJGrTHUu8rg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:44:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrR3iT1URxuYJGrTHUu8rg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:44:56 INFO - Downloaded 1302 bytes. 09:44:56 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:44:56 INFO - Using the following test package requirements: 09:44:56 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 09:44:56 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:44:56 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:44:56 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:44:56 INFO - u'jsshell-linux-x86_64.zip'], 09:44:56 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:44:56 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:44:56 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 09:44:56 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:44:56 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:44:56 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:44:56 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:44:56 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:44:56 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:44:56 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 09:44:56 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:44:56 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:44:56 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:44:56 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')]} 09:44:56 INFO - https://queue.taskcluster.net/v1/task/JrR3iT1URxuYJGrTHUu8rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:44:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrR3iT1URxuYJGrTHUu8rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:44:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrR3iT1URxuYJGrTHUu8rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:44:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrR3iT1URxuYJGrTHUu8rg/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 09:44:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrR3iT1URxuYJGrTHUu8rg/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 09:44:58 INFO - Downloaded 23158787 bytes. 09:44:58 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 09:44:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:44:58 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 09:44:59 INFO - Return code: 0 09:44:59 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 09:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:59 INFO - https://queue.taskcluster.net/v1/task/JrR3iT1URxuYJGrTHUu8rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:44:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrR3iT1URxuYJGrTHUu8rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:44:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrR3iT1URxuYJGrTHUu8rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:44:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrR3iT1URxuYJGrTHUu8rg/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 09:44:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrR3iT1URxuYJGrTHUu8rg/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 09:45:00 INFO - Downloaded 23158787 bytes. 09:45:00 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 09:45:00 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:45:00 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 09:45:01 INFO - Return code: 0 09:45:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:01 INFO - https://queue.taskcluster.net/v1/task/JrR3iT1URxuYJGrTHUu8rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:45:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrR3iT1URxuYJGrTHUu8rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 09:45:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrR3iT1URxuYJGrTHUu8rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 09:45:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrR3iT1URxuYJGrTHUu8rg/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 09:45:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrR3iT1URxuYJGrTHUu8rg/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 09:45:03 INFO - Downloaded 11132038 bytes. 09:45:03 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 09:45:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 09:45:03 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 09:45:03 INFO - Return code: 0 09:45: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')]} 09:45:03 INFO - https://queue.taskcluster.net/v1/task/JrR3iT1URxuYJGrTHUu8rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:45:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrR3iT1URxuYJGrTHUu8rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:45:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrR3iT1URxuYJGrTHUu8rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:45:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrR3iT1URxuYJGrTHUu8rg/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 09:45:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JrR3iT1URxuYJGrTHUu8rg/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 09:45:07 INFO - Downloaded 58025246 bytes. 09:45:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JrR3iT1URxuYJGrTHUu8rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:45:07 INFO - mkdir: /builds/slave/test-pgo/properties 09:45:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:45:07 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:45:07 INFO - Contents: 09:45:07 INFO - build_url:https://queue.taskcluster.net/v1/task/JrR3iT1URxuYJGrTHUu8rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:45:07 INFO - Running post-action listener: _resource_record_post_action 09:45:07 INFO - Running post-action listener: set_extra_try_arguments 09:45:07 INFO - ##### 09:45:07 INFO - ##### Running populate-webroot step. 09:45:07 INFO - ##### 09:45:07 INFO - Running pre-action listener: _resource_record_pre_action 09:45:07 INFO - Running main action method: populate_webroot 09:45:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:45:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:45:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:45:07 INFO - '--tppagecycles', 09:45:07 INFO - '7'], 09:45:07 INFO - 'tests': ['tsvgm']}}, 09:45:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:45:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:45:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:45:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:45:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:45:07 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:45:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:45:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:07 INFO - 'talos_options': ['--e10s'], 09:45:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:45:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:07 INFO - 'tests': ['damp', 'tps']}, 09:45:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:07 INFO - 'talos_options': ['--e10s'], 09:45:07 INFO - 'tests': ['damp', 'tps']}, 09:45:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:45:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:45:07 INFO - 'other': {'tests': ['a11yr', 09:45:07 INFO - 'ts_paint', 09:45:07 INFO - 'tpaint', 09:45:07 INFO - 'sessionrestore', 09:45:07 INFO - 'sessionrestore_no_auto_restore']}, 09:45:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:45:07 INFO - 'tests': ['a11yr', 09:45:07 INFO - 'ts_paint', 09:45:07 INFO - 'tpaint', 09:45:07 INFO - 'sessionrestore', 09:45:07 INFO - 'sessionrestore_no_auto_restore']}, 09:45:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:45:07 INFO - 'tests': ['a11yr', 09:45:07 INFO - 'ts_paint', 09:45:07 INFO - 'tpaint', 09:45:07 INFO - 'sessionrestore', 09:45:07 INFO - 'sessionrestore_no_auto_restore']}, 09:45:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:45:07 INFO - 'tests': ['a11yr', 09:45:07 INFO - 'ts_paint', 09:45:07 INFO - 'tpaint', 09:45:07 INFO - 'sessionrestore', 09:45:07 INFO - 'sessionrestore_no_auto_restore']}, 09:45:07 INFO - 'other_l64': {'tests': ['a11yr', 09:45:07 INFO - 'ts_paint', 09:45:07 INFO - 'tpaint', 09:45:07 INFO - 'sessionrestore', 09:45:07 INFO - 'sessionrestore_no_auto_restore']}, 09:45:07 INFO - 'other_nol64': {'tests': ['a11yr', 09:45:07 INFO - 'ts_paint', 09:45:07 INFO - 'tpaint', 09:45:07 INFO - 'sessionrestore', 09:45:07 INFO - 'sessionrestore_no_auto_restore']}, 09:45:07 INFO - 'svgr': {'tests': ['tsvgx', 09:45:07 INFO - 'tsvgr_opacity', 09:45:07 INFO - 'tart', 09:45:07 INFO - 'tscrollx', 09:45:07 INFO - 'cart']}, 09:45:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:45:07 INFO - 'tests': ['tsvgx', 09:45:07 INFO - 'tsvgr_opacity', 09:45:07 INFO - 'tart', 09:45:07 INFO - 'tscrollx', 09:45:07 INFO - 'cart']}, 09:45:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:07 INFO - 'tests': ['tp5o']}, 09:45:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:07 INFO - 'talos_options': ['--e10s'], 09:45:07 INFO - 'tests': ['tp5o']}, 09:45:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:07 INFO - 'talos_options': ['--xperf_path', 09:45:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:45:07 INFO - 'tests': ['tp5n']}, 09:45:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:07 INFO - 'talos_options': ['--e10s', 09:45:07 INFO - '--xperf_path', 09:45:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:45:07 INFO - 'tests': ['tp5n']}}, 09:45:07 INFO - 'talos.zip': {'path': '', 09:45:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:45:07 INFO - Running post-action listener: _resource_record_post_action 09:45:07 INFO - ##### 09:45:07 INFO - ##### Running create-virtualenv step. 09:45:07 INFO - ##### 09:45:07 INFO - Running pre-action listener: _resource_record_pre_action 09:45:07 INFO - Running main action method: create_virtualenv 09:45:07 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:45:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 09:45:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:45:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:45:07 INFO - Using real prefix '/usr' 09:45:07 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:45:08 INFO - Installing distribute.............................................................................................................................................................................................done. 09:45:10 INFO - Installing pip.................done. 09:45:10 INFO - Return code: 0 09:45:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2f835bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ee500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb6a0>, '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 0x14ec5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eca30>, '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': '6d15e502d8e29d5d2676d664000001c3-1453484691.765222-64653554', '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 09:45:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 09:45:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:45:10 INFO - Using env: {'DISPLAY': ':0', 09:45:10 INFO - 'HOME': '/home/cltbld', 09:45:10 INFO - 'LANG': 'en_US.UTF-8', 09:45:10 INFO - 'LANGUAGE': 'en_US:en', 09:45:10 INFO - 'LOGNAME': 'cltbld', 09:45:10 INFO - 'MAIL': '/var/mail/cltbld', 09:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:10 INFO - 'MOZ_NO_REMOTE': '1', 09:45:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:10 INFO - 'NO_EM_RESTART': '1', 09:45:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:45:10 INFO - 'PWD': '/builds/slave/test-pgo', 09:45:10 INFO - 'SHELL': '/bin/bash', 09:45:10 INFO - 'SHLVL': '1', 09:45:10 INFO - 'TERM': 'linux', 09:45:10 INFO - 'TMOUT': '86400', 09:45:10 INFO - 'USER': 'cltbld', 09:45:10 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453484691.765222-64653554', 09:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:10 INFO - '_': '/tools/buildbot/bin/python'} 09:45:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:45:10 INFO - Cleaning up... 09:45:10 INFO - Return code: 0 09:45:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2f835bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ee500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb6a0>, '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 0x14ec5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eca30>, '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': '6d15e502d8e29d5d2676d664000001c3-1453484691.765222-64653554', '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 09:45:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 09:45:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:45:10 INFO - Using env: {'DISPLAY': ':0', 09:45:10 INFO - 'HOME': '/home/cltbld', 09:45:10 INFO - 'LANG': 'en_US.UTF-8', 09:45:10 INFO - 'LANGUAGE': 'en_US:en', 09:45:10 INFO - 'LOGNAME': 'cltbld', 09:45:10 INFO - 'MAIL': '/var/mail/cltbld', 09:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:10 INFO - 'MOZ_NO_REMOTE': '1', 09:45:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:10 INFO - 'NO_EM_RESTART': '1', 09:45:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:45:10 INFO - 'PWD': '/builds/slave/test-pgo', 09:45:10 INFO - 'SHELL': '/bin/bash', 09:45:10 INFO - 'SHLVL': '1', 09:45:10 INFO - 'TERM': 'linux', 09:45:10 INFO - 'TMOUT': '86400', 09:45:10 INFO - 'USER': 'cltbld', 09:45:10 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453484691.765222-64653554', 09:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:10 INFO - '_': '/tools/buildbot/bin/python'} 09:45:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:10 INFO - Downloading/unpacking psutil>=0.7.1 09:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:45:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:45:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:45:12 INFO - Installing collected packages: psutil 09:45:12 INFO - Running setup.py install for psutil 09:45:12 INFO - building 'psutil._psutil_linux' extension 09:45:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:45:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:45:12 INFO - building 'psutil._psutil_posix' extension 09:45:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:45:13 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 09:45:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:45:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:45:13 INFO - Successfully installed psutil 09:45:13 INFO - Cleaning up... 09:45:13 INFO - Return code: 0 09:45:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:45:13 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')]} 09:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:13 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')]} 09:45:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:13 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 0x7f2f835bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ee500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb6a0>, '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 0x14ec5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eca30>, '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': '6d15e502d8e29d5d2676d664000001c3-1453484691.765222-64653554', '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 09:45:13 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 09:45:13 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 09:45:13 INFO - Using env: {'DISPLAY': ':0', 09:45:13 INFO - 'HOME': '/home/cltbld', 09:45:13 INFO - 'LANG': 'en_US.UTF-8', 09:45:13 INFO - 'LANGUAGE': 'en_US:en', 09:45:13 INFO - 'LOGNAME': 'cltbld', 09:45:13 INFO - 'MAIL': '/var/mail/cltbld', 09:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:13 INFO - 'MOZ_NO_REMOTE': '1', 09:45:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:13 INFO - 'NO_EM_RESTART': '1', 09:45:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:45:13 INFO - 'PWD': '/builds/slave/test-pgo', 09:45:13 INFO - 'SHELL': '/bin/bash', 09:45:13 INFO - 'SHLVL': '1', 09:45:13 INFO - 'TERM': 'linux', 09:45:13 INFO - 'TMOUT': '86400', 09:45:13 INFO - 'USER': 'cltbld', 09:45:13 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453484691.765222-64653554', 09:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:13 INFO - '_': '/tools/buildbot/bin/python'} 09:45:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:45:13 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 09:45:13 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 09:45:13 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 09:45:13 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 09:45:13 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 09:45:13 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 09:45:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:45:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:45:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:45:15 INFO - Installing collected packages: mozsystemmonitor 09:45:15 INFO - Running setup.py install for mozsystemmonitor 09:45:15 INFO - Successfully installed mozsystemmonitor 09:45:15 INFO - Cleaning up... 09:45:15 INFO - Return code: 0 09:45:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:45:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2f835bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ee500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb6a0>, '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 0x14ec5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eca30>, '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': '6d15e502d8e29d5d2676d664000001c3-1453484691.765222-64653554', '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 09:45:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 09:45:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:45:15 INFO - Using env: {'DISPLAY': ':0', 09:45:15 INFO - 'HOME': '/home/cltbld', 09:45:15 INFO - 'LANG': 'en_US.UTF-8', 09:45:15 INFO - 'LANGUAGE': 'en_US:en', 09:45:15 INFO - 'LOGNAME': 'cltbld', 09:45:15 INFO - 'MAIL': '/var/mail/cltbld', 09:45:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:15 INFO - 'MOZ_NO_REMOTE': '1', 09:45:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:15 INFO - 'NO_EM_RESTART': '1', 09:45:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:45:15 INFO - 'PWD': '/builds/slave/test-pgo', 09:45:15 INFO - 'SHELL': '/bin/bash', 09:45:15 INFO - 'SHLVL': '1', 09:45:15 INFO - 'TERM': 'linux', 09:45:15 INFO - 'TMOUT': '86400', 09:45:15 INFO - 'USER': 'cltbld', 09:45:15 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453484691.765222-64653554', 09:45:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:15 INFO - '_': '/tools/buildbot/bin/python'} 09:45:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:15 INFO - Downloading/unpacking blobuploader==1.2.4 09:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:17 INFO - Downloading blobuploader-1.2.4.tar.gz 09:45:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:45:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:45:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45:18 INFO - Downloading docopt-0.6.1.tar.gz 09:45:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:45:18 INFO - Installing collected packages: blobuploader, requests, docopt 09:45:18 INFO - Running setup.py install for blobuploader 09:45:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:45:18 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:45:18 INFO - Running setup.py install for requests 09:45:18 INFO - Running setup.py install for docopt 09:45:18 INFO - Successfully installed blobuploader requests docopt 09:45:18 INFO - Cleaning up... 09:45:18 INFO - Return code: 0 09:45:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:45:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:18 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2f835bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ee500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb6a0>, '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 0x14ec5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eca30>, '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': '6d15e502d8e29d5d2676d664000001c3-1453484691.765222-64653554', '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 09:45:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 09:45:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:45:18 INFO - Using env: {'DISPLAY': ':0', 09:45:18 INFO - 'HOME': '/home/cltbld', 09:45:18 INFO - 'LANG': 'en_US.UTF-8', 09:45:18 INFO - 'LANGUAGE': 'en_US:en', 09:45:18 INFO - 'LOGNAME': 'cltbld', 09:45:18 INFO - 'MAIL': '/var/mail/cltbld', 09:45:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:18 INFO - 'MOZ_NO_REMOTE': '1', 09:45:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:18 INFO - 'NO_EM_RESTART': '1', 09:45:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:45:18 INFO - 'PWD': '/builds/slave/test-pgo', 09:45:18 INFO - 'SHELL': '/bin/bash', 09:45:18 INFO - 'SHLVL': '1', 09:45:18 INFO - 'TERM': 'linux', 09:45:18 INFO - 'TMOUT': '86400', 09:45:18 INFO - 'USER': 'cltbld', 09:45:18 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453484691.765222-64653554', 09:45:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:18 INFO - '_': '/tools/buildbot/bin/python'} 09:45:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:45:18 INFO - Running setup.py (path:/tmp/pip-OuyqUb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:45:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:45:18 INFO - Running setup.py (path:/tmp/pip-BHxVkO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:45:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:45:19 INFO - Running setup.py (path:/tmp/pip-lHx2bK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:45:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:45:19 INFO - Running setup.py (path:/tmp/pip-yye1U9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:45:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:45:19 INFO - Running setup.py (path:/tmp/pip-gSgNLl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:45:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:45:19 INFO - Running setup.py (path:/tmp/pip-ItOZW1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:45:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:45:19 INFO - Running setup.py (path:/tmp/pip-k65XUV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:45:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:45:19 INFO - Running setup.py (path:/tmp/pip-6QkQMd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:45:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:45:19 INFO - Running setup.py (path:/tmp/pip-Nesgt2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:45:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:45:19 INFO - Running setup.py (path:/tmp/pip-rB2lel-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:45:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:45:19 INFO - Running setup.py (path:/tmp/pip-JskwW0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:45:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:45:19 INFO - Running setup.py (path:/tmp/pip-H97oRK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:45:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:45:19 INFO - Running setup.py (path:/tmp/pip-f6Kaw2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:45:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:45:19 INFO - Running setup.py (path:/tmp/pip-sirYoy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:45:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:45:19 INFO - Running setup.py (path:/tmp/pip-2mkZrf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:45:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:45:19 INFO - Running setup.py (path:/tmp/pip-1ZrBz8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:45:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:45:20 INFO - Running setup.py (path:/tmp/pip-6Ga_33-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:45:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:45:20 INFO - Running setup.py install for manifestparser 09:45:20 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:45:20 INFO - Running setup.py install for mozcrash 09:45:20 INFO - Running setup.py install for mozdebug 09:45:20 INFO - Running setup.py install for mozdevice 09:45:20 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:45:20 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:45:20 INFO - Running setup.py install for mozfile 09:45:20 INFO - Running setup.py install for mozhttpd 09:45:20 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:45:20 INFO - Running setup.py install for mozinfo 09:45:20 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:45:20 INFO - Running setup.py install for mozInstall 09:45:20 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:45:20 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:45:20 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:45:20 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:45:20 INFO - Running setup.py install for mozleak 09:45:21 INFO - Running setup.py install for mozlog 09:45:21 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:45:21 INFO - Running setup.py install for moznetwork 09:45:21 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:45:21 INFO - Running setup.py install for mozprocess 09:45:21 INFO - Running setup.py install for mozprofile 09:45:21 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:45:21 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:45:21 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:45:21 INFO - Running setup.py install for mozrunner 09:45:21 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:45:21 INFO - Running setup.py install for mozscreenshot 09:45:21 INFO - Running setup.py install for moztest 09:45:21 INFO - Running setup.py install for mozversion 09:45:21 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:45:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:45:21 INFO - Cleaning up... 09:45:21 INFO - Return code: 0 09:45:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:45: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')]} 09:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45: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')]} 09:45:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2f835bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ee500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb6a0>, '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 0x14ec5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eca30>, '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': '6d15e502d8e29d5d2676d664000001c3-1453484691.765222-64653554', '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 09:45:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 09:45:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:45:21 INFO - Using env: {'DISPLAY': ':0', 09:45:21 INFO - 'HOME': '/home/cltbld', 09:45:21 INFO - 'LANG': 'en_US.UTF-8', 09:45:21 INFO - 'LANGUAGE': 'en_US:en', 09:45:21 INFO - 'LOGNAME': 'cltbld', 09:45:21 INFO - 'MAIL': '/var/mail/cltbld', 09:45:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:21 INFO - 'MOZ_NO_REMOTE': '1', 09:45:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:21 INFO - 'NO_EM_RESTART': '1', 09:45:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:45:21 INFO - 'PWD': '/builds/slave/test-pgo', 09:45:21 INFO - 'SHELL': '/bin/bash', 09:45:21 INFO - 'SHLVL': '1', 09:45:21 INFO - 'TERM': 'linux', 09:45:21 INFO - 'TMOUT': '86400', 09:45:21 INFO - 'USER': 'cltbld', 09:45:21 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453484691.765222-64653554', 09:45:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:21 INFO - '_': '/tools/buildbot/bin/python'} 09:45:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:45:22 INFO - Running setup.py (path:/tmp/pip-tqEfrl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:45:22 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)) 09:45:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:45:22 INFO - Running setup.py (path:/tmp/pip-SDPjTS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:45:22 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)) 09:45:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:45:22 INFO - Running setup.py (path:/tmp/pip-XJCSUN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:45:22 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)) 09:45:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:45:22 INFO - Running setup.py (path:/tmp/pip-qPm61L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:45:22 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)) 09:45:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:45:22 INFO - Running setup.py (path:/tmp/pip-ukEKAV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:45:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 09:45:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:45:22 INFO - Running setup.py (path:/tmp/pip-iXHngs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:45:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 09:45:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:45:22 INFO - Running setup.py (path:/tmp/pip-3ibLkk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:45:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 09:45:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:45:22 INFO - Running setup.py (path:/tmp/pip-3J0g2L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:45:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 09:45:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:45:22 INFO - Running setup.py (path:/tmp/pip-aY0Dth-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:45:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 09:45:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:45:22 INFO - Running setup.py (path:/tmp/pip-nk5rU2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:45:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:45:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:45:22 INFO - Running setup.py (path:/tmp/pip-BQdPYJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:45:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 09:45:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:45:22 INFO - Running setup.py (path:/tmp/pip-HT4d_P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:45:23 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)) 09:45:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:45:23 INFO - Running setup.py (path:/tmp/pip-j803mQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:45:23 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)) 09:45:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:45:23 INFO - Running setup.py (path:/tmp/pip-XkxFZ6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:45:23 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)) 09:45:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:45:23 INFO - Running setup.py (path:/tmp/pip-aOGEWY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:45:23 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)) 09:45:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:45:23 INFO - Running setup.py (path:/tmp/pip-QTCQtF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:45:23 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)) 09:45:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:45:23 INFO - Running setup.py (path:/tmp/pip-cpjGDy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:45:23 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)) 09:45:23 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)) 09:45:23 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)) 09:45:23 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)) 09:45:23 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)) 09:45:23 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)) 09:45:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45:25 INFO - Downloading blessings-1.6.tar.gz 09:45:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:45:25 INFO - Installing collected packages: blessings 09:45:25 INFO - Running setup.py install for blessings 09:45:25 INFO - Successfully installed blessings 09:45:25 INFO - Cleaning up... 09:45:25 INFO - Return code: 0 09:45:25 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:45:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:45:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:45:25 INFO - Reading from file tmpfile_stdout 09:45:25 INFO - Current package versions: 09:45:25 INFO - argparse == 1.2.1 09:45:25 INFO - blessings == 1.6 09:45:25 INFO - blobuploader == 1.2.4 09:45:25 INFO - docopt == 0.6.1 09:45:25 INFO - manifestparser == 1.1 09:45:25 INFO - mozInstall == 1.12 09:45:25 INFO - mozcrash == 0.16 09:45:25 INFO - mozdebug == 0.1 09:45:25 INFO - mozdevice == 0.47 09:45:25 INFO - mozfile == 1.2 09:45:25 INFO - mozhttpd == 0.7 09:45:25 INFO - mozinfo == 0.9 09:45:25 INFO - mozleak == 0.1 09:45:25 INFO - mozlog == 3.1 09:45:25 INFO - moznetwork == 0.27 09:45:25 INFO - mozprocess == 0.22 09:45:25 INFO - mozprofile == 0.27 09:45:25 INFO - mozrunner == 6.11 09:45:25 INFO - mozscreenshot == 0.1 09:45:25 INFO - mozsystemmonitor == 0.0 09:45:25 INFO - moztest == 0.7 09:45:25 INFO - mozversion == 1.4 09:45:25 INFO - psutil == 3.1.1 09:45:25 INFO - requests == 1.2.3 09:45:25 INFO - wsgiref == 0.1.2 09:45:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:45: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')]} 09:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45: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')]} 09:45:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2f835bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ee500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb6a0>, '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 0x14ec5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eca30>, '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': '6d15e502d8e29d5d2676d664000001c3-1453484691.765222-64653554', '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 09:45:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 09:45:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:45:25 INFO - Using env: {'DISPLAY': ':0', 09:45:25 INFO - 'HOME': '/home/cltbld', 09:45:25 INFO - 'LANG': 'en_US.UTF-8', 09:45:25 INFO - 'LANGUAGE': 'en_US:en', 09:45:25 INFO - 'LOGNAME': 'cltbld', 09:45:25 INFO - 'MAIL': '/var/mail/cltbld', 09:45:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:25 INFO - 'MOZ_NO_REMOTE': '1', 09:45:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:25 INFO - 'NO_EM_RESTART': '1', 09:45:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:45:25 INFO - 'PWD': '/builds/slave/test-pgo', 09:45:25 INFO - 'SHELL': '/bin/bash', 09:45:25 INFO - 'SHLVL': '1', 09:45:25 INFO - 'TERM': 'linux', 09:45:25 INFO - 'TMOUT': '86400', 09:45:25 INFO - 'USER': 'cltbld', 09:45:25 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453484691.765222-64653554', 09:45:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:25 INFO - '_': '/tools/buildbot/bin/python'} 09:45:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 09:45:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 09:45:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 09:45:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 09:45:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 09:45:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 09:45:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 09:45:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 09:45:25 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)) 09:45:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 09:45:25 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 09:45:25 INFO - Cleaning up... 09:45:25 INFO - Return code: 0 09:45:25 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:45: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')]} 09:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45: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')]} 09:45:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2f835bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ee500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb6a0>, '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 0x14ec5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eca30>, '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': '6d15e502d8e29d5d2676d664000001c3-1453484691.765222-64653554', '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 09:45:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 09:45:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:45:25 INFO - Using env: {'DISPLAY': ':0', 09:45:25 INFO - 'HOME': '/home/cltbld', 09:45:25 INFO - 'LANG': 'en_US.UTF-8', 09:45:25 INFO - 'LANGUAGE': 'en_US:en', 09:45:25 INFO - 'LOGNAME': 'cltbld', 09:45:25 INFO - 'MAIL': '/var/mail/cltbld', 09:45:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:25 INFO - 'MOZ_NO_REMOTE': '1', 09:45:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:25 INFO - 'NO_EM_RESTART': '1', 09:45:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:45:25 INFO - 'PWD': '/builds/slave/test-pgo', 09:45:25 INFO - 'SHELL': '/bin/bash', 09:45:25 INFO - 'SHLVL': '1', 09:45:25 INFO - 'TERM': 'linux', 09:45:25 INFO - 'TMOUT': '86400', 09:45:25 INFO - 'USER': 'cltbld', 09:45:25 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453484691.765222-64653554', 09:45:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:25 INFO - '_': '/tools/buildbot/bin/python'} 09:45:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:26 INFO - Downloading/unpacking jsonschema 09:45:26 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 09:45:26 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 09:45:26 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 09:45:26 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 09:45:26 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 09:45:26 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 09:45:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:45:27 INFO - Downloading/unpacking functools32 (from jsonschema) 09:45:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:27 INFO - Downloading functools32-3.2.3-2.tar.gz 09:45:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:45:28 INFO - warning: no files found matching '*.txt' 09:45:28 INFO - no previously-included directories found matching 'build' 09:45:28 INFO - no previously-included directories found matching 'dist' 09:45:28 INFO - no previously-included directories found matching '.git*' 09:45:28 INFO - Installing collected packages: jsonschema, functools32 09:45:28 INFO - Running setup.py install for functools32 09:45:28 INFO - warning: no files found matching '*.txt' 09:45:28 INFO - no previously-included directories found matching 'build' 09:45:28 INFO - no previously-included directories found matching 'dist' 09:45:28 INFO - no previously-included directories found matching '.git*' 09:45:28 INFO - Successfully installed jsonschema functools32 09:45:28 INFO - Cleaning up... 09:45:28 INFO - Return code: 0 09:45:28 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:45: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')]} 09:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45: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')]} 09:45:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:28 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2f835bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ee500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb6a0>, '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 0x14ec5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eca30>, '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': '6d15e502d8e29d5d2676d664000001c3-1453484691.765222-64653554', '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 09:45:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 09:45:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:45:28 INFO - Using env: {'DISPLAY': ':0', 09:45:28 INFO - 'HOME': '/home/cltbld', 09:45:28 INFO - 'LANG': 'en_US.UTF-8', 09:45:28 INFO - 'LANGUAGE': 'en_US:en', 09:45:28 INFO - 'LOGNAME': 'cltbld', 09:45:28 INFO - 'MAIL': '/var/mail/cltbld', 09:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:28 INFO - 'MOZ_NO_REMOTE': '1', 09:45:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:28 INFO - 'NO_EM_RESTART': '1', 09:45:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:45:28 INFO - 'PWD': '/builds/slave/test-pgo', 09:45:28 INFO - 'SHELL': '/bin/bash', 09:45:28 INFO - 'SHLVL': '1', 09:45:28 INFO - 'TERM': 'linux', 09:45:28 INFO - 'TMOUT': '86400', 09:45:28 INFO - 'USER': 'cltbld', 09:45:28 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453484691.765222-64653554', 09:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:28 INFO - '_': '/tools/buildbot/bin/python'} 09:45:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:28 INFO - Downloading/unpacking flake8 09:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:45:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:45:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:45:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:45:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:45:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:45:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:45:30 INFO - no previously-included directories found matching 'docs/_build' 09:45:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:45:31 INFO - Running setup.py install for pep8 09:45:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:45:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:45:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:45:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:45:31 INFO - no previously-included directories found matching 'docs/_build' 09:45:31 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:45:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:45:31 INFO - Cleaning up... 09:45:31 INFO - Return code: 0 09:45:31 INFO - Running post-action listener: _resource_record_post_action 09:45:31 INFO - Running post-action listener: _start_resource_monitoring 09:45:31 INFO - Starting resource monitoring. 09:45:31 INFO - ##### 09:45:31 INFO - ##### Running install step. 09:45:31 INFO - ##### 09:45:31 INFO - Running pre-action listener: _resource_record_pre_action 09:45:31 INFO - Running main action method: install 09:45:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:45:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:45:31 INFO - Reading from file tmpfile_stdout 09:45:31 INFO - Detecting whether we're running mozinstall >=1.0... 09:45:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:45:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:45:31 INFO - Reading from file tmpfile_stdout 09:45:31 INFO - Output received: 09:45:31 INFO - Usage: mozinstall [options] installer 09:45:31 INFO - Options: 09:45:31 INFO - -h, --help show this help message and exit 09:45:31 INFO - -d DEST, --destination=DEST 09:45:31 INFO - Directory to install application into. [default: 09:45:31 INFO - "/builds/slave/test-pgo"] 09:45:31 INFO - --app=APP Application being installed. [default: firefox] 09:45:31 INFO - mkdir: /builds/slave/test-pgo/build/application 09:45:31 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'] 09:45:31 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 09:45:46 INFO - Reading from file tmpfile_stdout 09:45:46 INFO - Output received: 09:45:46 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:45:46 INFO - Running post-action listener: _resource_record_post_action 09:45:46 INFO - ##### 09:45:46 INFO - ##### Running run-tests step. 09:45:46 INFO - ##### 09:45:46 INFO - Running pre-action listener: _resource_record_pre_action 09:45:46 INFO - Running main action method: run_tests 09:45:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:45:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:45:46 INFO - Python 2.7.3 09:45:46 INFO - Return code: 0 09:45:46 INFO - grabbing minidump binary from tooltool 09:45:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:46 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 0x14eb6a0>, '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 0x14ec5a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14eca30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:45:46 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 09:45:46 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 09:45:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:45:46 INFO - Return code: 0 09:45:46 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:45:46 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:45:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:45:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:45:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:45:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:45:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:45:47 INFO - Return code: 0 09:45:47 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/JrR3iT1URxuYJGrTHUu8rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 09:45:47 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/JrR3iT1URxuYJGrTHUu8rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost 09:45:47 INFO - Using env: {'DISPLAY': ':0', 09:45:47 INFO - 'HOME': '/home/cltbld', 09:45:47 INFO - 'LANG': 'en_US.UTF-8', 09:45:47 INFO - 'LANGUAGE': 'en_US:en', 09:45:47 INFO - 'LOGNAME': 'cltbld', 09:45:47 INFO - 'MAIL': '/var/mail/cltbld', 09:45:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:45:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:47 INFO - 'MOZ_NO_REMOTE': '1', 09:45:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:45:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:47 INFO - 'NO_EM_RESTART': '1', 09:45:47 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:45:47 INFO - 'PWD': '/builds/slave/test-pgo', 09:45:47 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:45:47 INFO - 'SHELL': '/bin/bash', 09:45:47 INFO - 'SHLVL': '1', 09:45:47 INFO - 'TERM': 'linux', 09:45:47 INFO - 'TMOUT': '86400', 09:45:47 INFO - 'USER': 'cltbld', 09:45:47 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453484691.765222-64653554', 09:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:47 INFO - '_': '/tools/buildbot/bin/python'} 09:45:47 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/JrR3iT1URxuYJGrTHUu8rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost'] with output_timeout 3600 09:45:47 INFO - mozversion INFO | application_buildid: 20160122071931 09:45:47 INFO - mozversion INFO | application_changeset: eff72cafd49d71ee7e530506a99043a8b08751b9 09:45:47 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 09:45:47 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:45:47 INFO - mozversion INFO | application_name: Firefox 09:45:47 INFO - mozversion INFO | application_remotingname: firefox-dev 09:45:47 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:45:47 INFO - mozversion INFO | application_vendor: Mozilla 09:45:47 INFO - mozversion INFO | application_version: 45.0a2 09:45:47 INFO - mozversion INFO | platform_buildid: 20160122071931 09:45:47 INFO - mozversion INFO | platform_changeset: eff72cafd49d71ee7e530506a99043a8b08751b9 09:45:47 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:45:47 INFO - mozversion INFO | platform_version: 45.0a2 09:45:47 INFO - 2016-01-22 09:45:47,411 DEBUG : using testdate: 1453484747 09:45:47 INFO - 2016-01-22 09:45:47,411 DEBUG : actual date: 1453484747 09:45:47 INFO - 2016-01-22 09:45:47,420 INFO : starting webserver on 'localhost:37508' 09:45:47 INFO - 2016-01-22 09:45:47,421 INFO : Starting test suite talos-linux64-ix-023.e 09:45:47 INFO - 2016-01-22 09:45:47,421 INFO : Starting test dromaeo_css 09:45:47 INFO - 2016-01-22 09:45:47,421 DEBUG : operating with platform_type : linux_ 09:45:47 INFO - 2016-01-22 09:45:47,422 INFO : Initialising browser for dromaeo_css test... 09:45:47 INFO - 2016-01-22 09:45:47,438 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCuvVH1/profile http://localhost:37508/getInfo.html 09:45:50 INFO - 2016-01-22 09:45:50,807 DEBUG : BROWSER_OUTPUT: 09:45:50 INFO - 2016-01-22 09:45:50,807 DEBUG : BROWSER_OUTPUT: (process:2603): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:45:51 INFO - 2016-01-22 09:45:51,622 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:45:51 INFO - 2016-01-22 09:45:51,622 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:45:51 INFO - 2016-01-22 09:45:51,622 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:45:51 INFO - 2016-01-22 09:45:51,622 DEBUG : BROWSER_OUTPUT: __metrics 09:45:52 INFO - 2016-01-22 09:45:52,602 INFO : Browser initialized. 09:45:52 INFO - 2016-01-22 09:45:52,602 INFO : Running cycle 1/1 for dromaeo_css test... 09:45:52 INFO - 2016-01-22 09:45:52,602 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCuvVH1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:45:53 INFO - 2016-01-22 09:45:53,845 DEBUG : BROWSER_OUTPUT: 09:45:53 INFO - 2016-01-22 09:45:53,845 DEBUG : BROWSER_OUTPUT: (process:2764): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:46:04 INFO - 2016-01-22 09:46:04,351 DEBUG : BROWSER_OUTPUT: RSS: Main: 135409664 09:46:04 INFO - 2016-01-22 09:46:04,351 DEBUG : BROWSER_OUTPUT: 09:46:53 INFO - 2016-01-22 09:46:53,977 DEBUG : BROWSER_OUTPUT: 1453484813972 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] 09:49:01 INFO - 2016-01-22 09:49:01,866 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37508/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37508/tests/dromaeo/cssquery-ext.html) 09:49:02 INFO - 2016-01-22 09:49:02,922 DEBUG : BROWSER_OUTPUT: RSS: Main: 142057472 09:49:02 INFO - 2016-01-22 09:49:02,923 DEBUG : BROWSER_OUTPUT: 09:52:04 INFO - 2016-01-22 09:52:04,763 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37508/tests/dromaeo/cssquery-ext.html (next: http://localhost:37508/tests/dromaeo/cssquery-jquery.html) 09:52:05 INFO - 2016-01-22 09:52:05,351 DEBUG : BROWSER_OUTPUT: RSS: Main: 139894784 09:52:05 INFO - 2016-01-22 09:52:05,351 DEBUG : BROWSER_OUTPUT: 09:55:06 INFO - 2016-01-22 09:55:06,962 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37508/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37508/tests/dromaeo/cssquery-mootools.html) 09:55:07 INFO - 2016-01-22 09:55:07,552 DEBUG : BROWSER_OUTPUT: RSS: Main: 137699328 09:55:07 INFO - 2016-01-22 09:55:07,552 DEBUG : BROWSER_OUTPUT: 09:58:09 INFO - 2016-01-22 09:58:09,099 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37508/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37508/tests/dromaeo/cssquery-prototype.html) 09:58:09 INFO - 2016-01-22 09:58:09,687 DEBUG : BROWSER_OUTPUT: RSS: Main: 139046912 09:58:09 INFO - 2016-01-22 09:58:09,687 DEBUG : BROWSER_OUTPUT: 10:01:11 INFO - 2016-01-22 10:01:11,967 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37508/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37508/tests/dromaeo/cssquery-yui.html) 10:01:12 INFO - 2016-01-22 10:01:12,580 DEBUG : BROWSER_OUTPUT: RSS: Main: 139513856 10:01:12 INFO - 2016-01-22 10:01:12,580 DEBUG : BROWSER_OUTPUT: 10:04:14 INFO - 2016-01-22 10:04:14,586 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37508/tests/dromaeo/cssquery-yui.html (next: http://localhost:37508/tests/dromaeo/cssquery-dojo.html) 10:04:14 INFO - 2016-01-22 10:04:14,836 DEBUG : BROWSER_OUTPUT: RSS: Main: 142409728 10:04:14 INFO - 2016-01-22 10:04:14,837 DEBUG : BROWSER_OUTPUT: 10:04:14 INFO - 2016-01-22 10:04:14,838 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:04:14 INFO - 2016-01-22 10:04:14,838 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:04:14 INFO - 2016-01-22 10:04:14,838 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:04:14 INFO - 2016-01-22 10:04:14,838 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:04:14 INFO - 2016-01-22 10:04:14,840 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3329.1510664780476;3381.6787405196496;3397.8301084945747;3415.5047518109873;3416.692497675209;5558.833235002951;5562.666240025591;5570.749316280767;5598.552115830734;5609.971950140249;5591.944080559193;5616.831495055155;5622.746976386063;5630.183623374608;5633.8309850704445;5066.74666266687;5109.770060347275;5145.485451454862;5159.071367153911;5166.974165129169;4981.9252711209365;5021.447640759514;5109.233614957768;5113.284140220372;5113.309703190059;5092.337996060507;5156.510131537517;5161.122609156434;5163.509466600667;5166.638335316529;5171.301874246985;5176.352955880515;5178.093833579109;5182.041322355339;5211.478852114796;4879;4973.229149481836;4991.725455099968;5051.989602079599;5070.543651071422;5392.703401312926;5454.8909021819345;5457.263269458612;5462.8361149165585;5479.369872464637;5998.4601385875485;6005.489533389624;6060.606060606091;6066.757329706807;6068.3021452533085;5804.9419505805245;5893.410658934115;5977.7608895644125;6023.367546407651;6054.878902421971;5583.05088135018;5707.1153971134545;5717.599768016241;5725.4274572543245;5731.197632331477;6165.414285642946;6183.227096612924;6185.567010309325;6194.132821405007;6201.844953876189;5690.2887139107615;5773.509251713652;5815.79644712433;5885.352611212763;5922.970385148133;5891.9705401473575;6015.368386319374;6025.758969641253;6030;6032.668203248863;5742.7415766290615;5914.319853216935;5976.043832986701;5980.192673989043;5987.251593550806;5815.73829177688;5886.8822623547285;5910.556708246899;5912.142739302777;5922.318933322636;4528.207563676344;4586.954130458719;4587.105514424655;4588.220002599566;4607.723536587815;4052.128792309609;4115.5678653741525;4143.19207754491;4153.418521407006;4161.542230354658;5689.317281926113;5714.485696287354;5727.169560413717;5754.88490230193;5756.48191662744;5923.496502797224;5999.5800293979;6002.939970600238;6003.249593800775;6012.759489620454;5536.307961504812;5627.5779316551425;5672.404397538199;5713.771449142071;5715.8856822864145;5270.815521456807;5289.814856480005;5298.735063246822;5300.9734951325;5308.708021058802;6230.376962303733;6261.96869015652;6279.905801412982;6285.088662143963;6292.622442653455;5811.418858114154;5879.441453061952;5939.970300148471;6078.966575682233;6144.324124346408;6140.692965351625;6198.837406399293;6225.346338634378;6228.190335256388;6243.188385509855;5922.73347699346;5932.2584676915385;5982.192404025401;5991.400859913973;6031.457168854824;5927.31835838884;5947.881042379215;6050.485708714633;6057.303410107894;6086.847828804315;5758.222639943721;5774.509166720875;5791.102379131242;5806.158107074535;5813.215215945793;5720.799772008127;5795.797147099831;5796.710164491843;5818.4763371296785;5822.184894114743;5699.5155411790465;5738.483536481736;5787.884242315046;5796.681182534832;5815.883682326415;5699.772009119589;5792.478676919098;5838.708064596668;5840.890230856124;5858.209141765807;5614.663120212637;5687.317521897398;5752.856178595569;5775.104858746901;5817.069268916953 10:04:14 INFO - 2016-01-22 10:04:14,843 DEBUG : BROWSER_OUTPUT: |1;ext.html;572.8625129968809;598.4285007817534;610.2524407600688;626.1421852062675;632.8607706304612;40144.59855401449;41025.179496410055;41098.7945060275;41131.58868411315;41188.79405602975;43815.12369752611;44501;44652.55347446525;44664.77667611666;44740.77629611847;8969.596368163415;9183.219426348769;9183.49490778007;9197.95401022994;9265.212456941133;8804.075572064938;8878.422902511316;8995.955020224923;8996.505192214425;9005.684801031965;8962.551872406353;9091.954540227289;9110.316726245524;9113.772155696095;9122.22461090808;8991.28069754418;9116.635334586608;9117.45295282282;9144.54277286133;9149.908500914973;8950.104989500998;9081.591328390172;9092.22716069135;9102.362834601581;9104.954475227647;40998.38502422466;41545.79227103845;41706.582934170576;41734.1653166938;41873.581264187276;3304.041827869939;3349.765516413852;3390.9152271193416;3447.7586568940183;3785.7728536287636;31385;31940.361192776014;32294.838525807456;32412;32949.51727172283;3782.9432558511644;3798.2593394288124;3799.183175617228;3826.7512611680154;3880.301545721769;276703;276774;277132;277785;278491.607541963;53071.203931941054;53739.19391209135;58653.706731466926;66425;67185.3281467179;59384.703076484344;60005;60232;60292.095618565756;60379;15047.623809404633;15067.623309417353;15156.621084472976;15173.393064277305;15238.847611523965;11772.764544709058;11799.292042477478;11861.881381186251;11924.642260732191;11958.103142264365;19368.322108726126;19407.708884366744;19511.121999510055;19651.213951442067;19652.017399129985;7247.13034435871;7410.851782964418;7469.477136600386;7551.886721699179;7599.582022988679;956.4834989105944;993.7217579077725;1054.852320675106;1098.4837126550508;1169.345166706647;29195;29199.85400072986;29257.414851703274;29366.853165734035;29569.85215073911;1035.8394448860438;1039.4750650921237;1074.403705943209;1089.1286970423787;1173.7359094203737;13597.116187447784;15924.442644507619;16345.836541634431;16614.750778738086;16778.58053548671;356719;394686.0797088046;491121;492776;495398;51649;52176.478235217925;52217.73891130596;52453.7377313111;52546.47453525492;1394.1426022995988;1408.253625578445;1408.802767612535;1417.461364681435;1418.453895250336;27701;27707.44585108327;27820.16539503818;28166.2958426041;28475.572866407434;45809.77095114503;46150.53849461462;46158.538414615425;46219.76890115528;46227.3065904005;263944;264003;264857;265243;265631;31590.842045789625;31874.884379046624;32029.839850800596;32278.515822263154;32296;43636.12727745491;43904.34143487914;44766;45016.54983450124;45192.32211516896;37462.8126859364;37519.624803752704;38153;41402.585974139874;42587;36167.63832361748;37999.810000949816;38014.80992595019;38076;38392.80803595964;37105;37403.25193496169;37564;37954.81022594869;38125;30607;30671.846640766653;30744.231394215323;30787.230319242197;32011.839940800146;25702.228933132035;25932.35169120787;26217.213483595522;26398.340041499116;27337.45325093527 10:04:14 INFO - 2016-01-22 10:04:14,843 DEBUG : BROWSER_OUTPUT: |2;jquery.html;378.443687778965;379.7265968502677;390.1553137457405;390.83584894344364;391.33082429046334;16172.75740863888;17232.310707571698;17828.910855445705;18502.259909603632;18521.259149634014;10598.576056957712;10676.412797296145;11717.945384915378;16370.672586548291;16656;4864.513548645143;4902.877428064291;4979.153543897528;5008.724520151391;5010.123228435027;5174.715390653512;5299.443558426367;5329.360476742796;5330.760115794798;5450.836474905739;5269.973650131744;5328.360596728398;5334.493223143795;6208.937910620881;6254.061890716406;6170.7531698732;6172.537059720539;6193.81418557444;6205.1623030890705;6219.782307619257;5379.462053794628;5396.055690254189;5413.052715774763;5478.096114141162;5539.723013849331;13908.304584770822;14004.22976736279;14059.367328470244;19818.108185131703;20407;2205.349421920537;2292.736335321426;2353.623420252751;2363.291012696184;2494.9521201095586;14744.115353078849;15088.17015064171;15395.615109622237;15942.521724348288;16063.839361606468;2035.18592562976;2046.6623007203793;2129.936101916945;2133.232036466871;2153.6984822124914;71611;77657.61171194108;79358.60320698417;79587.60206198989;79617.20382796155;16563.337466501205;16585.668286634198;16609.750853737205;16627.83372166287;16855.410060647817;25463.87268063685;25485.74514254871;25556.361090972874;25742.099026533982;25819.225423237334;9705.854412183822;9763.365381250196;9805.950970245103;9825;9840.261980351503;8232;8246.05170405399;8260.884780554668;8292.37807164465;8306.127856574973;4255.680823938217;4322.8703138905885;8333.708320208763;8400.243978042006;8447.704330348408;1986.8907210103582;2065.814076733101;2095.2876022152236;2100.222917520527;2105.3683894831797;919.9862002069974;932.4871320773548;999.4552968632113;1036.5542816588788;1092.8415379769888;17023.574410639587;17591.38430154964;17594.824051759573;17791.377301794375;17922.641547168983;898.5192921786812;993.3493561717087;1000.9099181073739;1029.341221618165;1043.9312827776207;9561.665341713146;9722.319437639439;9739.805203895883;9763.658271960589;9850.408975461496;628284;630071;633452;642016;650760;84262;89003;90339.54830225807;90558.99999999868;93027.53486232525;1180.2505409065134;1199.3403628004562;1200.789861774186;1203.524607779922;1214.1258294028285;15462.536123916301;15488.225588720745;15499.922500387425;15572.299246533707;15823.129727865078;35380.46929296011;41514.37728434136;41676.79161604172;42431;43272;52415.73792131015;52435.47564524306;53693.194602081785;53927.19109213287;55512.44487555234;14970.925145374204;15119.244037797846;15142.091474511564;15169.469068582546;15316.540503784905;11306.547738090714;11371.658850234506;11693.941530292293;11744.765104697688;11760.58837940668;10314.535845887103;10346.586136554453;10389.9480502597;10593.947030264799;10617.044465998097;9151.77120571991;10357.637482688371;10602.681919542427;10623.256372053882;10661.253712240068;10645.946770266099;10767.730806729895;10864.739480707229;10932.398718070583;11133.498992545517;15478.84521154819;15501.224938752792;15600.375984960474;15615.843841561438;15792.21038948025;16472.341106355612;16596.83403166001;16856;17012.74480882763;17513.824861751218 10:04:14 INFO - 2016-01-22 10:04:14,843 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1519.9164045977482;1667.3580671441493;1748.3880641775381;1765;1775.467359792062;6975;7122.679479423426;7652.732154374591;7908.762737117889;7928.841423171533;7246.891296630542;7354.521956072865;7374.00450939123;7431.331180193782;7454.440916931225;2271.772822717727;2311.7572654871246;2315.2822624986306;2317.2584772872688;2328.092044102801;2320.5242925200378;2344.0155134843408;2388.4984153327823;2390.055927908475;2393.5571919194917;2262.6945362376114;2264.671622614728;2270.0692715986447;2344.765523447659;2349.2717257650097;2241.1707668162885;2262.468319944812;2281.6235321171985;2287.7712228777154;2289.198780426854;2310.9075636974667;2340.8478448900937;2342.61346877765;2344.050659482912;2344.777246161612;7794.064712234568;7896.1314255432435;7903.960480197619;7920.5247685139075;7939.0870049944415;4576.153411618828;4636.53634636537;4645.024544845586;4674.953250467486;4690.366800481926;3105.534169874514;3113.050519591524;3192.170035790688;3199.1842080269616;3221.4523530999786;1041.8697662792151;1055.5197385189797;1056.5668076088766;1083.3229231730168;1090.934543927359;10549.73625659357;10625.415602141957;10639.308444951053;10654.573817047309;10669.146468282519;4160.396742472324;4163.375493675972;4174.83300667976;4276.850310239127;4290.120525292307;9194.770130746785;9263.814723705487;9269.490178040272;9287.90712092884;9320.440773553608;4576.748278844696;4628.5371462853445;4670.276107203389;4670.626349892001;4696.8590942271785;4141.151064031867;4241.4698162729655;4247.299195632748;4260.2970509866145;4264.6801489888385;3632.182758879231;3646.0520264731363;3652.5982141964364;3662.359087159736;3677.0807298175455;1113.1762495753085;1114.1866437500669;1115.074488174813;1117.3296022386503;1119.6193294279983;1283.2236496919415;1286.5046956921653;1297.8702129786946;1320.907536472457;1333.1001573937554;7194.136703595602;7257.0565826442225;7345.816354591178;7372.815679608053;7386.556806591621;482.1706664536991;482.5777444735856;489.26365819441514;506.7719526213219;532.4329588987715;5889.94110058894;5892.469677729025;5920.111983202554;5937.732802023919;5944.375840536768;8991.370604057784;9452.338336316529;9565.234781217487;9566.18687411564;9567.712968610953;9341.11259430353;9405.388649737744;9420.764480888032;9442.763930901783;9494.05059494045;7137.92862071383;7231.927680723231;7239.131304243525;7281.781546553612;7330.96334518324;7155.284471552803;7219.278072192738;7228.024216730674;7240.782776516713;7249.202587715242;8235.752927412188;8456.365772567206;8457.87313190315;8467.36494762883;8473.95763021181;8535.445196062235;8587.613557389808;8604.956975215084;8624.051354350891;8626.309895208493;5675;5862.94137058624;6300.149479820349;6649;6785.694643740945;7507.099148102045;7535.321821036133;7571.432142589438;7575.166731659623;7598.278163574451;6938.930610693828;7015.859682806417;7057.117860267466;7066.152061752623;7253.8186545336785;6787.762428314985;6856.760013399507;6894.8621027580175;6917.757878474229;7142.392896603639;7142.250063743232;7204.639768011473;7207.747728829466;7243.963780181276;7264.091988501437;6442.613443193423;6443.903341449975;6467.126937863328;6474.223093228843;6477.611343319416;6475.417212450714;6557.672116394257;6559.344065593594;6604;6611.33886611335 10:04:14 INFO - 2016-01-22 10:04:14,845 DEBUG : BROWSER_OUTPUT: |4;prototype.html;363.89992751993213;365.96706296433314;366.2674650698603;367.9245754620303;375.1502846053689;6276.089966954789;6294.842628934273;6322.525810564209;6349.619022858632;6402.679866006704;6215.782447614323;6252.155958945541;6261.968690156555;6358;6428.067930150125;4951.207806750912;4956.107900577895;4971.279164521142;4978.253262010691;4989.077020751154;4942.233953737158;4945.579625731817;4972.428170760355;4977.104121258172;4982.427020892589;4945.62907781916;4964.950350496485;4965.379327584052;4970.453250142481;4983.900321993576;4851.975740121295;4903.8528844134735;4939.740366206594;4956.430010548797;4970.900581988376;4387.078713470143;4391.363252328394;4396.780160991938;4402.811240964921;4403.669724770623;6053;6065.909011364833;6074.453299203049;6078.544109191828;6104.908426373608;5659.151127330892;5756.050251708463;5781.479666830005;5788.5369170466265;5796.739146738365;6713.227978782454;6734.46124310054;6758.695858686322;6765.8646827063185;6770.187577490733;4836.153673107192;4848.563629273347;4858.659893807435;4859.611231101503;4865.70805751656;6931.896021559681;6973.267806880306;7005.0893383859775;7025.016497690327;7025.297470252934;4903.068417000758;4982.377202849644;4986.950130498722;4998.375203099613;5004.224345226496;5046.041252162077;5066.594672426197;5072.087024335655;5074.5686616637995;5080.695158290514;5742.712864356766;5753.309602847685;5765.798197063166;5771.134329850556;5771.163181338682;6682.5322227444585;6712.228093769279;6840.589564626139;6848.486363522756;6851.623160726208;1782.777152855893;1785.8303461171167;1798.4334934495853;1804.8736588438683;1805.3500739733686;1207.1188032736152;1217.5677634439824;1238.4488902438509;1253.4484826676232;1255.5480027190204;6492.350764923564;6501.544891857619;6512.479001679949;6519.250286217051;6534.509911756637;6993.930060699429;7010.614416207158;7014.894776578355;7030.472714546429;7039.507234493536;6391.776287829904;6498.675066246668;6511.967440162864;6534.346565343522;6683.6324002180345;3857.324968130566;3859.9228015440094;3867.0525721198487;3897.7466464680274;3908.3746600544346;7312.41500679955;7315.012473316141;7345.449091318065;7364.77905662831;7369.1525474570035;7129;7307.926920730724;7324.743633972892;7350.52221605594;7364.742234021891;7324.26757324274;7369;7373.77878663641;7374.668139933716;7382.630868456556;7098.254683258184;7104.715811367488;7105.786826395217;7140.6072666003865;7144.071270734979;6919.515633905779;6939.653017349011;6996.090508233897;7021.297870212938;7054.259302773135;7355.521891077063;7357.668904899399;7366.300201480851;7373.520721153108;7375.336219740249;4821.4696383397095;4838.056578967208;4862.659613826998;4881.219004959189;4894;6924.099867017457;7152.070230870162;7162.856742865218;7169.103862017248;7172.354488096096;6956.652167391711;6982.685779140053;6983.1620205575655;6990.335918087773;7012.544184627983;6780.593164410151;6894.793156205322;6926.06498122747;6967.338102880219;6969.337912898267;6704.497162712913;6819.488538359544;6820;6830.8633827324165;6858.417034552119;6934.826629334105;6951.478639101986;7000.649967501707;7006.194287656985;7006.719731210695;6744.359285867835;6771.356721111487;6778.42383397397;6794.04883316346;6823.112995310777 10:04:14 INFO - 2016-01-22 10:04:14,846 DEBUG : BROWSER_OUTPUT: |5;yui.html;795.2842441802374;834.803821102041;916.5096673279796;943.8348289049419;957.0477375011865;14813.629659258524;15252.542423727306;15281.92359038206;15348.002379845302;15369.69260614787;13450.73098538031;13580.981426393011;14084;14100.435982560712;14132.576022719335;851.4040171879678;858.9570521473902;864.6498168241841;865.2645251536176;865.4288169807928;853.159637756809;863.6761214544546;865.7013330401033;866.5970323799432;870.8040690844573;890.0965519997176;891.1177933845479;891.9375643704943;893.1515060692336;897.6678628907281;887.6360692116266;889.9243564297043;890.6971629645886;895.3285036222866;900.8198360327928;659.6075335175562;661.147120214927;661.5534514202942;662.0697919423218;663.698017402081;13078.280694561796;13353.399097040656;13391.799123013163;13420.731585368238;15214.16322102284;12957;13043.804342934864;13278.734425311439;13369.598912032654;13471;10813.297135686234;10853.728656783565;11052.565863403672;11115.221934464591;11550.88449115515;3807.904802379963;3825.540935087807;3853.730238883279;3864.5555761087553;3886.261610294035;48673;50387.74806125946;50551.494485055046;50896.74551627255;52944.47055529473;10607.204459665556;10614.150867930546;10696.465176741132;10750.892491074988;10868.184886133571;18712.906435467736;18719.812801872078;18740.718889216674;18773;18826.05869706509;7860.213978602208;7882.132965373919;7954.721584744506;7965.6017199139815;7990.4406691532195;4543.863684089482;4550.408446901882;4564.566366195206;4565.086982603426;4612.07758448305;3320.833958302075;3348.631650518441;3350.447176215897;3352.966470335314;3363.4114030045134;600.099850224663;600.7266693654377;611.9816405507842;617.1853153836981;617.9258488981351;744.8100734312824;753.9773806785805;759.2900637903577;771.4985259581205;778.3461892010738;9223.76940576491;9307.11582399671;9774.511274436392;10011.449370284705;10190.898091018995;643.5012865029546;720.0962791696387;756.7956651704119;764.5351149288184;784.5684873319651;4316.136772645484;4496.325551167286;4622.9768851156205;4635.327877457749;4717.198076327033;58464.415355846744;58519.41480585225;58732.41267587355;58890.41109588849;63714.68142659257;52913.206301905506;53569.1964620531;54278.45721542813;54383.18425223625;54571;48918.266226006635;50221.74889125531;53405;53435.46564534383;53794;9006.279497640304;9049.185573298435;9143.222826059859;9170.312226582899;9227.953860230657;37579.436308454846;37707.62292377151;38249;38300;38811.02972425712;42471.3629295567;46413.76793116013;46834.531654683014;47979;48138.27792583184;11206.271592346471;12262.570810021964;12686.429110690226;12843.357832108544;12939.611811645666;13178.670533236362;13228.867711322764;13488.786009258822;13506.39221235027;13725.656858578615;11344.602938897098;11378.146639001943;11518.424078796193;12386.876131238932;12677.556285529961;11866.584669536525;11969.222000569935;12213.69465763363;12230.571929982409;12296.446659900146;10759.731006724582;10862.565497380016;12397.876021240032;12424.875751242733;13124.868751312364;10539.209559282932;10675;10972.506237219184;11045.447727613426;11273.379964101725;10126.746766358;10642.361458312525;11204.327740335606;11261.49323280438;11282.605108821152 10:04:14 INFO - 2016-01-22 10:04:14,846 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:04:14 INFO - 2016-01-22 10:04:14,846 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:04:14 INFO - 2016-01-22 10:04:14,846 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,295 10:04:14 INFO - 2016-01-22 10:04:14,846 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:04:14 INFO - 2016-01-22 10:04:14,846 DEBUG : BROWSER_OUTPUT: __startTimestamp1453485854837__endTimestamp 10:04:14 INFO - 2016-01-22 10:04:14,846 DEBUG : BROWSER_OUTPUT: 10:04:14 INFO - 2016-01-22 10:04:14,846 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:04:14 INFO - 2016-01-22 10:04:14,847 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:04:14 INFO - 2016-01-22 10:04:14,847 DEBUG : BROWSER_OUTPUT: 10:04:14 INFO - 2016-01-22 10:04:14,847 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5567.90 Median:5754.88 stddev:609.52 (10.6%) stddev-sans-first:585.54 10:04:14 INFO - 2016-01-22 10:04:14,847 DEBUG : BROWSER_OUTPUT: Values: 3329.2 3381.7 3397.8 3415.5 3416.7 5558.8 5562.7 5570.7 5598.6 5610.0 5591.9 5616.8 5622.7 5630.2 5633.8 5066.7 5109.8 5145.5 5159.1 5167.0 4981.9 5021.4 5109.2 5113.3 5113.3 5092.3 5156.5 5161.1 5163.5 5166.6 5171.3 5176.4 5178.1 5182.0 5211.5 4879.0 4973.2 4991.7 5052.0 5070.5 5392.7 5454.9 5457.3 5462.8 5479.4 5998.5 6005.5 6060.6 6066.8 6068.3 5804.9 5893.4 5977.8 6023.4 6054.9 5583.1 5707.1 5717.6 5725.4 5731.2 6165.4 6183.2 6185.6 6194.1 6201.8 5690.3 5773.5 5815.8 5885.4 5923.0 5892.0 6015.4 6025.8 6030.0 6032.7 5742.7 5914.3 5976.0 5980.2 5987.3 5815.7 5886.9 5910.6 5912.1 5922.3 4528.2 4587.0 4587.1 4588.2 4607.7 4052.1 4115.6 4143.2 4153.4 4161.5 5689.3 5714.5 5727.2 5754.9 5756.5 5923.5 5999.6 6002.9 6003.2 6012.8 5536.3 5627.6 5672.4 5713.8 5715.9 5270.8 5289.8 5298.7 5301.0 5308.7 6230.4 6262.0 6279.9 6285.1 6292.6 5811.4 5879.4 5940.0 6079.0 6144.3 6140.7 6198.8 6225.3 6228.2 6243.2 5922.7 5932.3 5982.2 5991.4 6031.5 5927.3 5947.9 6050.5 6057.3 6086.8 5758.2 5774.5 5791.1 5806.2 5813.2 5720.8 5795.8 5796.7 5818.5 5822.2 5699.5 5738.5 5787.9 5796.7 5815.9 5699.8 5792.5 5838.7 5840.9 5858.2 5614.7 5687.3 5752.9 5775.1 5817.1 10:04:14 INFO - 2016-01-22 10:04:14,847 DEBUG : BROWSER_OUTPUT: 10:04:14 INFO - 2016-01-22 10:04:14,847 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49946.82 Median:38045.40 stddev:90065.48 (236.7%) stddev-sans-first:90241.85 10:04:14 INFO - 2016-01-22 10:04:14,847 DEBUG : BROWSER_OUTPUT: Values: 572.9 598.4 610.3 626.1 632.9 40144.6 41025.2 41098.8 41131.6 41188.8 43815.1 44501.0 44652.6 44664.8 44740.8 8969.6 9183.2 9183.5 9198.0 9265.2 8804.1 8878.4 8996.0 8996.5 9005.7 8962.6 9092.0 9110.3 9113.8 9122.2 8991.3 9116.6 9117.5 9144.5 9149.9 8950.1 9081.6 9092.2 9102.4 9105.0 40998.4 41545.8 41706.6 41734.2 41873.6 3304.0 3349.8 3390.9 3447.8 3785.8 31385.0 31940.4 32294.8 32412.0 32949.5 3782.9 3798.3 3799.2 3826.8 3880.3 276703.0 276774.0 277132.0 277785.0 278491.6 53071.2 53739.2 58653.7 66425.0 67185.3 59384.7 60005.0 60232.0 60292.1 60379.0 15047.6 15067.6 15156.6 15173.4 15238.8 11772.8 11799.3 11861.9 11924.6 11958.1 19368.3 19407.7 19511.1 19651.2 19652.0 7247.1 7410.9 7469.5 7551.9 7599.6 956.5 993.7 1054.9 1098.5 1169.3 29195.0 29199.9 29257.4 29366.9 29569.9 1035.8 1039.5 1074.4 1089.1 1173.7 13597.1 15924.4 16345.8 16614.8 16778.6 356719.0 394686.1 491121.0 492776.0 495398.0 51649.0 52176.5 52217.7 52453.7 52546.5 1394.1 1408.3 1408.8 1417.5 1418.5 27701.0 27707.4 27820.2 28166.3 28475.6 45809.8 46150.5 46158.5 46219.8 46227.3 263944.0 264003.0 264857.0 265243.0 265631.0 31590.8 31874.9 32029.8 32278.5 32296.0 43636.1 43904.3 44766.0 45016.5 45192.3 37462.8 37519.6 38153.0 41402.6 42587.0 36167.6 37999.8 38014.8 38076.0 38392.8 37105.0 37403.3 37564.0 37954.8 38125.0 30607.0 30671.8 30744.2 30787.2 32011.8 25702.2 25932.4 26217.2 26398.3 27337.5 10:04:14 INFO - 2016-01-22 10:04:14,847 DEBUG : BROWSER_OUTPUT: 10:04:14 INFO - 2016-01-22 10:04:14,847 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:33320.67 Median:2323.18 stddev:104179.43 (4484.3%) stddev-sans-first:104442.31 10:04:14 INFO - 2016-01-22 10:04:14,849 DEBUG : BROWSER_OUTPUT: Values: 378.4 379.7 390.2 390.8 391.3 16172.8 17232.3 17828.9 18502.3 18521.3 10598.6 10676.4 11717.9 16370.7 16656.0 4864.5 4902.9 4979.2 5008.7 5010.1 5174.7 5299.4 5329.4 5330.8 5450.8 5270.0 5328.4 5334.5 6208.9 6254.1 6170.8 6172.5 6193.8 6205.2 6219.8 5379.5 5396.1 5413.1 5478.1 5539.7 13908.3 14004.2 14059.4 19818.1 20407.0 2205.3 2292.7 2353.6 2363.3 2495.0 14744.1 15088.2 15395.6 15942.5 16063.8 2035.2 2046.7 2129.9 2133.2 2153.7 71611.0 77657.6 79358.6 79587.6 79617.2 16563.3 16585.7 16609.8 16627.8 16855.4 25463.9 25485.7 25556.4 25742.1 25819.2 9705.9 9763.4 9806.0 9825.0 9840.3 8232.0 8246.1 8260.9 8292.4 8306.1 4255.7 4322.9 8333.7 8400.2 8447.7 1986.9 2065.8 2095.3 2100.2 2105.4 920.0 932.5 999.5 1036.6 1092.8 17023.6 17591.4 17594.8 17791.4 17922.6 898.5 993.3 1000.9 1029.3 1043.9 9561.7 9722.3 9739.8 9763.7 9850.4 628284.0 630071.0 633452.0 642016.0 650760.0 84262.0 89003.0 90339.5 90559.0 93027.5 1180.3 1199.3 1200.8 1203.5 1214.1 15462.5 15488.2 15499.9 15572.3 15823.1 35380.5 41514.4 41676.8 42431.0 43272.0 52415.7 52435.5 53693.2 53927.2 55512.4 14970.9 15119.2 15142.1 15169.5 15316.5 11306.5 11371.7 11693.9 11744.8 11760.6 10314.5 10346.6 10389.9 10593.9 10617.0 9151.8 10357.6 10602.7 10623.3 10661.3 10645.9 10767.7 10864.7 10932.4 11133.5 15478.8 15501.2 15600.4 15615.8 15792.2 16472.3 16596.8 16856.0 17012.7 17513.8 10:04:14 INFO - 2016-01-22 10:04:14,849 DEBUG : BROWSER_OUTPUT: 10:04:14 INFO - 2016-01-22 10:04:14,849 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5446.79 Median:5941.05 stddev:2831.37 (47.7%) stddev-sans-first:2823.93 10:04:14 INFO - 2016-01-22 10:04:14,849 DEBUG : BROWSER_OUTPUT: Values: 1519.9 1667.4 1748.4 1765.0 1775.5 6975.0 7122.7 7652.7 7908.8 7928.8 7246.9 7354.5 7374.0 7431.3 7454.4 2271.8 2311.8 2315.3 2317.3 2328.1 2320.5 2344.0 2388.5 2390.1 2393.6 2262.7 2264.7 2270.1 2344.8 2349.3 2241.2 2262.5 2281.6 2287.8 2289.2 2310.9 2340.8 2342.6 2344.1 2344.8 7794.1 7896.1 7904.0 7920.5 7939.1 4576.2 4636.5 4645.0 4675.0 4690.4 3105.5 3113.1 3192.2 3199.2 3221.5 1041.9 1055.5 1056.6 1083.3 1090.9 10549.7 10625.4 10639.3 10654.6 10669.1 4160.4 4163.4 4174.8 4276.9 4290.1 9194.8 9263.8 9269.5 9287.9 9320.4 4576.7 4628.5 4670.3 4670.6 4696.9 4141.2 4241.5 4247.3 4260.3 4264.7 3632.2 3646.1 3652.6 3662.4 3677.1 1113.2 1114.2 1115.1 1117.3 1119.6 1283.2 1286.5 1297.9 1320.9 1333.1 7194.1 7257.1 7345.8 7372.8 7386.6 482.2 482.6 489.3 506.8 532.4 5889.9 5892.5 5920.1 5937.7 5944.4 8991.4 9452.3 9565.2 9566.2 9567.7 9341.1 9405.4 9420.8 9442.8 9494.1 7137.9 7231.9 7239.1 7281.8 7331.0 7155.3 7219.3 7228.0 7240.8 7249.2 8235.8 8456.4 8457.9 8467.4 8474.0 8535.4 8587.6 8605.0 8624.1 8626.3 5675.0 5862.9 6300.1 6649.0 6785.7 7507.1 7535.3 7571.4 7575.2 7598.3 6938.9 7015.9 7057.1 7066.2 7253.8 6787.8 6856.8 6894.9 6917.8 7142.4 7142.3 7204.6 7207.7 7244.0 7264.1 6442.6 6443.9 6467.1 6474.2 6477.6 6475.4 6557.7 6559.3 6604.0 6611.3 10:04:14 INFO - 2016-01-22 10:04:14,849 DEBUG : BROWSER_OUTPUT: 10:04:14 INFO - 2016-01-22 10:04:14,849 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5753.02 Median:6460.21 stddev:1710.13 (26.5%) stddev-sans-first:1666.40 10:04:14 INFO - 2016-01-22 10:04:14,850 DEBUG : BROWSER_OUTPUT: Values: 363.9 366.0 366.3 367.9 375.2 6276.1 6294.8 6322.5 6349.6 6402.7 6215.8 6252.2 6262.0 6358.0 6428.1 4951.2 4956.1 4971.3 4978.3 4989.1 4942.2 4945.6 4972.4 4977.1 4982.4 4945.6 4965.0 4965.4 4970.5 4983.9 4852.0 4903.9 4939.7 4956.4 4970.9 4387.1 4391.4 4396.8 4402.8 4403.7 6053.0 6065.9 6074.5 6078.5 6104.9 5659.2 5756.1 5781.5 5788.5 5796.7 6713.2 6734.5 6758.7 6765.9 6770.2 4836.2 4848.6 4858.7 4859.6 4865.7 6931.9 6973.3 7005.1 7025.0 7025.3 4903.1 4982.4 4987.0 4998.4 5004.2 5046.0 5066.6 5072.1 5074.6 5080.7 5742.7 5753.3 5765.8 5771.1 5771.2 6682.5 6712.2 6840.6 6848.5 6851.6 1782.8 1785.8 1798.4 1804.9 1805.4 1207.1 1217.6 1238.4 1253.4 1255.5 6492.4 6501.5 6512.5 6519.3 6534.5 6993.9 7010.6 7014.9 7030.5 7039.5 6391.8 6498.7 6512.0 6534.3 6683.6 3857.3 3859.9 3867.1 3897.7 3908.4 7312.4 7315.0 7345.4 7364.8 7369.2 7129.0 7307.9 7324.7 7350.5 7364.7 7324.3 7369.0 7373.8 7374.7 7382.6 7098.3 7104.7 7105.8 7140.6 7144.1 6919.5 6939.7 6996.1 7021.3 7054.3 7355.5 7357.7 7366.3 7373.5 7375.3 4821.5 4838.1 4862.7 4881.2 4894.0 6924.1 7152.1 7162.9 7169.1 7172.4 6956.7 6982.7 6983.2 6990.3 7012.5 6780.6 6894.8 6926.1 6967.3 6969.3 6704.5 6819.5 6820.0 6830.9 6858.4 6934.8 6951.5 7000.6 7006.2 7006.7 6744.4 6771.4 6778.4 6794.0 6823.1 10:04:14 INFO - 2016-01-22 10:04:14,850 DEBUG : BROWSER_OUTPUT: 10:04:14 INFO - 2016-01-22 10:04:14,851 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14750.94 Median:4547.14 stddev:16893.09 (371.5%) stddev-sans-first:16907.97 10:04:14 INFO - 2016-01-22 10:04:14,851 DEBUG : BROWSER_OUTPUT: Values: 795.3 834.8 916.5 943.8 957.0 14813.6 15252.5 15281.9 15348.0 15369.7 13450.7 13581.0 14084.0 14100.4 14132.6 851.4 859.0 864.6 865.3 865.4 853.2 863.7 865.7 866.6 870.8 890.1 891.1 891.9 893.2 897.7 887.6 889.9 890.7 895.3 900.8 659.6 661.1 661.6 662.1 663.7 13078.3 13353.4 13391.8 13420.7 15214.2 12957.0 13043.8 13278.7 13369.6 13471.0 10813.3 10853.7 11052.6 11115.2 11550.9 3807.9 3825.5 3853.7 3864.6 3886.3 48673.0 50387.7 50551.5 50896.7 52944.5 10607.2 10614.2 10696.5 10750.9 10868.2 18712.9 18719.8 18740.7 18773.0 18826.1 7860.2 7882.1 7954.7 7965.6 7990.4 4543.9 4550.4 4564.6 4565.1 4612.1 3320.8 3348.6 3350.4 3353.0 3363.4 600.1 600.7 612.0 617.2 617.9 744.8 754.0 759.3 771.5 778.3 9223.8 9307.1 9774.5 10011.4 10190.9 643.5 720.1 756.8 764.5 784.6 4316.1 4496.3 4623.0 4635.3 4717.2 58464.4 58519.4 58732.4 58890.4 63714.7 52913.2 53569.2 54278.5 54383.2 54571.0 48918.3 50221.7 53405.0 53435.5 53794.0 9006.3 9049.2 9143.2 9170.3 9228.0 37579.4 37707.6 38249.0 38300.0 38811.0 42471.4 46413.8 46834.5 47979.0 48138.3 11206.3 12262.6 12686.4 12843.4 12939.6 13178.7 13228.9 13488.8 13506.4 13725.7 11344.6 11378.1 11518.4 12386.9 12677.6 11866.6 11969.2 12213.7 12230.6 12296.4 10759.7 10862.6 12397.9 12424.9 13124.9 10539.2 10675.0 10972.5 11045.4 11273.4 10126.7 10642.4 11204.3 11261.5 11282.6 10:04:14 INFO - 2016-01-22 10:04:14,851 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:04:14 INFO - 2016-01-22 10:04:14,851 DEBUG : BROWSER_OUTPUT: 10:04:15 INFO - 2016-01-22 10:04:15,498 INFO : Browser exited with error code: 0 10:04:15 INFO - 2016-01-22 10:04:15,519 INFO : Completed test dromaeo_css (00:18:28) 10:04:15 INFO - 2016-01-22 10:04:15,519 INFO : Starting test kraken 10:04:15 INFO - 2016-01-22 10:04:15,519 DEBUG : operating with platform_type : linux_ 10:04:15 INFO - 2016-01-22 10:04:15,519 INFO : Initialising browser for kraken test... 10:04:15 INFO - 2016-01-22 10:04:15,525 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNLigHC/profile http://localhost:37508/getInfo.html 10:04:19 INFO - 2016-01-22 10:04:19,042 DEBUG : BROWSER_OUTPUT: 10:04:19 INFO - 2016-01-22 10:04:19,042 DEBUG : BROWSER_OUTPUT: (process:3098): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:04:19 INFO - 2016-01-22 10:04:19,877 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:04:19 INFO - 2016-01-22 10:04:19,877 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:04:19 INFO - 2016-01-22 10:04:19,877 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:04:19 INFO - 2016-01-22 10:04:19,877 DEBUG : BROWSER_OUTPUT: __metrics 10:04:20 INFO - 2016-01-22 10:04:20,817 INFO : Browser initialized. 10:04:20 INFO - 2016-01-22 10:04:20,818 INFO : Running cycle 1/1 for kraken test... 10:04:20 INFO - 2016-01-22 10:04:20,818 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNLigHC/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:04:22 INFO - 2016-01-22 10:04:22,141 DEBUG : BROWSER_OUTPUT: 10:04:22 INFO - 2016-01-22 10:04:22,142 DEBUG : BROWSER_OUTPUT: (process:3212): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:04:32 INFO - 2016-01-22 10:04:32,643 DEBUG : BROWSER_OUTPUT: RSS: Main: 136335360 10:04:32 INFO - 2016-01-22 10:04:32,643 DEBUG : BROWSER_OUTPUT: 10:04:35 INFO - 2016-01-22 10:04:35,100 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37508/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37508/tests/kraken/driver.html?testName=audio-beat-detection) 10:04:35 INFO - 2016-01-22 10:04:35,702 DEBUG : BROWSER_OUTPUT: RSS: Main: 137682944 10:04:35 INFO - 2016-01-22 10:04:35,702 DEBUG : BROWSER_OUTPUT: 10:04:38 INFO - 2016-01-22 10:04:38,304 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37508/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37508/tests/kraken/driver.html?testName=audio-dft) 10:04:38 INFO - 2016-01-22 10:04:38,890 DEBUG : BROWSER_OUTPUT: RSS: Main: 138854400 10:04:38 INFO - 2016-01-22 10:04:38,890 DEBUG : BROWSER_OUTPUT: 10:04:41 INFO - 2016-01-22 10:04:41,717 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37508/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37508/tests/kraken/driver.html?testName=audio-fft) 10:04:42 INFO - 2016-01-22 10:04:42,298 DEBUG : BROWSER_OUTPUT: RSS: Main: 138235904 10:04:42 INFO - 2016-01-22 10:04:42,298 DEBUG : BROWSER_OUTPUT: 10:04:44 INFO - 2016-01-22 10:04:44,331 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37508/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37508/tests/kraken/driver.html?testName=audio-oscillator) 10:04:44 INFO - 2016-01-22 10:04:44,913 DEBUG : BROWSER_OUTPUT: RSS: Main: 138960896 10:04:44 INFO - 2016-01-22 10:04:44,913 DEBUG : BROWSER_OUTPUT: 10:04:47 INFO - 2016-01-22 10:04:47,134 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37508/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37508/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:04:47 INFO - 2016-01-22 10:04:47,715 DEBUG : BROWSER_OUTPUT: RSS: Main: 137846784 10:04:47 INFO - 2016-01-22 10:04:47,716 DEBUG : BROWSER_OUTPUT: 10:04:50 INFO - 2016-01-22 10:04:50,666 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37508/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37508/tests/kraken/driver.html?testName=imaging-darkroom) 10:04:51 INFO - 2016-01-22 10:04:51,250 DEBUG : BROWSER_OUTPUT: RSS: Main: 139689984 10:04:51 INFO - 2016-01-22 10:04:51,250 DEBUG : BROWSER_OUTPUT: 10:04:54 INFO - 2016-01-22 10:04:54,697 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37508/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37508/tests/kraken/driver.html?testName=imaging-desaturate) 10:04:55 INFO - 2016-01-22 10:04:55,283 DEBUG : BROWSER_OUTPUT: RSS: Main: 139886592 10:04:55 INFO - 2016-01-22 10:04:55,283 DEBUG : BROWSER_OUTPUT: 10:04:58 INFO - 2016-01-22 10:04:58,067 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37508/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37508/tests/kraken/driver.html?testName=json-parse-financial) 10:04:58 INFO - 2016-01-22 10:04:58,654 DEBUG : BROWSER_OUTPUT: RSS: Main: 139886592 10:04:58 INFO - 2016-01-22 10:04:58,654 DEBUG : BROWSER_OUTPUT: 10:05:00 INFO - 2016-01-22 10:05:00,236 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37508/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37508/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:05:00 INFO - 2016-01-22 10:05:00,818 DEBUG : BROWSER_OUTPUT: RSS: Main: 139014144 10:05:00 INFO - 2016-01-22 10:05:00,818 DEBUG : BROWSER_OUTPUT: 10:05:02 INFO - 2016-01-22 10:05:02,593 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37508/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37508/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:05:03 INFO - 2016-01-22 10:05:03,215 DEBUG : BROWSER_OUTPUT: RSS: Main: 138297344 10:05:03 INFO - 2016-01-22 10:05:03,215 DEBUG : BROWSER_OUTPUT: 10:05:05 INFO - 2016-01-22 10:05:05,260 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37508/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37508/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:05:05 INFO - 2016-01-22 10:05:05,853 DEBUG : BROWSER_OUTPUT: RSS: Main: 138399744 10:05:05 INFO - 2016-01-22 10:05:05,854 DEBUG : BROWSER_OUTPUT: 10:05:08 INFO - 2016-01-22 10:05:08,260 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37508/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37508/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:05:08 INFO - 2016-01-22 10:05:08,850 DEBUG : BROWSER_OUTPUT: RSS: Main: 138797056 10:05:08 INFO - 2016-01-22 10:05:08,850 DEBUG : BROWSER_OUTPUT: 10:05:11 INFO - 2016-01-22 10:05:11,358 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37508/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37508/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:05:11 INFO - 2016-01-22 10:05:11,944 DEBUG : BROWSER_OUTPUT: RSS: Main: 138141696 10:05:11 INFO - 2016-01-22 10:05:11,944 DEBUG : BROWSER_OUTPUT: 10:05:13 INFO - 2016-01-22 10:05:13,599 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37508/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37508/tests/kraken/driver.html?testName=ai-astar) 10:05:13 INFO - 2016-01-22 10:05:13,849 DEBUG : BROWSER_OUTPUT: RSS: Main: 138321920 10:05:13 INFO - 2016-01-22 10:05:13,849 DEBUG : BROWSER_OUTPUT: 10:05:13 INFO - 2016-01-22 10:05:13,849 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:05:13 INFO - 2016-01-22 10:05:13,850 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:05:13 INFO - 2016-01-22 10:05:13,850 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:05:13 INFO - 2016-01-22 10:05:13,850 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:05:13 INFO - 2016-01-22 10:05:13,850 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;105;111;111;112;122;110;109;110;111 10:05:13 INFO - 2016-01-22 10:05:13,850 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;129;146;161;123;144;144;130;164;125 10:05:13 INFO - 2016-01-22 10:05:13,851 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;163;161;165;163;161;160;162;164;161 10:05:13 INFO - 2016-01-22 10:05:13,851 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;74;72;158;71;71;71;72;151;72 10:05:13 INFO - 2016-01-22 10:05:13,851 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;143;91;92;93;140;92;93;132 10:05:13 INFO - 2016-01-22 10:05:13,851 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;110;109;109;109;109;110;110 10:05:13 INFO - 2016-01-22 10:05:13,852 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;146;148;148;145;149;147;147;146 10:05:13 INFO - 2016-01-22 10:05:13,852 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;96;96;96;96;96;96;96 10:05:13 INFO - 2016-01-22 10:05:13,852 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;62;60;59;59;62;60;59;60;61;60 10:05:13 INFO - 2016-01-22 10:05:13,852 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;64;65;64;64;63;64;63;64;65 10:05:13 INFO - 2016-01-22 10:05:13,852 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;79;81;81;81;82;82;82;89;85;82 10:05:13 INFO - 2016-01-22 10:05:13,853 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;114;117;121;119;116;114;123;122;114 10:05:13 INFO - 2016-01-22 10:05:13,853 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;143;146;138;145;145;142;142;142;145 10:05:13 INFO - 2016-01-22 10:05:13,853 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;67;65;65;69;69;65;65;69;67 10:05:13 INFO - 2016-01-22 10:05:13,853 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:05:13 INFO - 2016-01-22 10:05:13,854 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:05:13 INFO - 2016-01-22 10:05:13,854 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,719 10:05:13 INFO - 2016-01-22 10:05:13,854 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:05:13 INFO - 2016-01-22 10:05:13,854 DEBUG : BROWSER_OUTPUT: __startTimestamp1453485913848__endTimestamp 10:05:13 INFO - 2016-01-22 10:05:13,855 DEBUG : BROWSER_OUTPUT: 10:05:13 INFO - 2016-01-22 10:05:13,856 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:05:13 INFO - 2016-01-22 10:05:13,856 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:05:13 INFO - 2016-01-22 10:05:13,856 DEBUG : BROWSER_OUTPUT: 10:05:13 INFO - 2016-01-22 10:05:13,857 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.00 Median:111.00 stddev:4.32 (3.9%) stddev-sans-first:4.52 10:05:13 INFO - 2016-01-22 10:05:13,857 DEBUG : BROWSER_OUTPUT: Values: 109.0 105.0 111.0 111.0 112.0 122.0 110.0 109.0 110.0 111.0 10:05:13 INFO - 2016-01-22 10:05:13,857 DEBUG : BROWSER_OUTPUT: 10:05:13 INFO - 2016-01-22 10:05:13,857 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.80 Median:145.00 stddev:14.65 (10.1%) stddev-sans-first:15.07 10:05:13 INFO - 2016-01-22 10:05:13,857 DEBUG : BROWSER_OUTPUT: Values: 152.0 129.0 146.0 161.0 123.0 144.0 144.0 130.0 164.0 125.0 10:05:13 INFO - 2016-01-22 10:05:13,857 DEBUG : BROWSER_OUTPUT: 10:05:13 INFO - 2016-01-22 10:05:13,857 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.10 Median:162.50 stddev:1.60 (1.0%) stddev-sans-first:1.64 10:05:13 INFO - 2016-01-22 10:05:13,858 DEBUG : BROWSER_OUTPUT: Values: 161.0 163.0 161.0 165.0 163.0 161.0 160.0 162.0 164.0 161.0 10:05:13 INFO - 2016-01-22 10:05:13,858 DEBUG : BROWSER_OUTPUT: 10:05:13 INFO - 2016-01-22 10:05:13,858 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.50 Median:72.00 stddev:34.84 (48.4%) stddev-sans-first:36.50 10:05:13 INFO - 2016-01-22 10:05:13,859 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 72.0 158.0 71.0 71.0 71.0 72.0 151.0 72.0 10:05:13 INFO - 2016-01-22 10:05:13,859 DEBUG : BROWSER_OUTPUT: 10:05:13 INFO - 2016-01-22 10:05:13,859 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.00 Median:92.00 stddev:22.48 (24.4%) stddev-sans-first:23.27 10:05:13 INFO - 2016-01-22 10:05:13,859 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 143.0 91.0 92.0 93.0 140.0 92.0 93.0 132.0 10:05:13 INFO - 2016-01-22 10:05:13,859 DEBUG : BROWSER_OUTPUT: 10:05:13 INFO - 2016-01-22 10:05:13,859 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 10:05:13 INFO - 2016-01-22 10:05:13,859 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 110.0 109.0 109.0 109.0 109.0 110.0 110.0 10:05:13 INFO - 2016-01-22 10:05:13,859 DEBUG : BROWSER_OUTPUT: 10:05:13 INFO - 2016-01-22 10:05:13,859 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:1.20 (0.8%) stddev-sans-first:1.27 10:05:13 INFO - 2016-01-22 10:05:13,859 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 146.0 148.0 148.0 145.0 149.0 147.0 147.0 146.0 10:05:13 INFO - 2016-01-22 10:05:13,859 DEBUG : BROWSER_OUTPUT: 10:05:13 INFO - 2016-01-22 10:05:13,860 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:05:13 INFO - 2016-01-22 10:05:13,860 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 10:05:13 INFO - 2016-01-22 10:05:13,860 DEBUG : BROWSER_OUTPUT: 10:05:13 INFO - 2016-01-22 10:05:13,860 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.20 Median:60.00 stddev:1.14 (1.9%) stddev-sans-first:1.00 10:05:13 INFO - 2016-01-22 10:05:13,860 DEBUG : BROWSER_OUTPUT: Values: 62.0 60.0 59.0 59.0 62.0 60.0 59.0 60.0 61.0 60.0 10:05:13 INFO - 2016-01-22 10:05:13,860 DEBUG : BROWSER_OUTPUT: 10:05:13 INFO - 2016-01-22 10:05:13,860 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 10:05:13 INFO - 2016-01-22 10:05:13,860 DEBUG : BROWSER_OUTPUT: Values: 65.0 64.0 65.0 64.0 64.0 63.0 64.0 63.0 64.0 65.0 10:05:13 INFO - 2016-01-22 10:05:13,860 DEBUG : BROWSER_OUTPUT: 10:05:13 INFO - 2016-01-22 10:05:13,860 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.00 stddev:2.76 (3.4%) stddev-sans-first:2.64 10:05:13 INFO - 2016-01-22 10:05:13,860 DEBUG : BROWSER_OUTPUT: Values: 79.0 81.0 81.0 81.0 82.0 82.0 82.0 89.0 85.0 82.0 10:05:13 INFO - 2016-01-22 10:05:13,860 DEBUG : BROWSER_OUTPUT: 10:05:13 INFO - 2016-01-22 10:05:13,860 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:117.80 Median:118.50 stddev:3.39 (2.9%) stddev-sans-first:3.60 10:05:13 INFO - 2016-01-22 10:05:13,860 DEBUG : BROWSER_OUTPUT: Values: 118.0 114.0 117.0 121.0 119.0 116.0 114.0 123.0 122.0 114.0 10:05:13 INFO - 2016-01-22 10:05:13,860 DEBUG : BROWSER_OUTPUT: 10:05:13 INFO - 2016-01-22 10:05:13,860 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.10 Median:144.00 stddev:2.33 (1.6%) stddev-sans-first:2.47 10:05:13 INFO - 2016-01-22 10:05:13,861 DEBUG : BROWSER_OUTPUT: Values: 143.0 143.0 146.0 138.0 145.0 145.0 142.0 142.0 142.0 145.0 10:05:13 INFO - 2016-01-22 10:05:13,861 DEBUG : BROWSER_OUTPUT: 10:05:13 INFO - 2016-01-22 10:05:13,861 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.50 stddev:1.79 (2.7%) stddev-sans-first:1.86 10:05:13 INFO - 2016-01-22 10:05:13,861 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 65.0 65.0 69.0 69.0 65.0 65.0 69.0 67.0 10:05:13 INFO - 2016-01-22 10:05:13,861 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:05:13 INFO - 2016-01-22 10:05:13,861 DEBUG : BROWSER_OUTPUT: 10:05:14 INFO - 2016-01-22 10:05:14,654 INFO : Browser exited with error code: 0 10:05:14 INFO - 2016-01-22 10:05:14,724 INFO : Completed test kraken (00:00:59) 10:05:14 INFO - 2016-01-22 10:05:14,725 INFO : Starting test v8_7 10:05:14 INFO - 2016-01-22 10:05:14,725 DEBUG : operating with platform_type : linux_ 10:05:14 INFO - 2016-01-22 10:05:14,725 INFO : Initialising browser for v8_7 test... 10:05:14 INFO - 2016-01-22 10:05:14,731 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnocceG/profile http://localhost:37508/getInfo.html 10:05:18 INFO - 2016-01-22 10:05:18,101 DEBUG : BROWSER_OUTPUT: 10:05:18 INFO - 2016-01-22 10:05:18,101 DEBUG : BROWSER_OUTPUT: (process:3524): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:05:18 INFO - 2016-01-22 10:05:18,924 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:05:18 INFO - 2016-01-22 10:05:18,924 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:05:18 INFO - 2016-01-22 10:05:18,924 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:05:18 INFO - 2016-01-22 10:05:18,924 DEBUG : BROWSER_OUTPUT: __metrics 10:05:19 INFO - 2016-01-22 10:05:19,861 INFO : Browser initialized. 10:05:19 INFO - 2016-01-22 10:05:19,862 INFO : Running cycle 1/1 for v8_7 test... 10:05:19 INFO - 2016-01-22 10:05:19,862 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnocceG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:05:21 INFO - 2016-01-22 10:05:21,159 DEBUG : BROWSER_OUTPUT: 10:05:21 INFO - 2016-01-22 10:05:21,159 DEBUG : BROWSER_OUTPUT: (process:3636): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:05:31 INFO - 2016-01-22 10:05:31,663 DEBUG : BROWSER_OUTPUT: RSS: Main: 135831552 10:05:31 INFO - 2016-01-22 10:05:31,663 DEBUG : BROWSER_OUTPUT: 10:05:52 INFO - 2016-01-22 10:05:52,981 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37508/tests/v8_7/run.html (next: http://localhost:37508/tests/v8_7/run.html) 10:05:53 INFO - 2016-01-22 10:05:53,239 DEBUG : BROWSER_OUTPUT: RSS: Main: 135643136 10:05:53 INFO - 2016-01-22 10:05:53,239 DEBUG : BROWSER_OUTPUT: 10:05:53 INFO - 2016-01-22 10:05:53,239 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:05:53 INFO - 2016-01-22 10:05:53,239 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:05:53 INFO - 2016-01-22 10:05:53,239 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:05:53 INFO - 2016-01-22 10:05:53,239 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:05:53 INFO - 2016-01-22 10:05:53,239 DEBUG : BROWSER_OUTPUT: |0;Richards;165.50810989738497 10:05:53 INFO - 2016-01-22 10:05:53,239 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;172.74140611504578 10:05:53 INFO - 2016-01-22 10:05:53,239 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.6291446085261 10:05:53 INFO - 2016-01-22 10:05:53,239 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5181.347150259067 10:05:53 INFO - 2016-01-22 10:05:53,240 DEBUG : BROWSER_OUTPUT: |4;RayTrace;941.6195856873823 10:05:53 INFO - 2016-01-22 10:05:53,240 DEBUG : BROWSER_OUTPUT: |5;Earley;553.0973451327434 10:05:53 INFO - 2016-01-22 10:05:53,240 DEBUG : BROWSER_OUTPUT: |6;Boyer;10934.782608695652 10:05:53 INFO - 2016-01-22 10:05:53,240 DEBUG : BROWSER_OUTPUT: |7;RegExp;25871.79487179487 10:05:53 INFO - 2016-01-22 10:05:53,240 DEBUG : BROWSER_OUTPUT: |8;Splay;517.8663904712585 10:05:53 INFO - 2016-01-22 10:05:53,240 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 10:05:53 INFO - 2016-01-22 10:05:53,240 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:05:53 INFO - 2016-01-22 10:05:53,240 DEBUG : BROWSER_OUTPUT: __startTimestamp1453485953232__endTimestamp 10:05:53 INFO - 2016-01-22 10:05:53,240 DEBUG : BROWSER_OUTPUT: 10:05:53 INFO - 2016-01-22 10:05:53,240 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:05:53 INFO - 2016-01-22 10:05:53,240 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:05:53 INFO - 2016-01-22 10:05:53,240 DEBUG : BROWSER_OUTPUT: 10:05:53 INFO - 2016-01-22 10:05:53,240 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.51 Median:165.51 stddev:0.00 (0.0%) 10:05:53 INFO - 2016-01-22 10:05:53,240 DEBUG : BROWSER_OUTPUT: Values: 165.5 10:05:53 INFO - 2016-01-22 10:05:53,240 DEBUG : BROWSER_OUTPUT: 10:05:53 INFO - 2016-01-22 10:05:53,240 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:172.74 Median:172.74 stddev:0.00 (0.0%) 10:05:53 INFO - 2016-01-22 10:05:53,241 DEBUG : BROWSER_OUTPUT: Values: 172.7 10:05:53 INFO - 2016-01-22 10:05:53,241 DEBUG : BROWSER_OUTPUT: 10:05:53 INFO - 2016-01-22 10:05:53,241 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.63 Median:278.63 stddev:0.00 (0.0%) 10:05:53 INFO - 2016-01-22 10:05:53,241 DEBUG : BROWSER_OUTPUT: Values: 278.6 10:05:53 INFO - 2016-01-22 10:05:53,241 DEBUG : BROWSER_OUTPUT: 10:05:53 INFO - 2016-01-22 10:05:53,241 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 10:05:53 INFO - 2016-01-22 10:05:53,241 DEBUG : BROWSER_OUTPUT: Values: 5181.3 10:05:53 INFO - 2016-01-22 10:05:53,241 DEBUG : BROWSER_OUTPUT: 10:05:53 INFO - 2016-01-22 10:05:53,241 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:941.62 Median:941.62 stddev:0.00 (0.0%) 10:05:53 INFO - 2016-01-22 10:05:53,241 DEBUG : BROWSER_OUTPUT: Values: 941.6 10:05:53 INFO - 2016-01-22 10:05:53,241 DEBUG : BROWSER_OUTPUT: 10:05:53 INFO - 2016-01-22 10:05:53,241 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:553.10 Median:553.10 stddev:0.00 (0.0%) 10:05:53 INFO - 2016-01-22 10:05:53,241 DEBUG : BROWSER_OUTPUT: Values: 553.1 10:05:53 INFO - 2016-01-22 10:05:53,241 DEBUG : BROWSER_OUTPUT: 10:05:53 INFO - 2016-01-22 10:05:53,241 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10934.78 Median:10934.78 stddev:0.00 (0.0%) 10:05:53 INFO - 2016-01-22 10:05:53,241 DEBUG : BROWSER_OUTPUT: Values: 10934.8 10:05:53 INFO - 2016-01-22 10:05:53,242 DEBUG : BROWSER_OUTPUT: 10:05:53 INFO - 2016-01-22 10:05:53,242 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25871.79 Median:25871.79 stddev:0.00 (0.0%) 10:05:53 INFO - 2016-01-22 10:05:53,242 DEBUG : BROWSER_OUTPUT: Values: 25871.8 10:05:53 INFO - 2016-01-22 10:05:53,242 DEBUG : BROWSER_OUTPUT: 10:05:53 INFO - 2016-01-22 10:05:53,242 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:517.87 Median:517.87 stddev:0.00 (0.0%) 10:05:53 INFO - 2016-01-22 10:05:53,242 DEBUG : BROWSER_OUTPUT: Values: 517.9 10:05:53 INFO - 2016-01-22 10:05:53,242 DEBUG : BROWSER_OUTPUT: 10:05:53 INFO - 2016-01-22 10:05:53,242 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 10:05:53 INFO - 2016-01-22 10:05:53,242 DEBUG : BROWSER_OUTPUT: Values: 4840.6 10:05:53 INFO - 2016-01-22 10:05:53,243 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:05:53 INFO - 2016-01-22 10:05:53,243 DEBUG : BROWSER_OUTPUT: 10:05:54 INFO - 2016-01-22 10:05:54,070 INFO : Browser exited with error code: 0 10:05:54 INFO - 2016-01-22 10:05:54,084 INFO : Completed test v8_7 (00:00:39) 10:05:54 INFO - 2016-01-22 10:05:54,306 INFO : Completed test suite (00:20:06) 10:05:54 INFO - 2016-01-22 10:05:54,306 DEBUG : Working with test: dromaeo_css 10:05:54 INFO - 2016-01-22 10:05:54,306 DEBUG : Generating results file: dromaeo_css 10:05:54 INFO - 2016-01-22 10:05:54,307 DEBUG : Working with test: kraken 10:05:54 INFO - 2016-01-22 10:05:54,308 DEBUG : Generating results file: kraken 10:05:54 INFO - 2016-01-22 10:05:54,308 INFO : javascript benchmark 10:05:54 INFO - 2016-01-22 10:05:54,308 DEBUG : Working with test: v8_7 10:05:54 INFO - 2016-01-22 10:05:54,308 DEBUG : Generating results file: v8_7 10:05:54 INFO - 2016-01-22 10:05:54,309 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:05:54 INFO - 2016-01-22 10:05:54,363 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 10:05:54 INFO - 2016-01-22 10:05:54,363 DEBUG : process_Request line: dromaeo_css 7379.20 graph.html#tests=[[72,52,43]] 10:05:54 INFO - 2016-01-22 10:05:54,363 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:05:54 INFO - 2016-01-22 10:05:54,400 DEBUG : process_Request line: kraken 1496.20 graph.html#tests=[[232,52,43]] 10:05:54 INFO - 2016-01-22 10:05:54,400 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:05:54 INFO - 2016-01-22 10:05:54,430 DEBUG : process_Request line: v8_7 22970.08 graph.html#tests=[[230,52,43]] 10:05:54 INFO - 2016-01-22 10:05:54,432 INFO : javascript benchmark 10:05:54 INFO - 2016-01-22 10:05:54,435 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3329.1510664780476, 3381.6787405196496, 3397.8301084945747, 3415.5047518109873, 3416.692497675209, 5558.833235002951, 5562.666240025591, 5570.749316280767, 5598.552115830734, 5609.971950140249, 5591.944080559193, 5616.831495055155, 5622.746976386063, 5630.183623374608, 5633.8309850704445, 5066.74666266687, 5109.770060347275, 5145.485451454862, 5159.071367153911, 5166.974165129169, 4981.9252711209365, 5021.447640759514, 5109.233614957768, 5113.284140220372, 5113.309703190059, 5092.337996060507, 5156.510131537517, 5161.122609156434, 5163.509466600667, 5166.638335316529, 5171.301874246985, 5176.352955880515, 5178.093833579109, 5182.041322355339, 5211.478852114796, 4879.0, 4973.229149481836, 4991.725455099968, 5051.989602079599, 5070.543651071422, 5392.703401312926, 5454.8909021819345, 5457.263269458612, 5462.8361149165585, 5479.369872464637, 5998.4601385875485, 6005.489533389624, 6060.606060606091, 6066.757329706807, 6068.3021452533085, 5804.9419505805245, 5893.410658934115, 5977.7608895644125, 6023.367546407651, 6054.878902421971, 5583.05088135018, 5707.1153971134545, 5717.599768016241, 5725.4274572543245, 5731.197632331477, 6165.414285642946, 6183.227096612924, 6185.567010309325, 6194.132821405007, 6201.844953876189, 5690.2887139107615, 5773.509251713652, 5815.79644712433, 5885.352611212763, 5922.970385148133, 5891.9705401473575, 6015.368386319374, 6025.758969641253, 6030.0, 6032.668203248863, 5742.7415766290615, 5914.319853216935, 5976.043832986701, 5980.192673989043, 5987.251593550806, 5815.73829177688, 5886.8822623547285, 5910.556708246899, 5912.142739302777, 5922.318933322636, 4528.207563676344, 4586.954130458719, 4587.105514424655, 4588.220002599566, 4607.723536587815, 4052.128792309609, 4115.5678653741525, 4143.19207754491, 4153.418521407006, 4161.542230354658, 5689.317281926113, 5714.485696287354, 5727.169560413717, 5754.88490230193, 5756.48191662744, 5923.496502797224, 5999.5800293979, 6002.939970600238, 6003.249593800775, 6012.759489620454, 5536.307961504812, 5627.5779316551425, 5672.404397538199, 5713.771449142071, 5715.8856822864145, 5270.815521456807, 5289.814856480005, 5298.735063246822, 5300.9734951325, 5308.708021058802, 6230.376962303733, 6261.96869015652, 6279.905801412982, 6285.088662143963, 6292.622442653455, 5811.418858114154, 5879.441453061952, 5939.970300148471, 6078.966575682233, 6144.324124346408, 6140.692965351625, 6198.837406399293, 6225.346338634378, 6228.190335256388, 6243.188385509855, 5922.73347699346, 5932.2584676915385, 5982.192404025401, 5991.400859913973, 6031.457168854824, 5927.31835838884, 5947.881042379215, 6050.485708714633, 6057.303410107894, 6086.847828804315, 5758.222639943721, 5774.509166720875, 5791.102379131242, 5806.158107074535, 5813.215215945793, 5720.799772008127, 5795.797147099831, 5796.710164491843, 5818.4763371296785, 5822.184894114743, 5699.5155411790465, 5738.483536481736, 5787.884242315046, 5796.681182534832, 5815.883682326415, 5699.772009119589, 5792.478676919098, 5838.708064596668, 5840.890230856124, 5858.209141765807, 5614.663120212637, 5687.317521897398, 5752.856178595569, 5775.104858746901, 5817.069268916953], "unit": "ms", "name": "dojo.html", "value": 5528.988888879145}, {"lowerIsBetter": false, "replicates": [572.8625129968809, 598.4285007817534, 610.2524407600688, 626.1421852062675, 632.8607706304612, 40144.59855401449, 41025.179496410055, 41098.7945060275, 41131.58868411315, 41188.79405602975, 43815.12369752611, 44501.0, 44652.55347446525, 44664.77667611666, 44740.77629611847, 8969.596368163415, 9183.219426348769, 9183.49490778007, 9197.95401022994, 9265.212456941133, 8804.075572064938, 8878.422902511316, 8995.955020224923, 8996.505192214425, 9005.684801031965, 8962.551872406353, 9091.954540227289, 9110.316726245524, 9113.772155696095, 9122.22461090808, 8991.28069754418, 9116.635334586608, 9117.45295282282, 9144.54277286133, 9149.908500914973, 8950.104989500998, 9081.591328390172, 9092.22716069135, 9102.362834601581, 9104.954475227647, 40998.38502422466, 41545.79227103845, 41706.582934170576, 41734.1653166938, 41873.581264187276, 3304.041827869939, 3349.765516413852, 3390.9152271193416, 3447.7586568940183, 3785.7728536287636, 31385.0, 31940.361192776014, 32294.838525807456, 32412.0, 32949.51727172283, 3782.9432558511644, 3798.2593394288124, 3799.183175617228, 3826.7512611680154, 3880.301545721769, 276703.0, 276774.0, 277132.0, 277785.0, 278491.607541963, 53071.203931941054, 53739.19391209135, 58653.706731466926, 66425.0, 67185.3281467179, 59384.703076484344, 60005.0, 60232.0, 60292.095618565756, 60379.0, 15047.623809404633, 15067.623309417353, 15156.621084472976, 15173.393064277305, 15238.847611523965, 11772.764544709058, 11799.292042477478, 11861.881381186251, 11924.642260732191, 11958.103142264365, 19368.322108726126, 19407.708884366744, 19511.121999510055, 19651.213951442067, 19652.017399129985, 7247.13034435871, 7410.851782964418, 7469.477136600386, 7551.886721699179, 7599.582022988679, 956.4834989105944, 993.7217579077725, 1054.852320675106, 1098.4837126550508, 1169.345166706647, 29195.0, 29199.85400072986, 29257.414851703274, 29366.853165734035, 29569.85215073911, 1035.8394448860438, 1039.4750650921237, 1074.403705943209, 1089.1286970423787, 1173.7359094203737, 13597.116187447784, 15924.442644507619, 16345.836541634431, 16614.750778738086, 16778.58053548671, 356719.0, 394686.0797088046, 491121.0, 492776.0, 495398.0, 51649.0, 52176.478235217925, 52217.73891130596, 52453.7377313111, 52546.47453525492, 1394.1426022995988, 1408.253625578445, 1408.802767612535, 1417.461364681435, 1418.453895250336, 27701.0, 27707.44585108327, 27820.16539503818, 28166.2958426041, 28475.572866407434, 45809.77095114503, 46150.53849461462, 46158.538414615425, 46219.76890115528, 46227.3065904005, 263944.0, 264003.0, 264857.0, 265243.0, 265631.0, 31590.842045789625, 31874.884379046624, 32029.839850800596, 32278.515822263154, 32296.0, 43636.12727745491, 43904.34143487914, 44766.0, 45016.54983450124, 45192.32211516896, 37462.8126859364, 37519.624803752704, 38153.0, 41402.585974139874, 42587.0, 36167.63832361748, 37999.810000949816, 38014.80992595019, 38076.0, 38392.80803595964, 37105.0, 37403.25193496169, 37564.0, 37954.81022594869, 38125.0, 30607.0, 30671.846640766653, 30744.231394215323, 30787.230319242197, 32011.839940800146, 25702.228933132035, 25932.35169120787, 26217.213483595522, 26398.340041499116, 27337.45325093527], "unit": "ms", "name": "ext.html", "value": 19058.779195105173}, {"lowerIsBetter": false, "replicates": [378.443687778965, 379.7265968502677, 390.1553137457405, 390.83584894344364, 391.33082429046334, 16172.75740863888, 17232.310707571698, 17828.910855445705, 18502.259909603632, 18521.259149634014, 10598.576056957712, 10676.412797296145, 11717.945384915378, 16370.672586548291, 16656.0, 4864.513548645143, 4902.877428064291, 4979.153543897528, 5008.724520151391, 5010.123228435027, 5174.715390653512, 5299.443558426367, 5329.360476742796, 5330.760115794798, 5450.836474905739, 5269.973650131744, 5328.360596728398, 5334.493223143795, 6208.937910620881, 6254.061890716406, 6170.7531698732, 6172.537059720539, 6193.81418557444, 6205.1623030890705, 6219.782307619257, 5379.462053794628, 5396.055690254189, 5413.052715774763, 5478.096114141162, 5539.723013849331, 13908.304584770822, 14004.22976736279, 14059.367328470244, 19818.108185131703, 20407.0, 2205.349421920537, 2292.736335321426, 2353.623420252751, 2363.291012696184, 2494.9521201095586, 14744.115353078849, 15088.17015064171, 15395.615109622237, 15942.521724348288, 16063.839361606468, 2035.18592562976, 2046.6623007203793, 2129.936101916945, 2133.232036466871, 2153.6984822124914, 71611.0, 77657.61171194108, 79358.60320698417, 79587.60206198989, 79617.20382796155, 16563.337466501205, 16585.668286634198, 16609.750853737205, 16627.83372166287, 16855.410060647817, 25463.87268063685, 25485.74514254871, 25556.361090972874, 25742.099026533982, 25819.225423237334, 9705.854412183822, 9763.365381250196, 9805.950970245103, 9825.0, 9840.261980351503, 8232.0, 8246.05170405399, 8260.884780554668, 8292.37807164465, 8306.127856574973, 4255.680823938217, 4322.8703138905885, 8333.708320208763, 8400.243978042006, 8447.704330348408, 1986.8907210103582, 2065.814076733101, 2095.2876022152236, 2100.222917520527, 2105.3683894831797, 919.9862002069974, 932.4871320773548, 999.4552968632113, 1036.5542816588788, 1092.8415379769888, 17023.574410639587, 17591.38430154964, 17594.824051759573, 17791.377301794375, 17922.641547168983, 898.5192921786812, 993.3493561717087, 1000.9099181073739, 1029.341221618165, 1043.9312827776207, 9561.665341713146, 9722.319437639439, 9739.805203895883, 9763.658271960589, 9850.408975461496, 628284.0, 630071.0, 633452.0, 642016.0, 650760.0, 84262.0, 89003.0, 90339.54830225807, 90558.99999999868, 93027.53486232525, 1180.2505409065134, 1199.3403628004562, 1200.789861774186, 1203.524607779922, 1214.1258294028285, 15462.536123916301, 15488.225588720745, 15499.922500387425, 15572.299246533707, 15823.129727865078, 35380.46929296011, 41514.37728434136, 41676.79161604172, 42431.0, 43272.0, 52415.73792131015, 52435.47564524306, 53693.194602081785, 53927.19109213287, 55512.44487555234, 14970.925145374204, 15119.244037797846, 15142.091474511564, 15169.469068582546, 15316.540503784905, 11306.547738090714, 11371.658850234506, 11693.941530292293, 11744.765104697688, 11760.58837940668, 10314.535845887103, 10346.586136554453, 10389.9480502597, 10593.947030264799, 10617.044465998097, 9151.77120571991, 10357.637482688371, 10602.681919542427, 10623.256372053882, 10661.253712240068, 10645.946770266099, 10767.730806729895, 10864.739480707229, 10932.398718070583, 11133.498992545517, 15478.84521154819, 15501.224938752792, 15600.375984960474, 15615.843841561438, 15792.21038948025, 16472.341106355612, 16596.83403166001, 16856.0, 17012.74480882763, 17513.824861751218], "unit": "ms", "name": "jquery.html", "value": 9782.578950941723}, {"lowerIsBetter": false, "replicates": [1519.9164045977482, 1667.3580671441493, 1748.3880641775381, 1765.0, 1775.467359792062, 6975.0, 7122.679479423426, 7652.732154374591, 7908.762737117889, 7928.841423171533, 7246.891296630542, 7354.521956072865, 7374.00450939123, 7431.331180193782, 7454.440916931225, 2271.772822717727, 2311.7572654871246, 2315.2822624986306, 2317.2584772872688, 2328.092044102801, 2320.5242925200378, 2344.0155134843408, 2388.4984153327823, 2390.055927908475, 2393.5571919194917, 2262.6945362376114, 2264.671622614728, 2270.0692715986447, 2344.765523447659, 2349.2717257650097, 2241.1707668162885, 2262.468319944812, 2281.6235321171985, 2287.7712228777154, 2289.198780426854, 2310.9075636974667, 2340.8478448900937, 2342.61346877765, 2344.050659482912, 2344.777246161612, 7794.064712234568, 7896.1314255432435, 7903.960480197619, 7920.5247685139075, 7939.0870049944415, 4576.153411618828, 4636.53634636537, 4645.024544845586, 4674.953250467486, 4690.366800481926, 3105.534169874514, 3113.050519591524, 3192.170035790688, 3199.1842080269616, 3221.4523530999786, 1041.8697662792151, 1055.5197385189797, 1056.5668076088766, 1083.3229231730168, 1090.934543927359, 10549.73625659357, 10625.415602141957, 10639.308444951053, 10654.573817047309, 10669.146468282519, 4160.396742472324, 4163.375493675972, 4174.83300667976, 4276.850310239127, 4290.120525292307, 9194.770130746785, 9263.814723705487, 9269.490178040272, 9287.90712092884, 9320.440773553608, 4576.748278844696, 4628.5371462853445, 4670.276107203389, 4670.626349892001, 4696.8590942271785, 4141.151064031867, 4241.4698162729655, 4247.299195632748, 4260.2970509866145, 4264.6801489888385, 3632.182758879231, 3646.0520264731363, 3652.5982141964364, 3662.359087159736, 3677.0807298175455, 1113.1762495753085, 1114.1866437500669, 1115.074488174813, 1117.3296022386503, 1119.6193294279983, 1283.2236496919415, 1286.5046956921653, 1297.8702129786946, 1320.907536472457, 1333.1001573937554, 7194.136703595602, 7257.0565826442225, 7345.816354591178, 7372.815679608053, 7386.556806591621, 482.1706664536991, 482.5777444735856, 489.26365819441514, 506.7719526213219, 532.4329588987715, 5889.94110058894, 5892.469677729025, 5920.111983202554, 5937.732802023919, 5944.375840536768, 8991.370604057784, 9452.338336316529, 9565.234781217487, 9566.18687411564, 9567.712968610953, 9341.11259430353, 9405.388649737744, 9420.764480888032, 9442.763930901783, 9494.05059494045, 7137.92862071383, 7231.927680723231, 7239.131304243525, 7281.781546553612, 7330.96334518324, 7155.284471552803, 7219.278072192738, 7228.024216730674, 7240.782776516713, 7249.202587715242, 8235.752927412188, 8456.365772567206, 8457.87313190315, 8467.36494762883, 8473.95763021181, 8535.445196062235, 8587.613557389808, 8604.956975215084, 8624.051354350891, 8626.309895208493, 5675.0, 5862.94137058624, 6300.149479820349, 6649.0, 6785.694643740945, 7507.099148102045, 7535.321821036133, 7571.432142589438, 7575.166731659623, 7598.278163574451, 6938.930610693828, 7015.859682806417, 7057.117860267466, 7066.152061752623, 7253.8186545336785, 6787.762428314985, 6856.760013399507, 6894.8621027580175, 6917.757878474229, 7142.392896603639, 7142.250063743232, 7204.639768011473, 7207.747728829466, 7243.963780181276, 7264.091988501437, 6442.613443193423, 6443.903341449975, 6467.126937863328, 6474.223093228843, 6477.611343319416, 6475.417212450714, 6557.672116394257, 6559.344065593594, 6604.0, 6611.33886611335], "unit": "ms", "name": "mootools.html", "value": 4420.762726258887}, {"lowerIsBetter": false, "replicates": [363.89992751993213, 365.96706296433314, 366.2674650698603, 367.9245754620303, 375.1502846053689, 6276.089966954789, 6294.842628934273, 6322.525810564209, 6349.619022858632, 6402.679866006704, 6215.782447614323, 6252.155958945541, 6261.968690156555, 6358.0, 6428.067930150125, 4951.207806750912, 4956.107900577895, 4971.279164521142, 4978.253262010691, 4989.077020751154, 4942.233953737158, 4945.579625731817, 4972.428170760355, 4977.104121258172, 4982.427020892589, 4945.62907781916, 4964.950350496485, 4965.379327584052, 4970.453250142481, 4983.900321993576, 4851.975740121295, 4903.8528844134735, 4939.740366206594, 4956.430010548797, 4970.900581988376, 4387.078713470143, 4391.363252328394, 4396.780160991938, 4402.811240964921, 4403.669724770623, 6053.0, 6065.909011364833, 6074.453299203049, 6078.544109191828, 6104.908426373608, 5659.151127330892, 5756.050251708463, 5781.479666830005, 5788.5369170466265, 5796.739146738365, 6713.227978782454, 6734.46124310054, 6758.695858686322, 6765.8646827063185, 6770.187577490733, 4836.153673107192, 4848.563629273347, 4858.659893807435, 4859.611231101503, 4865.70805751656, 6931.896021559681, 6973.267806880306, 7005.0893383859775, 7025.016497690327, 7025.297470252934, 4903.068417000758, 4982.377202849644, 4986.950130498722, 4998.375203099613, 5004.224345226496, 5046.041252162077, 5066.594672426197, 5072.087024335655, 5074.5686616637995, 5080.695158290514, 5742.712864356766, 5753.309602847685, 5765.798197063166, 5771.134329850556, 5771.163181338682, 6682.5322227444585, 6712.228093769279, 6840.589564626139, 6848.486363522756, 6851.623160726208, 1782.777152855893, 1785.8303461171167, 1798.4334934495853, 1804.8736588438683, 1805.3500739733686, 1207.1188032736152, 1217.5677634439824, 1238.4488902438509, 1253.4484826676232, 1255.5480027190204, 6492.350764923564, 6501.544891857619, 6512.479001679949, 6519.250286217051, 6534.509911756637, 6993.930060699429, 7010.614416207158, 7014.894776578355, 7030.472714546429, 7039.507234493536, 6391.776287829904, 6498.675066246668, 6511.967440162864, 6534.346565343522, 6683.6324002180345, 3857.324968130566, 3859.9228015440094, 3867.0525721198487, 3897.7466464680274, 3908.3746600544346, 7312.41500679955, 7315.012473316141, 7345.449091318065, 7364.77905662831, 7369.1525474570035, 7129.0, 7307.926920730724, 7324.743633972892, 7350.52221605594, 7364.742234021891, 7324.26757324274, 7369.0, 7373.77878663641, 7374.668139933716, 7382.630868456556, 7098.254683258184, 7104.715811367488, 7105.786826395217, 7140.6072666003865, 7144.071270734979, 6919.515633905779, 6939.653017349011, 6996.090508233897, 7021.297870212938, 7054.259302773135, 7355.521891077063, 7357.668904899399, 7366.300201480851, 7373.520721153108, 7375.336219740249, 4821.4696383397095, 4838.056578967208, 4862.659613826998, 4881.219004959189, 4894.0, 6924.099867017457, 7152.070230870162, 7162.856742865218, 7169.103862017248, 7172.354488096096, 6956.652167391711, 6982.685779140053, 6983.1620205575655, 6990.335918087773, 7012.544184627983, 6780.593164410151, 6894.793156205322, 6926.06498122747, 6967.338102880219, 6969.337912898267, 6704.497162712913, 6819.488538359544, 6820.0, 6830.8633827324165, 6858.417034552119, 6934.826629334105, 6951.478639101986, 7000.649967501707, 7006.194287656985, 7006.719731210695, 6744.359285867835, 6771.356721111487, 6778.42383397397, 6794.04883316346, 6823.112995310777], "unit": "ms", "name": "prototype.html", "value": 5203.87267899089}, {"lowerIsBetter": false, "replicates": [795.2842441802374, 834.803821102041, 916.5096673279796, 943.8348289049419, 957.0477375011865, 14813.629659258524, 15252.542423727306, 15281.92359038206, 15348.002379845302, 15369.69260614787, 13450.73098538031, 13580.981426393011, 14084.0, 14100.435982560712, 14132.576022719335, 851.4040171879678, 858.9570521473902, 864.6498168241841, 865.2645251536176, 865.4288169807928, 853.159637756809, 863.6761214544546, 865.7013330401033, 866.5970323799432, 870.8040690844573, 890.0965519997176, 891.1177933845479, 891.9375643704943, 893.1515060692336, 897.6678628907281, 887.6360692116266, 889.9243564297043, 890.6971629645886, 895.3285036222866, 900.8198360327928, 659.6075335175562, 661.147120214927, 661.5534514202942, 662.0697919423218, 663.698017402081, 13078.280694561796, 13353.399097040656, 13391.799123013163, 13420.731585368238, 15214.16322102284, 12957.0, 13043.804342934864, 13278.734425311439, 13369.598912032654, 13471.0, 10813.297135686234, 10853.728656783565, 11052.565863403672, 11115.221934464591, 11550.88449115515, 3807.904802379963, 3825.540935087807, 3853.730238883279, 3864.5555761087553, 3886.261610294035, 48673.0, 50387.74806125946, 50551.494485055046, 50896.74551627255, 52944.47055529473, 10607.204459665556, 10614.150867930546, 10696.465176741132, 10750.892491074988, 10868.184886133571, 18712.906435467736, 18719.812801872078, 18740.718889216674, 18773.0, 18826.05869706509, 7860.213978602208, 7882.132965373919, 7954.721584744506, 7965.6017199139815, 7990.4406691532195, 4543.863684089482, 4550.408446901882, 4564.566366195206, 4565.086982603426, 4612.07758448305, 3320.833958302075, 3348.631650518441, 3350.447176215897, 3352.966470335314, 3363.4114030045134, 600.099850224663, 600.7266693654377, 611.9816405507842, 617.1853153836981, 617.9258488981351, 744.8100734312824, 753.9773806785805, 759.2900637903577, 771.4985259581205, 778.3461892010738, 9223.76940576491, 9307.11582399671, 9774.511274436392, 10011.449370284705, 10190.898091018995, 643.5012865029546, 720.0962791696387, 756.7956651704119, 764.5351149288184, 784.5684873319651, 4316.136772645484, 4496.325551167286, 4622.9768851156205, 4635.327877457749, 4717.198076327033, 58464.415355846744, 58519.41480585225, 58732.41267587355, 58890.41109588849, 63714.68142659257, 52913.206301905506, 53569.1964620531, 54278.45721542813, 54383.18425223625, 54571.0, 48918.266226006635, 50221.74889125531, 53405.0, 53435.46564534383, 53794.0, 9006.279497640304, 9049.185573298435, 9143.222826059859, 9170.312226582899, 9227.953860230657, 37579.436308454846, 37707.62292377151, 38249.0, 38300.0, 38811.02972425712, 42471.3629295567, 46413.76793116013, 46834.531654683014, 47979.0, 48138.27792583184, 11206.271592346471, 12262.570810021964, 12686.429110690226, 12843.357832108544, 12939.611811645666, 13178.670533236362, 13228.867711322764, 13488.786009258822, 13506.39221235027, 13725.656858578615, 11344.602938897098, 11378.146639001943, 11518.424078796193, 12386.876131238932, 12677.556285529961, 11866.584669536525, 11969.222000569935, 12213.69465763363, 12230.571929982409, 12296.446659900146, 10759.731006724582, 10862.565497380016, 12397.876021240032, 12424.875751242733, 13124.868751312364, 10539.209559282932, 10675.0, 10972.506237219184, 11045.447727613426, 11273.379964101725, 10126.746766358, 10642.361458312525, 11204.327740335606, 11261.49323280438, 11282.605108821152], "unit": "ms", "name": "yui.html", "value": 6807.667065431743}], "name": "dromaeo_css", "value": 7379.1964139603115}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 105.0, 111.0, 111.0, 112.0, 122.0, 110.0, 109.0, 110.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [152.0, 129.0, 146.0, 161.0, 123.0, 144.0, 144.0, 130.0, 164.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.8}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 161.0, 165.0, 163.0, 161.0, 160.0, 162.0, 164.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 162.1}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 72.0, 158.0, 71.0, 71.0, 71.0, 72.0, 151.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 88.5}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 143.0, 91.0, 92.0, 93.0, 140.0, 92.0, 93.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 106.0}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 148.0, 148.0, 145.0, 149.0, 147.0, 147.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [62.0, 60.0, 59.0, 59.0, 62.0, 60.0, 59.0, 60.0, 61.0, 60.0], "unit": "ms", "name": "json-parse-financial", "value": 60.2}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 65.0, 64.0, 64.0, 63.0, 64.0, 63.0, 64.0, 65.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.1}, {"lowerIsBetter": true, "replicates": [79.0, 81.0, 81.0, 81.0, 82.0, 82.0, 82.0, 89.0, 85.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.4}, {"lowerIsBetter": true, "replicates": [118.0, 114.0, 117.0, 121.0, 119.0, 116.0, 114.0, 123.0, 122.0, 114.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 117.8}, {"lowerIsBetter": true, "replicates": [143.0, 143.0, 146.0, 138.0, 145.0, 145.0, 142.0, 142.0, 142.0, 145.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.1}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 65.0, 65.0, 69.0, 69.0, 65.0, 65.0, 69.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.9}], "name": "kraken", "value": 1496.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.50810989738497], "unit": "score", "name": "Richards", "value": 213.294684}, {"lowerIsBetter": false, "replicates": [172.74140611504578], "unit": "score", "name": "DeltaBlue", "value": 382.7571020000001}, {"lowerIsBetter": false, "replicates": [278.6291446085261], "unit": "score", "name": "Encrypt", "value": 955.3236090000001}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [941.6195856873823], "unit": "score", "name": "RayTrace", "value": 785.8683179999997}, {"lowerIsBetter": false, "replicates": [553.0973451327434], "unit": "score", "name": "Earley", "value": 1204.9651040000003}, {"lowerIsBetter": false, "replicates": [10934.782608695652], "unit": "score", "name": "Boyer", "value": 60.94890258449304}, {"lowerIsBetter": false, "replicates": [25871.79487179487], "unit": "score", "name": "RegExp", "value": 35.21151139742318}, {"lowerIsBetter": false, "replicates": [517.8663904712585], "unit": "score", "name": "Splay", "value": 157.359121}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 22970.07769054332}]} 10:05:54 INFO - RETURN: dromaeo_css: 7379.20 10:05:54 INFO - RETURN: kraken: 1496.20 10:05:54 INFO - RETURN: v8_7: 22970.08 10:05:54 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "22970.08"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1496.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7379.20"}}} 10:05:54 INFO - Return code: 0 10:05:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:05:54 INFO - # TBPL SUCCESS # 10:05:54 INFO - Running post-action listener: _resource_record_post_action 10:05:54 INFO - Running post-run listener: _resource_record_post_run 10:05:55 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 266240; Write bytes: 507088896; Read time: 132; Write time: 379148 10:05:55 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 163799040; Read time: 0; Write time: 162584 10:05:55 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 266240; Write bytes: 276701184; Read time: 132; Write time: 166044 10:05:55 INFO - Running post-run listener: _upload_blobber_files 10:05:55 INFO - Blob upload gear active. 10:05:55 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:05:55 INFO - Copying logs to upload dir... 10:05:55 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1262.076056 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-01-22 10:05:55.370386) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-22 10:05:55.373668) ========= 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=6d15e502d8e29d5d2676d664000001c3-1453484691.765222-64653554 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/JrR3iT1URxuYJGrTHUu8rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009963 build_url: 'https://queue.taskcluster.net/v1/task/JrR3iT1URxuYJGrTHUu8rg/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-22 10:05:55.427680) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 10:05:55.428554) ========= 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=6d15e502d8e29d5d2676d664000001c3-1453484691.765222-64653554 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004566 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 10:05:55.479827) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 10:05:55.480161) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 10:05:55.483515) ========= ========= Total master_lag: 0.27 =========