builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1453749649.35 results: success (0) buildid: 20160125032407 builduid: 84a569e400f549d78ae6c3dedf0c2ad7 revision: 3bfa5bc61b626761d487b45c170b115259f69d6b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 11:20:49.346856) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 11:20:49.347292) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 11:20:49.347589) ========= 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=5cf47e208febbcd81da23b2e0000026f-1453749648.78248-2057032723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004238 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 11:20:49.374547) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 11:20:49.374834) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 11:20:49.389754) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:20:49.390130) ========= 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=5cf47e208febbcd81da23b2e0000026f-1453749648.78248-2057032723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.081530 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:20:49.482275) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 11:20:49.482581) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 11:20:49.482947) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:20:49.483213) ========= 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=5cf47e208febbcd81da23b2e0000026f-1453749648.78248-2057032723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-25 11:20:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.5M=0s 2016-01-25 11:20:49 (37.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.297746 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:20:49.792923) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:20:49.793264) ========= 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=5cf47e208febbcd81da23b2e0000026f-1453749648.78248-2057032723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.094216 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:20:49.899105) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:20:49.899475) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3bfa5bc61b626761d487b45c170b115259f69d6b --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3bfa5bc61b626761d487b45c170b115259f69d6b --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1453749648.78248-2057032723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-25 11:20:49,938 truncating revision to first 12 chars 2016-01-25 11:20:49,938 Setting DEBUG logging. 2016-01-25 11:20:49,938 attempt 1/10 2016-01-25 11:20:49,938 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3bfa5bc61b62?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-25 11:20:50,207 unpacking tar archive at: mozilla-aurora-3bfa5bc61b62/testing/mozharness/ program finished with exit code 0 elapsedTime=0.575664 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:20:50.487637) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 11:20:50.487983) ========= echo 3bfa5bc61b626761d487b45c170b115259f69d6b in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3bfa5bc61b626761d487b45c170b115259f69d6b'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1453749648.78248-2057032723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 3bfa5bc61b626761d487b45c170b115259f69d6b program finished with exit code 0 elapsedTime=0.004505 script_repo_revision: '3bfa5bc61b626761d487b45c170b115259f69d6b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 11:20:50.539109) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 11:20:50.539441) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 11:20:50.549466) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-01-25 11:20:50.549806) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=5cf47e208febbcd81da23b2e0000026f-1453749648.78248-2057032723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:20:50 INFO - MultiFileLogger online at 20160125 11:20:50 in /builds/slave/test-pgo 11:20:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:20:50 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:20:50 INFO - {'append_to_log': False, 11:20:50 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:20:50 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:20:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:20:50 INFO - 'branch': 'Mozilla-Aurora', 11:20:50 INFO - 'buildbot_json_path': 'buildprops.json', 11:20:50 INFO - 'config_files': ('talos/linux_config.py',), 11:20:50 INFO - 'default_actions': ('clobber', 11:20:50 INFO - 'read-buildbot-config', 11:20:50 INFO - 'download-and-extract', 11:20:50 INFO - 'populate-webroot', 11:20:50 INFO - 'create-virtualenv', 11:20:50 INFO - 'install', 11:20:50 INFO - 'run-tests'), 11:20:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:20:50 INFO - 'download_minidump_stackwalk': True, 11:20:50 INFO - 'download_symbols': 'ondemand', 11:20:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:20:50 INFO - 'tooltool.py': '/tools/tooltool.py', 11:20:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:20:50 INFO - '/tools/misc-python/virtualenv.py')}, 11:20:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:20:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:20:50 INFO - 'installer_path': 'installer.exe', 11:20:50 INFO - 'log_level': 'info', 11:20:50 INFO - 'log_name': 'talos', 11:20:50 INFO - 'log_to_console': True, 11:20:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:20:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:20:50 INFO - 'opt_config_files': (), 11:20:50 INFO - 'pip_index': False, 11:20:50 INFO - 'sps_profile': False, 11:20:50 INFO - 'sps_profile_interval': 0, 11:20:50 INFO - 'suite': 'dromaeojs', 11:20:50 INFO - 'system_bits': '32', 11:20:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:20:50 INFO - 'title': 'talos-linux64-ix-011', 11:20:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:20:50 INFO - 'use_talos_json': True, 11:20:50 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:20:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:20:50 INFO - 'work_dir': 'build'} 11:20:50 INFO - ##### 11:20:50 INFO - ##### Running clobber step. 11:20:50 INFO - ##### 11:20:50 INFO - Running pre-action listener: _resource_record_pre_action 11:20:50 INFO - Running main action method: clobber 11:20:50 INFO - rmtree: /builds/slave/test-pgo/build 11:20:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:20:52 INFO - Running post-action listener: _resource_record_post_action 11:20:52 INFO - ##### 11:20:52 INFO - ##### Running read-buildbot-config step. 11:20:52 INFO - ##### 11:20:52 INFO - Running pre-action listener: _resource_record_pre_action 11:20:52 INFO - Running main action method: read_buildbot_config 11:20:52 INFO - Using buildbot properties: 11:20:52 INFO - { 11:20:52 INFO - "properties": { 11:20:52 INFO - "buildnumber": 8, 11:20:52 INFO - "product": "firefox", 11:20:52 INFO - "script_repo_revision": "production", 11:20:52 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 11:20:52 INFO - "repository": "", 11:20:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 11:20:52 INFO - "buildid": "20160125032407", 11:20:52 INFO - "slavename": "talos-linux64-ix-011", 11:20:52 INFO - "pgo_build": "True", 11:20:52 INFO - "basedir": "/builds/slave/test-pgo", 11:20:52 INFO - "project": "", 11:20:52 INFO - "platform": "ubuntu64_hw", 11:20:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:20:52 INFO - "slavebuilddir": "test", 11:20:52 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:20:52 INFO - "branch": "mozilla-aurora", 11:20:52 INFO - "repo_path": "releases/mozilla-aurora", 11:20:52 INFO - "stage_platform": "linux64-pgo", 11:20:52 INFO - "builduid": "84a569e400f549d78ae6c3dedf0c2ad7", 11:20:52 INFO - "revision": "3bfa5bc61b626761d487b45c170b115259f69d6b" 11:20:52 INFO - }, 11:20:52 INFO - "sourcestamp": { 11:20:52 INFO - "repository": "", 11:20:52 INFO - "hasPatch": false, 11:20:52 INFO - "project": "", 11:20:52 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 11:20:52 INFO - "changes": [ 11:20:52 INFO - { 11:20:52 INFO - "category": null, 11:20:52 INFO - "files": [ 11:20:52 INFO - { 11:20:52 INFO - "url": null, 11:20:52 INFO - "name": "https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 11:20:52 INFO - } 11:20:52 INFO - ], 11:20:52 INFO - "repository": "", 11:20:52 INFO - "rev": "3bfa5bc61b626761d487b45c170b115259f69d6b", 11:20:52 INFO - "who": "cbook@mozilla.com", 11:20:52 INFO - "when": 1453730728, 11:20:52 INFO - "number": 7510949, 11:20:52 INFO - "comments": "Bug 1234675 - Ability to disable e10s for users with addons. r=Mossop, a=sylvestre", 11:20:52 INFO - "project": "", 11:20:52 INFO - "at": "Mon 25 Jan 2016 06:05:28", 11:20:52 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 11:20:52 INFO - "revlink": "", 11:20:52 INFO - "properties": [ 11:20:52 INFO - [ 11:20:52 INFO - "buildid", 11:20:52 INFO - "20160125032407", 11:20:52 INFO - "Change" 11:20:52 INFO - ], 11:20:52 INFO - [ 11:20:52 INFO - "builduid", 11:20:52 INFO - "84a569e400f549d78ae6c3dedf0c2ad7", 11:20:52 INFO - "Change" 11:20:52 INFO - ], 11:20:52 INFO - [ 11:20:52 INFO - "pgo_build", 11:20:52 INFO - "True", 11:20:52 INFO - "Change" 11:20:52 INFO - ] 11:20:52 INFO - ], 11:20:52 INFO - "revision": "3bfa5bc61b626761d487b45c170b115259f69d6b" 11:20:52 INFO - } 11:20:52 INFO - ], 11:20:52 INFO - "revision": "3bfa5bc61b626761d487b45c170b115259f69d6b" 11:20:52 INFO - } 11:20:52 INFO - } 11:20:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 11:20:52 INFO - Running post-action listener: _resource_record_post_action 11:20:52 INFO - ##### 11:20:52 INFO - ##### Running download-and-extract step. 11:20:52 INFO - ##### 11:20:52 INFO - Running pre-action listener: _resource_record_pre_action 11:20:52 INFO - Running main action method: download_and_extract 11:20:52 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:20:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:52 INFO - https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:20:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/test_packages.json 11:20:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/test_packages.json 11:20:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 11:20:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 11:20:53 INFO - Downloaded 1302 bytes. 11:20:53 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 11:20:53 INFO - Using the following test package requirements: 11:20:53 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 11:20:53 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:20:53 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:20:53 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:20:53 INFO - u'jsshell-linux-x86_64.zip'], 11:20:53 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:20:53 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:20:53 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 11:20:53 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:20:53 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:20:53 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:20:53 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:20:53 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:20:53 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:20:53 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 11:20:53 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:20:53 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:20:53 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:53 INFO - https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:20:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:20:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:20:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:20:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:20:54 INFO - Downloaded 21579043 bytes. 11:20:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 11:20:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:20:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:20:55 INFO - Return code: 0 11:20:55 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:55 INFO - https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:20:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:20:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:20:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:20:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:20:59 INFO - Downloaded 21579043 bytes. 11:20:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 11:20:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:20:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:21:03 INFO - Return code: 0 11:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:03 INFO - https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:21:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 11:21:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 11:21:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 11:21:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:21:04 INFO - Downloaded 11132038 bytes. 11:21:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 11:21:04 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 11:21:04 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 11:21:04 INFO - Return code: 0 11:21:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:04 INFO - https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:21:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:21:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:21:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:21:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:21:06 INFO - Downloaded 58070235 bytes. 11:21:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:21:06 INFO - mkdir: /builds/slave/test-pgo/properties 11:21:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:21:06 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:21:06 INFO - Contents: 11:21:06 INFO - build_url:https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:21:06 INFO - Running post-action listener: _resource_record_post_action 11:21:06 INFO - Running post-action listener: set_extra_try_arguments 11:21:06 INFO - ##### 11:21:06 INFO - ##### Running populate-webroot step. 11:21:06 INFO - ##### 11:21:06 INFO - Running pre-action listener: _resource_record_pre_action 11:21:06 INFO - Running main action method: populate_webroot 11:21:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:21:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:21:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:21:06 INFO - '--tppagecycles', 11:21:06 INFO - '7'], 11:21:06 INFO - 'tests': ['tsvgm']}}, 11:21:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:21:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:21:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:21:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:21:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:21:06 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:21:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:21:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:06 INFO - 'talos_options': ['--e10s'], 11:21:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:21:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:06 INFO - 'tests': ['damp', 'tps']}, 11:21:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:06 INFO - 'talos_options': ['--e10s'], 11:21:06 INFO - 'tests': ['damp', 'tps']}, 11:21:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:21:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:21:06 INFO - 'other': {'tests': ['a11yr', 11:21:06 INFO - 'ts_paint', 11:21:06 INFO - 'tpaint', 11:21:06 INFO - 'sessionrestore', 11:21:06 INFO - 'sessionrestore_no_auto_restore']}, 11:21:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:21:06 INFO - 'tests': ['a11yr', 11:21:06 INFO - 'ts_paint', 11:21:06 INFO - 'tpaint', 11:21:06 INFO - 'sessionrestore', 11:21:06 INFO - 'sessionrestore_no_auto_restore']}, 11:21:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:21:06 INFO - 'tests': ['a11yr', 11:21:06 INFO - 'ts_paint', 11:21:06 INFO - 'tpaint', 11:21:06 INFO - 'sessionrestore', 11:21:06 INFO - 'sessionrestore_no_auto_restore']}, 11:21:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:21:06 INFO - 'tests': ['a11yr', 11:21:06 INFO - 'ts_paint', 11:21:06 INFO - 'tpaint', 11:21:06 INFO - 'sessionrestore', 11:21:06 INFO - 'sessionrestore_no_auto_restore']}, 11:21:06 INFO - 'other_l64': {'tests': ['a11yr', 11:21:06 INFO - 'ts_paint', 11:21:06 INFO - 'tpaint', 11:21:06 INFO - 'sessionrestore', 11:21:06 INFO - 'sessionrestore_no_auto_restore']}, 11:21:06 INFO - 'other_nol64': {'tests': ['a11yr', 11:21:06 INFO - 'ts_paint', 11:21:06 INFO - 'tpaint', 11:21:06 INFO - 'sessionrestore', 11:21:06 INFO - 'sessionrestore_no_auto_restore']}, 11:21:06 INFO - 'svgr': {'tests': ['tsvgx', 11:21:06 INFO - 'tsvgr_opacity', 11:21:06 INFO - 'tart', 11:21:06 INFO - 'tscrollx', 11:21:06 INFO - 'cart']}, 11:21:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:21:06 INFO - 'tests': ['tsvgx', 11:21:06 INFO - 'tsvgr_opacity', 11:21:06 INFO - 'tart', 11:21:06 INFO - 'tscrollx', 11:21:06 INFO - 'cart']}, 11:21:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:06 INFO - 'tests': ['tp5o']}, 11:21:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:06 INFO - 'talos_options': ['--e10s'], 11:21:06 INFO - 'tests': ['tp5o']}, 11:21:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:06 INFO - 'talos_options': ['--xperf_path', 11:21:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:21:06 INFO - 'tests': ['tp5n']}, 11:21:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:21:06 INFO - 'talos_options': ['--e10s', 11:21:06 INFO - '--xperf_path', 11:21:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:21:06 INFO - 'tests': ['tp5n']}}, 11:21:06 INFO - 'talos.zip': {'path': '', 11:21:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:21:06 INFO - Running post-action listener: _resource_record_post_action 11:21:06 INFO - ##### 11:21:06 INFO - ##### Running create-virtualenv step. 11:21:06 INFO - ##### 11:21:06 INFO - Running pre-action listener: _resource_record_pre_action 11:21:06 INFO - Running main action method: create_virtualenv 11:21:06 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:21:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 11:21:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:21:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:21:06 INFO - Using real prefix '/usr' 11:21:06 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:21:07 INFO - Installing distribute.............................................................................................................................................................................................done. 11:21:12 INFO - Installing pip.................done. 11:21:12 INFO - Return code: 0 11:21:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:21:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdb8a8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1828600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b7350>, '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 0x18b8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b86e0>, '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': '5cf47e208febbcd81da23b2e0000026f-1453749648.78248-2057032723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 11:21:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:21:12 INFO - Using env: {'DISPLAY': ':0', 11:21:12 INFO - 'HOME': '/home/cltbld', 11:21:12 INFO - 'LANG': 'en_US.UTF-8', 11:21:12 INFO - 'LANGUAGE': 'en_US:en', 11:21:12 INFO - 'LOGNAME': 'cltbld', 11:21:12 INFO - 'MAIL': '/var/mail/cltbld', 11:21:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:12 INFO - 'MOZ_NO_REMOTE': '1', 11:21:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:12 INFO - 'NO_EM_RESTART': '1', 11:21:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:21:12 INFO - 'PWD': '/builds/slave/test-pgo', 11:21:12 INFO - 'SHELL': '/bin/bash', 11:21:12 INFO - 'SHLVL': '1', 11:21:12 INFO - 'TERM': 'linux', 11:21:12 INFO - 'TMOUT': '86400', 11:21:12 INFO - 'USER': 'cltbld', 11:21:12 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1453749648.78248-2057032723', 11:21:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:12 INFO - '_': '/tools/buildbot/bin/python'} 11:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:21:13 INFO - Cleaning up... 11:21:13 INFO - Return code: 0 11:21:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:21: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')]} 11:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21: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')]} 11:21:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21: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', '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 0x7ffdb8a8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1828600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b7350>, '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 0x18b8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b86e0>, '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': '5cf47e208febbcd81da23b2e0000026f-1453749648.78248-2057032723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 11:21: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 psutil>=0.7.1 11:21:13 INFO - Using env: {'DISPLAY': ':0', 11:21:13 INFO - 'HOME': '/home/cltbld', 11:21:13 INFO - 'LANG': 'en_US.UTF-8', 11:21:13 INFO - 'LANGUAGE': 'en_US:en', 11:21:13 INFO - 'LOGNAME': 'cltbld', 11:21:13 INFO - 'MAIL': '/var/mail/cltbld', 11:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:13 INFO - 'MOZ_NO_REMOTE': '1', 11:21:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:13 INFO - 'NO_EM_RESTART': '1', 11:21:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:21:13 INFO - 'PWD': '/builds/slave/test-pgo', 11:21:13 INFO - 'SHELL': '/bin/bash', 11:21:13 INFO - 'SHLVL': '1', 11:21:13 INFO - 'TERM': 'linux', 11:21:13 INFO - 'TMOUT': '86400', 11:21:13 INFO - 'USER': 'cltbld', 11:21:13 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1453749648.78248-2057032723', 11:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:13 INFO - '_': '/tools/buildbot/bin/python'} 11:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:13 INFO - Downloading/unpacking psutil>=0.7.1 11:21: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 11:21: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 11:21: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 11:21: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 11:21: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 11:21: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 11:21:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:21:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:21:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:21:15 INFO - Installing collected packages: psutil 11:21:15 INFO - Running setup.py install for psutil 11:21:15 INFO - building 'psutil._psutil_linux' extension 11:21:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:21:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:21:17 INFO - building 'psutil._psutil_posix' extension 11:21:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:21:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:21:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:21:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:21:17 INFO - Successfully installed psutil 11:21:17 INFO - Cleaning up... 11:21:17 INFO - Return code: 0 11:21:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:17 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffdb8a8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1828600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b7350>, '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 0x18b8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b86e0>, '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': '5cf47e208febbcd81da23b2e0000026f-1453749648.78248-2057032723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 11:21:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:21:17 INFO - Using env: {'DISPLAY': ':0', 11:21:17 INFO - 'HOME': '/home/cltbld', 11:21:17 INFO - 'LANG': 'en_US.UTF-8', 11:21:17 INFO - 'LANGUAGE': 'en_US:en', 11:21:17 INFO - 'LOGNAME': 'cltbld', 11:21:17 INFO - 'MAIL': '/var/mail/cltbld', 11:21:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:17 INFO - 'MOZ_NO_REMOTE': '1', 11:21:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:17 INFO - 'NO_EM_RESTART': '1', 11:21:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:21:17 INFO - 'PWD': '/builds/slave/test-pgo', 11:21:17 INFO - 'SHELL': '/bin/bash', 11:21:17 INFO - 'SHLVL': '1', 11:21:17 INFO - 'TERM': 'linux', 11:21:17 INFO - 'TMOUT': '86400', 11:21:17 INFO - 'USER': 'cltbld', 11:21:17 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1453749648.78248-2057032723', 11:21:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:17 INFO - '_': '/tools/buildbot/bin/python'} 11:21:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:21:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:21:20 INFO - Installing collected packages: mozsystemmonitor 11:21:20 INFO - Running setup.py install for mozsystemmonitor 11:21:20 INFO - Successfully installed mozsystemmonitor 11:21:20 INFO - Cleaning up... 11:21:21 INFO - Return code: 0 11:21:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:21:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffdb8a8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1828600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b7350>, '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 0x18b8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b86e0>, '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': '5cf47e208febbcd81da23b2e0000026f-1453749648.78248-2057032723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 11:21:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:21:21 INFO - Using env: {'DISPLAY': ':0', 11:21:21 INFO - 'HOME': '/home/cltbld', 11:21:21 INFO - 'LANG': 'en_US.UTF-8', 11:21:21 INFO - 'LANGUAGE': 'en_US:en', 11:21:21 INFO - 'LOGNAME': 'cltbld', 11:21:21 INFO - 'MAIL': '/var/mail/cltbld', 11:21:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:21 INFO - 'MOZ_NO_REMOTE': '1', 11:21:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:21 INFO - 'NO_EM_RESTART': '1', 11:21:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:21:21 INFO - 'PWD': '/builds/slave/test-pgo', 11:21:21 INFO - 'SHELL': '/bin/bash', 11:21:21 INFO - 'SHLVL': '1', 11:21:21 INFO - 'TERM': 'linux', 11:21:21 INFO - 'TMOUT': '86400', 11:21:21 INFO - 'USER': 'cltbld', 11:21:21 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1453749648.78248-2057032723', 11:21:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:21 INFO - '_': '/tools/buildbot/bin/python'} 11:21:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:21 INFO - Downloading/unpacking blobuploader==1.2.4 11:21:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:22 INFO - Downloading blobuploader-1.2.4.tar.gz 11:21:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:21:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:21:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:23 INFO - Downloading docopt-0.6.1.tar.gz 11:21:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:21:23 INFO - Installing collected packages: blobuploader, requests, docopt 11:21:23 INFO - Running setup.py install for blobuploader 11:21:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:21:23 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:21:23 INFO - Running setup.py install for requests 11:21:24 INFO - Running setup.py install for docopt 11:21:24 INFO - Successfully installed blobuploader requests docopt 11:21:24 INFO - Cleaning up... 11:21:24 INFO - Return code: 0 11:21:24 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:24 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 0x7ffdb8a8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1828600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b7350>, '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 0x18b8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b86e0>, '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': '5cf47e208febbcd81da23b2e0000026f-1453749648.78248-2057032723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 11:21:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:21:24 INFO - Using env: {'DISPLAY': ':0', 11:21:24 INFO - 'HOME': '/home/cltbld', 11:21:24 INFO - 'LANG': 'en_US.UTF-8', 11:21:24 INFO - 'LANGUAGE': 'en_US:en', 11:21:24 INFO - 'LOGNAME': 'cltbld', 11:21:24 INFO - 'MAIL': '/var/mail/cltbld', 11:21:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:24 INFO - 'MOZ_NO_REMOTE': '1', 11:21:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:24 INFO - 'NO_EM_RESTART': '1', 11:21:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:21:24 INFO - 'PWD': '/builds/slave/test-pgo', 11:21:24 INFO - 'SHELL': '/bin/bash', 11:21:24 INFO - 'SHLVL': '1', 11:21:24 INFO - 'TERM': 'linux', 11:21:24 INFO - 'TMOUT': '86400', 11:21:24 INFO - 'USER': 'cltbld', 11:21:24 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1453749648.78248-2057032723', 11:21:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:24 INFO - '_': '/tools/buildbot/bin/python'} 11:21:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:21:24 INFO - Running setup.py (path:/tmp/pip-a3sr16-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:21:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:21:24 INFO - Running setup.py (path:/tmp/pip-01VT3w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:21:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:21:24 INFO - Running setup.py (path:/tmp/pip-HQsoUn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:21:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:21:24 INFO - Running setup.py (path:/tmp/pip-bZl_j4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:21:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:21:24 INFO - Running setup.py (path:/tmp/pip-0wk1rJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:21:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:21:24 INFO - Running setup.py (path:/tmp/pip-p45Rzc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:21:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:21:24 INFO - Running setup.py (path:/tmp/pip-g5Zaa4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:21:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:21:25 INFO - Running setup.py (path:/tmp/pip-GkIUd5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:21:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:21:25 INFO - Running setup.py (path:/tmp/pip-NqHHaE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:21:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:21:25 INFO - Running setup.py (path:/tmp/pip-Qznnyc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:21:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:21:25 INFO - Running setup.py (path:/tmp/pip-eb7QWn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:21:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:21:25 INFO - Running setup.py (path:/tmp/pip-0gWTQM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:21:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:21:25 INFO - Running setup.py (path:/tmp/pip-LOaVoY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:21:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:21:25 INFO - Running setup.py (path:/tmp/pip-Mf5gjZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:21:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:21:25 INFO - Running setup.py (path:/tmp/pip-ZtRU3P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:21:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:21:25 INFO - Running setup.py (path:/tmp/pip-1nA1wr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:21:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:21:25 INFO - Running setup.py (path:/tmp/pip-ePUtHl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:21:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:21:25 INFO - Running setup.py install for manifestparser 11:21:25 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:21:25 INFO - Running setup.py install for mozcrash 11:21:25 INFO - Running setup.py install for mozdebug 11:21:26 INFO - Running setup.py install for mozdevice 11:21:26 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:21:26 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:21:26 INFO - Running setup.py install for mozfile 11:21:26 INFO - Running setup.py install for mozhttpd 11:21:26 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:21:26 INFO - Running setup.py install for mozinfo 11:21:26 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:21:26 INFO - Running setup.py install for mozInstall 11:21:26 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:21:26 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:21:26 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:21:26 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:21:26 INFO - Running setup.py install for mozleak 11:21:26 INFO - Running setup.py install for mozlog 11:21:26 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:21:26 INFO - Running setup.py install for moznetwork 11:21:26 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:21:26 INFO - Running setup.py install for mozprocess 11:21:26 INFO - Running setup.py install for mozprofile 11:21:27 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:21:27 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:21:27 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:21:27 INFO - Running setup.py install for mozrunner 11:21:27 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:21:27 INFO - Running setup.py install for mozscreenshot 11:21:27 INFO - Running setup.py install for moztest 11:21:27 INFO - Running setup.py install for mozversion 11:21:27 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:21:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:21:27 INFO - Cleaning up... 11:21:27 INFO - Return code: 0 11:21:27 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:21:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:27 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 0x7ffdb8a8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1828600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b7350>, '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 0x18b8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b86e0>, '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': '5cf47e208febbcd81da23b2e0000026f-1453749648.78248-2057032723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 11:21:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:21:27 INFO - Using env: {'DISPLAY': ':0', 11:21:27 INFO - 'HOME': '/home/cltbld', 11:21:27 INFO - 'LANG': 'en_US.UTF-8', 11:21:27 INFO - 'LANGUAGE': 'en_US:en', 11:21:27 INFO - 'LOGNAME': 'cltbld', 11:21:27 INFO - 'MAIL': '/var/mail/cltbld', 11:21:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:27 INFO - 'MOZ_NO_REMOTE': '1', 11:21:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:27 INFO - 'NO_EM_RESTART': '1', 11:21:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:21:27 INFO - 'PWD': '/builds/slave/test-pgo', 11:21:27 INFO - 'SHELL': '/bin/bash', 11:21:27 INFO - 'SHLVL': '1', 11:21:27 INFO - 'TERM': 'linux', 11:21:27 INFO - 'TMOUT': '86400', 11:21:27 INFO - 'USER': 'cltbld', 11:21:27 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1453749648.78248-2057032723', 11:21:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:27 INFO - '_': '/tools/buildbot/bin/python'} 11:21:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:21:27 INFO - Running setup.py (path:/tmp/pip-bqmUrH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:21:27 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 11:21:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:21:27 INFO - Running setup.py (path:/tmp/pip-MHifxg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:21:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 11:21:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:21:27 INFO - Running setup.py (path:/tmp/pip-9HEts1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:21:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 11:21:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:21:27 INFO - Running setup.py (path:/tmp/pip-D6gFA9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:21:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:21:28 INFO - Running setup.py (path:/tmp/pip-y0RfjL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 11:21:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:21:28 INFO - Running setup.py (path:/tmp/pip-pkBUkf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 11:21:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:21:28 INFO - Running setup.py (path:/tmp/pip-PYnkXq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 11:21:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:21:28 INFO - Running setup.py (path:/tmp/pip-rlZ0Kb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 11:21:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:21:28 INFO - Running setup.py (path:/tmp/pip-2jUgTP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 11:21:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:21:28 INFO - Running setup.py (path:/tmp/pip-t3QnTf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:21:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:21:28 INFO - Running setup.py (path:/tmp/pip-d9pyHC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 11:21:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:21:28 INFO - Running setup.py (path:/tmp/pip-zRQEsm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 11:21:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:21:28 INFO - Running setup.py (path:/tmp/pip-_Gf26x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 11:21:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:21:28 INFO - Running setup.py (path:/tmp/pip-v5XPF1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 11:21:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:21:28 INFO - Running setup.py (path:/tmp/pip-nwFhKg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 11:21:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:21:28 INFO - Running setup.py (path:/tmp/pip-NfKwQJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 11:21:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:21:28 INFO - Running setup.py (path:/tmp/pip-Duubyu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 11:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 11:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 11:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 11:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:21:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:21: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 11:21: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 11:21: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 11:21: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 11:21: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 11:21: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 11:21:30 INFO - Downloading blessings-1.6.tar.gz 11:21:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:21:30 INFO - Installing collected packages: blessings 11:21:30 INFO - Running setup.py install for blessings 11:21:30 INFO - Successfully installed blessings 11:21:30 INFO - Cleaning up... 11:21:31 INFO - Return code: 0 11:21:31 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:21:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:21:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:21:31 INFO - Reading from file tmpfile_stdout 11:21:31 INFO - Current package versions: 11:21:31 INFO - argparse == 1.2.1 11:21:31 INFO - blessings == 1.6 11:21:31 INFO - blobuploader == 1.2.4 11:21:31 INFO - docopt == 0.6.1 11:21:31 INFO - manifestparser == 1.1 11:21:31 INFO - mozInstall == 1.12 11:21:31 INFO - mozcrash == 0.16 11:21:31 INFO - mozdebug == 0.1 11:21:31 INFO - mozdevice == 0.47 11:21:31 INFO - mozfile == 1.2 11:21:31 INFO - mozhttpd == 0.7 11:21:31 INFO - mozinfo == 0.9 11:21:31 INFO - mozleak == 0.1 11:21:31 INFO - mozlog == 3.1 11:21:31 INFO - moznetwork == 0.27 11:21:31 INFO - mozprocess == 0.22 11:21:31 INFO - mozprofile == 0.27 11:21:31 INFO - mozrunner == 6.11 11:21:31 INFO - mozscreenshot == 0.1 11:21:31 INFO - mozsystemmonitor == 0.0 11:21:31 INFO - moztest == 0.7 11:21:31 INFO - mozversion == 1.4 11:21:31 INFO - psutil == 3.1.1 11:21:31 INFO - requests == 1.2.3 11:21:31 INFO - wsgiref == 0.1.2 11:21:31 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:31 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 0x7ffdb8a8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1828600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b7350>, '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 0x18b8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b86e0>, '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': '5cf47e208febbcd81da23b2e0000026f-1453749648.78248-2057032723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 11:21:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:21:31 INFO - Using env: {'DISPLAY': ':0', 11:21:31 INFO - 'HOME': '/home/cltbld', 11:21:31 INFO - 'LANG': 'en_US.UTF-8', 11:21:31 INFO - 'LANGUAGE': 'en_US:en', 11:21:31 INFO - 'LOGNAME': 'cltbld', 11:21:31 INFO - 'MAIL': '/var/mail/cltbld', 11:21:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:31 INFO - 'MOZ_NO_REMOTE': '1', 11:21:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:31 INFO - 'NO_EM_RESTART': '1', 11:21:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:21:31 INFO - 'PWD': '/builds/slave/test-pgo', 11:21:31 INFO - 'SHELL': '/bin/bash', 11:21:31 INFO - 'SHLVL': '1', 11:21:31 INFO - 'TERM': 'linux', 11:21:31 INFO - 'TMOUT': '86400', 11:21:31 INFO - 'USER': 'cltbld', 11:21:31 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1453749648.78248-2057032723', 11:21:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:31 INFO - '_': '/tools/buildbot/bin/python'} 11:21:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 11:21:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 11:21:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 11:21:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 11:21:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 11:21:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 11:21:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 11:21:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 11:21:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 11:21:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 11:21:31 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 11:21:31 INFO - Cleaning up... 11:21:31 INFO - Return code: 0 11:21:31 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:31 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 0x7ffdb8a8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1828600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b7350>, '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 0x18b8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b86e0>, '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': '5cf47e208febbcd81da23b2e0000026f-1453749648.78248-2057032723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 11:21:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:21:31 INFO - Using env: {'DISPLAY': ':0', 11:21:31 INFO - 'HOME': '/home/cltbld', 11:21:31 INFO - 'LANG': 'en_US.UTF-8', 11:21:31 INFO - 'LANGUAGE': 'en_US:en', 11:21:31 INFO - 'LOGNAME': 'cltbld', 11:21:31 INFO - 'MAIL': '/var/mail/cltbld', 11:21:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:31 INFO - 'MOZ_NO_REMOTE': '1', 11:21:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:31 INFO - 'NO_EM_RESTART': '1', 11:21:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:21:31 INFO - 'PWD': '/builds/slave/test-pgo', 11:21:31 INFO - 'SHELL': '/bin/bash', 11:21:31 INFO - 'SHLVL': '1', 11:21:31 INFO - 'TERM': 'linux', 11:21:31 INFO - 'TMOUT': '86400', 11:21:31 INFO - 'USER': 'cltbld', 11:21:31 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1453749648.78248-2057032723', 11:21:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:31 INFO - '_': '/tools/buildbot/bin/python'} 11:21:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:31 INFO - Downloading/unpacking jsonschema 11:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:21:33 INFO - Downloading/unpacking functools32 (from jsonschema) 11:21:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:33 INFO - Downloading functools32-3.2.3-2.tar.gz 11:21:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:21:33 INFO - warning: no files found matching '*.txt' 11:21:33 INFO - no previously-included directories found matching 'build' 11:21:33 INFO - no previously-included directories found matching 'dist' 11:21:33 INFO - no previously-included directories found matching '.git*' 11:21:33 INFO - Installing collected packages: jsonschema, functools32 11:21:33 INFO - Running setup.py install for functools32 11:21:33 INFO - warning: no files found matching '*.txt' 11:21:33 INFO - no previously-included directories found matching 'build' 11:21:33 INFO - no previously-included directories found matching 'dist' 11:21:33 INFO - no previously-included directories found matching '.git*' 11:21:33 INFO - Successfully installed jsonschema functools32 11:21:33 INFO - Cleaning up... 11:21:33 INFO - Return code: 0 11:21:33 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:21:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:33 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 0x7ffdb8a8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1828600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b7350>, '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 0x18b8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b86e0>, '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': '5cf47e208febbcd81da23b2e0000026f-1453749648.78248-2057032723', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 11:21:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:21:33 INFO - Using env: {'DISPLAY': ':0', 11:21:33 INFO - 'HOME': '/home/cltbld', 11:21:33 INFO - 'LANG': 'en_US.UTF-8', 11:21:33 INFO - 'LANGUAGE': 'en_US:en', 11:21:33 INFO - 'LOGNAME': 'cltbld', 11:21:33 INFO - 'MAIL': '/var/mail/cltbld', 11:21:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:33 INFO - 'MOZ_NO_REMOTE': '1', 11:21:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:33 INFO - 'NO_EM_RESTART': '1', 11:21:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:21:33 INFO - 'PWD': '/builds/slave/test-pgo', 11:21:33 INFO - 'SHELL': '/bin/bash', 11:21:33 INFO - 'SHLVL': '1', 11:21:33 INFO - 'TERM': 'linux', 11:21:33 INFO - 'TMOUT': '86400', 11:21:33 INFO - 'USER': 'cltbld', 11:21:33 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1453749648.78248-2057032723', 11:21:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:33 INFO - '_': '/tools/buildbot/bin/python'} 11:21:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:34 INFO - Downloading/unpacking flake8 11:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:21:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:21:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:21:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:21:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:21:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:21:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:21:36 INFO - no previously-included directories found matching 'docs/_build' 11:21:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:21:36 INFO - Running setup.py install for pep8 11:21:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:21:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:21:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:21:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:21:36 INFO - no previously-included directories found matching 'docs/_build' 11:21:36 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:21:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:21:36 INFO - Cleaning up... 11:21:36 INFO - Return code: 0 11:21:36 INFO - Running post-action listener: _resource_record_post_action 11:21:36 INFO - Running post-action listener: _start_resource_monitoring 11:21:36 INFO - Starting resource monitoring. 11:21:36 INFO - ##### 11:21:36 INFO - ##### Running install step. 11:21:36 INFO - ##### 11:21:36 INFO - Running pre-action listener: _resource_record_pre_action 11:21:36 INFO - Running main action method: install 11:21:36 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:21:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:21:37 INFO - Reading from file tmpfile_stdout 11:21:37 INFO - Detecting whether we're running mozinstall >=1.0... 11:21:37 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:21:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:21:37 INFO - Reading from file tmpfile_stdout 11:21:37 INFO - Output received: 11:21:37 INFO - Usage: mozinstall [options] installer 11:21:37 INFO - Options: 11:21:37 INFO - -h, --help show this help message and exit 11:21:37 INFO - -d DEST, --destination=DEST 11:21:37 INFO - Directory to install application into. [default: 11:21:37 INFO - "/builds/slave/test-pgo"] 11:21:37 INFO - --app=APP Application being installed. [default: firefox] 11:21:37 INFO - mkdir: /builds/slave/test-pgo/build/application 11:21:37 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 11:21:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 11:21:51 INFO - Reading from file tmpfile_stdout 11:21:51 INFO - Output received: 11:21:51 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:21:51 INFO - Running post-action listener: _resource_record_post_action 11:21:51 INFO - ##### 11:21:51 INFO - ##### Running run-tests step. 11:21:51 INFO - ##### 11:21:51 INFO - Running pre-action listener: _resource_record_pre_action 11:21:51 INFO - Running main action method: run_tests 11:21:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:21:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:21:51 INFO - Python 2.7.3 11:21:51 INFO - Return code: 0 11:21:51 INFO - grabbing minidump binary from tooltool 11:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:21:51 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 0x18b7350>, '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 0x18b8250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b86e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:21:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 11:21:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:21:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:21:51 INFO - Return code: 0 11:21:51 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:21:51 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:21:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:21:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:21:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:21:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:21:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:21:52 INFO - Return code: 0 11:21:52 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 11:21:52 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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost 11:21:52 INFO - Using env: {'DISPLAY': ':0', 11:21:52 INFO - 'HOME': '/home/cltbld', 11:21:52 INFO - 'LANG': 'en_US.UTF-8', 11:21:52 INFO - 'LANGUAGE': 'en_US:en', 11:21:52 INFO - 'LOGNAME': 'cltbld', 11:21:52 INFO - 'MAIL': '/var/mail/cltbld', 11:21:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:21:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:21:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:52 INFO - 'MOZ_NO_REMOTE': '1', 11:21:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:21:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:52 INFO - 'NO_EM_RESTART': '1', 11:21:52 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:21:52 INFO - 'PWD': '/builds/slave/test-pgo', 11:21:52 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:21:52 INFO - 'SHELL': '/bin/bash', 11:21:52 INFO - 'SHLVL': '1', 11:21:52 INFO - 'TERM': 'linux', 11:21:52 INFO - 'TMOUT': '86400', 11:21:52 INFO - 'USER': 'cltbld', 11:21:52 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1453749648.78248-2057032723', 11:21:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:52 INFO - '_': '/tools/buildbot/bin/python'} 11:21:52 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost'] with output_timeout 3600 11:21:53 INFO - mozversion INFO | application_buildid: 20160125032407 11:21:53 INFO - mozversion INFO | application_changeset: 3bfa5bc61b626761d487b45c170b115259f69d6b 11:21:53 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 11:21:53 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:21:53 INFO - mozversion INFO | application_name: Firefox 11:21:53 INFO - mozversion INFO | application_remotingname: firefox-dev 11:21:53 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:21:53 INFO - mozversion INFO | application_vendor: Mozilla 11:21:53 INFO - mozversion INFO | application_version: 45.0a2 11:21:53 INFO - mozversion INFO | platform_buildid: 20160125032407 11:21:53 INFO - mozversion INFO | platform_changeset: 3bfa5bc61b626761d487b45c170b115259f69d6b 11:21:53 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:21:53 INFO - mozversion INFO | platform_version: 45.0a2 11:21:53 INFO - 2016-01-25 11:21:53,203 DEBUG : using testdate: 1453749713 11:21:53 INFO - 2016-01-25 11:21:53,203 DEBUG : actual date: 1453749713 11:21:53 INFO - 2016-01-25 11:21:53,211 INFO : starting webserver on 'localhost:40868' 11:21:53 INFO - 2016-01-25 11:21:53,212 INFO : Starting test suite talos-linux64-ix-011 11:21:53 INFO - 2016-01-25 11:21:53,212 INFO : Starting test dromaeo_css 11:21:53 INFO - 2016-01-25 11:21:53,212 DEBUG : operating with platform_type : linux_ 11:21:53 INFO - 2016-01-25 11:21:53,212 INFO : Initialising browser for dromaeo_css test... 11:21:53 INFO - 2016-01-25 11:21:53,231 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1WYFjm/profile http://localhost:40868/getInfo.html 11:22:03 INFO - 2016-01-25 11:22:03,628 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:22:03 INFO - 2016-01-25 11:22:03,628 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:22:03 INFO - 2016-01-25 11:22:03,628 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:22:03 INFO - 2016-01-25 11:22:03,628 DEBUG : BROWSER_OUTPUT: __metrics 11:22:03 INFO - 2016-01-25 11:22:03,830 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:22:05 INFO - 2016-01-25 11:22:05,351 INFO : Browser initialized. 11:22:05 INFO - 2016-01-25 11:22:05,352 INFO : Running cycle 1/1 for dromaeo_css test... 11:22:05 INFO - 2016-01-25 11:22:05,352 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1WYFjm/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:22:17 INFO - 2016-01-25 11:22:17,153 DEBUG : BROWSER_OUTPUT: RSS: Main: 136785920 11:22:17 INFO - 2016-01-25 11:22:17,154 DEBUG : BROWSER_OUTPUT: 11:23:08 INFO - 2016-01-25 11:23:08,000 DEBUG : BROWSER_OUTPUT: 1453749787999 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:25:16 INFO - 2016-01-25 11:25:16,952 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40868/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40868/tests/dromaeo/cssquery-ext.html) 11:25:18 INFO - 2016-01-25 11:25:18,170 DEBUG : BROWSER_OUTPUT: RSS: Main: 258146304 11:25:18 INFO - 2016-01-25 11:25:18,171 DEBUG : BROWSER_OUTPUT: 11:28:20 INFO - 2016-01-25 11:28:20,449 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40868/tests/dromaeo/cssquery-ext.html (next: http://localhost:40868/tests/dromaeo/cssquery-jquery.html) 11:28:21 INFO - 2016-01-25 11:28:21,016 DEBUG : BROWSER_OUTPUT: RSS: Main: 220946432 11:28:21 INFO - 2016-01-25 11:28:21,016 DEBUG : BROWSER_OUTPUT: 11:31:22 INFO - 2016-01-25 11:31:22,871 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40868/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40868/tests/dromaeo/cssquery-mootools.html) 11:31:23 INFO - 2016-01-25 11:31:23,433 DEBUG : BROWSER_OUTPUT: RSS: Main: 214417408 11:31:23 INFO - 2016-01-25 11:31:23,433 DEBUG : BROWSER_OUTPUT: 11:34:25 INFO - 2016-01-25 11:34:25,215 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40868/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40868/tests/dromaeo/cssquery-prototype.html) 11:34:25 INFO - 2016-01-25 11:34:25,784 DEBUG : BROWSER_OUTPUT: RSS: Main: 200355840 11:34:25 INFO - 2016-01-25 11:34:25,785 DEBUG : BROWSER_OUTPUT: 11:37:28 INFO - 2016-01-25 11:37:28,278 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40868/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40868/tests/dromaeo/cssquery-yui.html) 11:37:28 INFO - 2016-01-25 11:37:28,844 DEBUG : BROWSER_OUTPUT: RSS: Main: 205107200 11:37:28 INFO - 2016-01-25 11:37:28,844 DEBUG : BROWSER_OUTPUT: 11:40:31 INFO - 2016-01-25 11:40:31,059 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40868/tests/dromaeo/cssquery-yui.html (next: http://localhost:40868/tests/dromaeo/cssquery-dojo.html) 11:40:31 INFO - 2016-01-25 11:40:31,310 DEBUG : BROWSER_OUTPUT: RSS: Main: 244740096 11:40:31 INFO - 2016-01-25 11:40:31,310 DEBUG : BROWSER_OUTPUT: 11:40:31 INFO - 2016-01-25 11:40:31,311 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:40:31 INFO - 2016-01-25 11:40:31,312 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:40:31 INFO - 2016-01-25 11:40:31,312 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:40:31 INFO - 2016-01-25 11:40:31,312 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:40:31 INFO - 2016-01-25 11:40:31,315 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3197.2006998250436;3224.596925384327;3254.088855120567;3257.576515053043;3269.0356344878264;5436.347638283407;5439.5104440600335;5448.536874365674;5451.836444906654;5493.368262649791;5450.04624190767;5454.372747134081;5468.589855760814;5471;5471.945280547194;4807.855764327058;4873.5613794758465;4941.3329200558;4979.526944940243;5007.699538027712;4921.803127874899;4969.776360063805;4989.875253118665;4991.351124353829;4998.200287953928;4873.463918968929;4961.751912404384;4987.326710894037;5004.299398084253;5029.396472423315;4961.578265847407;4970.179920313144;4999.87502811868;5018.5232402921665;5051.747412629391;4768.928466073012;4943.975280123613;4966.975165124188;4983.501649835024;4991.026749783794;5141.254518094893;5207.036698210805;5233.712145831978;5283.207518872162;5289.338832645919;5846.853828654275;5868.823935281948;5884.588078834483;5925.111233314994;5925.911111333334;5677.489025987639;5955.851103722398;5963.045912653998;5971.880562388771;5972.641641501524;5357.812476563302;5481.451854814526;5586.16207568868;5608.85977850557;5617.80337688183;6032.909506357408;6049.274087109575;6056.36408177135;6060.454559089703;6066.787662431882;5592;5795.681237531976;5812.738426770806;5813.651180929158;5847.766089356463;5754.165645981309;5761.827145185651;5833.591648584643;5850.824475265749;5853.560982926298;5809.186713860063;5814.156947242626;5852.707364631837;5862.530997520188;5864.38423965486;5791.942080579141;5819.185314056035;5854.063349864086;5855.063189889683;5864.501517370986;4349.391085248068;4422.624076953431;4434.401355816924;4484.708493947883;4508.098380323949;4034.616711412411;4045.8583949561626;4060.451839001756;4069.715119941635;4070.063885306337;5401.378841433207;5548.278723765965;5556.277683901067;5559.360673522597;5566.192902029264;5774.191613174159;5828.358880523224;5841.1238314253205;5854.121881717691;5858.648481091148;5538.584606154554;5542.86142846424;5554.361248456398;5559.277293951841;5564.081926482166;5114.411842638145;5120.92318615221;5131.486851314913;5134.075866344094;5165.612579056586;5858.882822343529;5902.734376953047;6008.909866352008;6027.638341699424;6084.999999999912;5844.47399734009;5849.064149736022;5854.853628659318;5861.677607731615;5863.912041319299;5870.647761134345;6002.939970600238;6048.0625503047095;6048.939510605013;6056.424639659225;5672.262605861377;5697.373288938296;5728.684922329312;5751.827445176651;5780.046292361713;5884.852878678067;5899.616524925866;5926.911096333644;5928.822135335947;5932.644041357532;5519.9448005521035;5619.494245517923;5773.24947756789;5787.508061814793;5791;5599.720013999366;5668.5465162787705;5671.461211184931;5672.943270567242;5704.657720536781;5657.066584013756;5668.26312579362;5669.829905102853;5674.460926212003;5676.659400435987;5546.057170280981;5579.330480342385;5642.605017648725;5742.885142297214;5787.276590426197;5598.608097433141;5671.574631902541;5695;5697.800576979786;5705.372409035086 11:40:31 INFO - 2016-01-25 11:40:31,316 DEBUG : BROWSER_OUTPUT: |1;ext.html;594.7085927895332;640.564416196986;649.156097073804;659.47242206235;660.3990368764422;31869.68130318699;32656.510152347735;41987.37018944718;42774.14451710964;42809.78595107028;47876.521234787644;48335.27497087546;48415.51584484154;48430.27354589684;48453.27320090202;8007.51954882706;8128.536863364592;9160.038195989426;9312.30157738169;9318.953405232964;10948.3978381189;11124.221304508688;11135.276207046556;11156.274842135235;11167.720806979809;10982.945085274563;11095.944520277428;11107;11112.888871111307;11119.221654484189;8108.513489190638;8221.301189398908;8255.793605159859;8260.421770476069;10953.83569246462;11024.338539687644;11276.661700149009;11280.548778048951;11286.040686541653;11296.548138074468;43877.56122438767;44108.558914410765;44302;44389.33415998763;44402.333964990554;3505.439129739255;3683.6684698377007;3751.381022131345;3827.559830619459;3847;33846.49230261548;34035.48946765801;34315.48526772075;34337.313253734785;34348.82825585881;3620.529331186955;3767.7362584619086;3781.659650631429;3798;3833.4441505981754;299284;300889;301217;303477;303676;61868;63044.68477657674;68242;68639;68719.65640171767;79950;81714.59142704248;81878.72485100529;81929.18070819335;82021.58989205016;17510.474685759447;17768.200430980636;17784.644307113784;17788.733169002477;17835;12257.448414821354;12280.447379867928;12291.508339666314;12299.200551964093;12300.692482687826;22527.211547595754;22777;22925.656115158286;22948;22962.65556016661;8159.98241512299;8482.915170848337;8489.872651910226;8500.27747641445;8507.276881465144;1004.7588578741196;1045.0124632222478;1050.4327663062013;1147.5753971030772;1188.3820413385165;29349.559756603667;29491.262718432212;29748.55377169344;29855.850720746257;30552.84723576368;1148.9712757181137;1159.721666799962;1191.124523475245;1194.8745381734966;1229.4959066782576;15529.145896975775;15826;15896.523104306889;18373.356932507297;18427;465993;471519;472852;473278;473388;60672.39327606667;60888;61451.692741536004;61476;61508;1362.2848004797363;1480.415235981781;1488.0773920169563;1490.2176357412445;1589.4119175904757;30745.846270769398;30957.535636965913;31227.219319517193;31576.842115789274;32129;49338.50661493483;49615.50384496109;50064.249036263755;50709.74645126751;56427;208248;208273;209831;210044;210480;32679.18302042468;33063.50404743979;33073;33073.173170669965;33090.834545827114;44003.559964399945;44117;44682.77658611816;44757.77621111873;45489.54510454853;37349.25301494009;39740.80129599333;46170.76914615405;46971;48485.272720908506;45623.31565026461;45625.77187114176;46533;46728.29907551457;47182.76408617935;39368.60631393649;39968.800156000194;40136.799316003235;40193.79903100466;40198.39702404525;35519.82240088783;36419.45370819387;36890;36968.07579810526;37097.6290237105;26973.3256668577;27237.45525089527;27269.45461090807;27319.86340068287;27370.726292737614 11:40:31 INFO - 2016-01-25 11:40:31,319 DEBUG : BROWSER_OUTPUT: |2;jquery.html;360.4935066231945;367.31495760406847;381.72515788632194;382.54406708928667;385.32183357291166;16468.423605173823;17038.91480542597;18634.161462734177;18746.99999999998;19105.331313404033;11798.528058877657;11966.700832479193;12050.397480125981;18577;18789;3974.1455587048777;5096.413912400066;5210.921836172461;5212.113940630083;5212.791488340462;4043.090304681438;4055.675545956331;4059.9797001014954;4074.5110586729634;5617.859553511154;5721.628094173865;5764.365919748845;5766.855828604276;5774.335951365584;5841.591088623798;6101.389861013885;6166.84582885427;6174;6176.938230617681;6180.660063696495;5417;5525.972370138164;5527.336719593634;5528.198411230389;5567.972160139173;14196.645083872883;14355.282235888164;14359.928200359036;14463.493777717835;14517.056391334529;2214.3689048621227;2270.8296877734238;2322.129201549419;2403.9639405408934;2455.5579995600965;9890.20878329732;10094.192464602815;13283.60149195516;13934.721305573934;14424.639384015378;1909.493984094216;1937.6415363157862;1950.8439324853978;1975.5258737902943;1976.6046790641785;66898.66550667264;69591;71024.28975710229;71598;72094.63952680255;10042.748931276776;10224.488775561193;10353.534090965924;10363.32638378503;10453.21600879937;13253.536126235536;13261.867381326256;13274;13289.401976911062;13322.333883305795;7970.561619111005;7983.2415920487465;7987.520748755093;7999.520028798291;8017.398695097891;8174.182581741778;8182.263596276363;8199.95900020496;8246.299064579578;8252.257296843312;4210.7473551587;4212.241796476664;4234.1108367242605;4237.978810105991;4244.214820258262;1795.7126859702385;1838.301445450747;1840.7115019486146;1934.8355389791743;1944.9027548622512;446.3750748951429;469.99295010574866;506.3746273352407;953.5422996961358;1112.9054030407344;10725.946370268099;11542.19204655666;11782.234154779911;12092.395380230953;12465.439055242536;512.075703355447;528.8096285337275;936.2182577547687;967.3180407812475;1019.3527110285022;7303.780886573411;9824.263180261509;9896.60413583463;9918.206543476505;10118.595256189818;678737;682490;687961;708178;713119;88043.55978220068;89080;91183.54408227916;91328;92458.53770731103;1182.456070207714;1186.1874615888144;1188.8276199950958;1190.5475919150667;1191.065013964034;15989.840101598835;16146.273417696466;16260.837391625932;16306.613937815418;16394.344226230816;22520;35216.11959701028;35849.283014340086;36286.27427451383;36501.45247821232;50019.49980500294;50612;50954.49045509497;51646.48353516567;54102.18846717224;10587.470626468492;10639.095676867244;10644.095251903675;10785.352878827296;10800;16191.271392787117;19375.546833987224;19540.31608893682;19854.50363740918;19942.50143746418;16059.116748578941;16074.276657550672;16212.67574648524;16513.256903439615;16535.338586456408;15654.608634784221;15891.761623575887;15954.60113497172;16262.349506019627;16513.33946642121;13594.660133496345;15703.293351799424;15996.120213388376;16128.193590320672;16281.18594070268;9945.900540994788;10116.898831011596;10376.636817711344;10404;10424.739381515523;10630.893691062991;10762.46187690628;10916.672499825017;10948.45257737126;11101.333919964827 11:40:31 INFO - 2016-01-25 11:40:31,320 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1409.3305679802088;1558.290977605189;1563.5856498028018;1813.8911665300084;1841.0426578179347;6943.444524438046;7374.041374621298;7502.062242219723;7513.511621744583;7513.69945202192;7595.9620201898915;7848.372130229583;7857.960710196441;7862.213778622135;7868;1841.1346667066457;1884.4911873794135;2171.6525355943054;2179.978200217993;2213.513027134036;2238.876861772602;2240.137547044383;2246.4608493961496;2254.8534345267503;2255.650374192003;2076.9584608307823;2135.028562004292;2152.5156839711094;2155.9892200538975;2158.0396723458066;2208.238157835552;2235.3964429604;2244.607193741097;2279.943001424978;2280.5096904165684;2244.102359056374;2246.3597874605657;2273.6703178039093;2273.783990520898;2279.87460689662;7703.653335599912;7757.340626046793;7759.9612001940195;7764.805879852993;7771.922280777233;4514.796834142471;4533.52397998212;4539.296409056601;4547.045120524694;4629.398178236841;2975.8809647614285;2994.595729576501;3027.3945210957677;3046.6039414876145;3080.553319768621;1017.5268500147467;1017.6896046705751;1037.1132681557235;1038.709161434792;1052.7736536644582;10323.019313165161;10336.5348559315;10340.844887326695;10355.534000969974;10359.22305827066;4043.5147782266317;4061.8578349757618;4093.2427500912427;4101.9950112222095;4116;9008.189262966365;9010.053944335881;9015.413998090104;9017.594208260643;9024.413413128126;4569.543045695404;4620.399348084795;4620.792064357112;4622;4623.791929363187;4195.622393984495;4234.87295381139;4243;4243.618074373321;4245.660347172219;3329.267561136546;3352.6479719629574;3542.557180352456;3598.712103031751;3661.7253705972157;1140.937248451343;1141.7259857634274;1142.5943789954613;1145.352875625269;1148.6496618531262;1182.9290242585473;1190.5773450425147;1210.431097384228;1467.039089396447;1489.3521318226606;7237.601931893796;7238.384737297389;7252.311030452099;7354.374878135419;7464.85070298591;1143.451143451148;1163.66253786401;1170.280277629269;1213.6177104212145;1218.6405010521917;5809.622374545641;5881.852953676193;5885.852853678693;5896.262967129109;5902;8676.089010653917;9157.816843663222;9289.16397524226;9294.953525232331;9323.580438880266;9043.638254469879;9102.499362534993;9192.310576706774;9214.447133171898;9216.677416290398;7195.172555156119;7243.022192004118;7253.202147763742;7277.345038946414;7320.926790732131;7214.855702886018;7249.347558719741;7276.854462910818;7289.271072892669;7298.489105762758;7968.521888686697;7974.760757177294;8077.798055048435;8089.271965523131;8262.215089566482;8263.628136733741;8279.710210142615;8447.91552084496;8452.704155354533;8454.957725211334;6630.436412904957;6902.654867256718;6921.757738479129;6921.792346229621;6925.480588955747;6609.537332386687;6939.930600693929;6949.444044476329;7191.748288809867;7508.924910750822;7096.396806271525;7135.571865688075;7168.784936451915;7198.244184360776;7250.709971601077;6964.965175174092;6966.303369662993;7082.964585177041;7099.041629379967;7170.498065135391;7130.4625326605765;7157.7136914522835;7196.4962452627815;7202.603856787927;7208.855822883618;6582.868342633024;6629.105070815571;6633;6638.601683898982;6638.668066596748;6628.072069910313;6661.034150048313;6675.165604299463;6679.966600166968;6683.298253683293 11:40:31 INFO - 2016-01-25 11:40:31,322 DEBUG : BROWSER_OUTPUT: |4;prototype.html;355.4419561288777;358.541067433685;359.3728942994475;359.559539564034;363.54919899324847;6008.459238668519;6159.969200153993;6167.784127555531;6177.9382206177925;6184.041473571592;5947.791827286046;6063.181470501481;6102.420270074347;6117.051856962167;6118.449339559439;4732.810687572493;4736.242201247801;4737.099951009297;4748.240281554952;4748.3589715388325;4533.2066888294585;4591.816327346902;4624.12141693079;4735.384400027991;4738.90522189556;4666.510016448275;4686.343911852344;4697.459792123898;4711.693739906895;4711.929321060187;4682.6253899687945;4703.082898834746;4716.033213191287;4717.1980763269985;4756.7859446325;4170.207660544487;4174.958250417488;4180.435641188431;4191.643710284629;4192.266353388145;5738.167965644958;5818.679972601505;5820.243368362128;5854.47309742121;5888.5289176865745;5467.9453205467835;5469.890602187974;5479.068558345051;5481.369642491125;5481.725913704299;6222.968885155546;6411.166548348731;6469.547131700783;6502.7398904043785;6507.6420796856155;4369.388285640013;4556.749378784166;4624.468186158601;4625.375574297461;4640.628749700016;6671.699773510204;6765.966170169167;6777.288384719632;6779.966100169468;6789.694463749143;4782.3543821584335;4783.808647654125;4787.305840653085;4791.185498465269;4795.20879054952;4777.4267087949665;4851.902961940741;4865.221564549655;4871.415430148405;4875.7074575525585;5519.751611177507;5520.033994051106;5520.558355331564;5525.475079867406;5527.53015993637;6522.706478208492;6524.151860258136;6528.771492997722;6536.7712130075215;6538.803835884931;1704.582377317565;1719.7162468192857;1719.819418960991;1721.5868191633917;1723.8103808581045;1177.6584790410857;1185.3421351150193;1187.2935603316014;1189.167582692119;1195.6891208285733;6228.5017198624;6281.78013769525;6287.528435367274;6289.182406287154;6295.496360291166;6691.665416729144;6694.397504224643;6696.732130714717;6698.22970358415;6705.664716764142;6272.466840318532;6272.686365681789;6275.435210831047;6279.811605651837;6286.528510361742;3588.3361578108133;3676.540432445944;3681.0245284999496;3682.6685598295744;3684.705223582107;7054.506184567031;7074.787756367317;7078.893816592756;7079.92920070803;7096.787096387116;6855.108835851307;6944.722211111499;6980.825479363057;6986.231514533397;6988.6855091521;6996.370326670624;7002.334778196063;7021.368076873106;7063.752768653072;7065.328793764585;6496.220453545416;6686.465082793462;6727.966360168168;6773.62745049027;6775.288594697486;6646.468282537482;6701.262861085374;6715.93284067153;6729.1924969002075;6734.8653026940165;6982.371586557234;7037.507374483737;7045.225025247116;7046.260142684944;7049.436045116276;4597.655175861757;4644.303354496852;4665.953340466552;4679.555442232982;4684.344191813081;6736.393724564813;6762.695678694372;6788.355106264897;6793.490488213305;6801.625910574966;6590.868182636224;6606.10817539626;6610.272869984202;6611.140551728245;6615;6472.546921715623;6598.868022639616;6605.976073708583;6609.669516524058;6610.305917878553;6475.838104047437;6476.125723027331;6480.935190648033;6485.77299794505;6489.5781774184525;6605.933940660532;6653;6653.900191497035;6663.100481435138;6665.366790154928;6350.618962862243;6438.937575300023;6465.612063276219;6467.482601391784;6475.579087359307 11:40:31 INFO - 2016-01-25 11:40:31,325 DEBUG : BROWSER_OUTPUT: |5;yui.html;900.9279257659385;917.6788124156544;927.5130556457863;936.134075979719;954.5131982688827;14954.775678364833;15254.618634534143;15268.16025118618;17190.74213886793;17700.822991770077;16057.759133612975;16095.919520402382;16117.758233626504;16159.83840161598;16204.83795162048;896.2874514760764;914.008300993423;914.7667344827094;915.0300681277866;915.199200699388;763.0080894836718;769.9730509432171;905.4748246017294;907.7412937312868;914.711865762286;945.4091193004373;946.356477595235;953.5184731710476;954.1460392948308;954.2175416158752;793.821390187209;795.645937557787;945.8202941441139;950.1638558068925;950.7147855643314;705.4039336760429;708.9113860767404;715.7494876793132;719.0723966083746;720.0747040053506;14960.62598435037;15069.397224111022;15095.320710567941;15098.622534436618;15126.773098403533;12334.691632709164;12683.239005659598;12727.172733772368;12860.807087893596;13062.477500899953;11026.503807328609;11207.159463040305;11244.662660120128;11431.428428578538;11849.881501184964;3651.1054791575966;3679.4296883983025;3689.760165589255;3701.3522633539023;3745.7190710696536;53926;53929;54046.45953540454;54137.729311353585;54504.18243726347;9801.117899388946;10007.199424046059;10029.946855580205;10853.45732713377;11197.66407007791;19894.70157947632;20052.298169563994;20066.89966550158;20070.297539586045;20080.39758807209;7778.8055298616855;7911.406644501571;8041.517508949481;8064.717734879251;8194.754157375288;4938.456769755324;4946.752662366867;4973.104841128559;4975.626827987915;5047.343845300161;3333.1833700743473;3339.632640409553;3355.3960287148548;3356.3287342531103;3360.0423879194313;545.2148905575958;558.2324304081887;562.4010428893216;568.0995621939272;568.5394830187562;632.6741728010079;671.1677519875319;709.670003448399;722.1298335505703;740.9433352395591;8868.379213455126;8928.330375221754;8929.776755581033;9237.722868313962;10052.899471005343;703.5673061067407;719.2914978745931;751.3726038757699;751.8909608327782;776.8174478997431;4204.180184863983;4471.195184866755;4518.909621807546;4528.909421811545;4553.908921821545;62908;64575;64771;64889.67555162194;65062;55111.44888551063;55705.72147139238;55764.72117639386;56149;56850.71574642183;50934.74532627313;51370.74314628403;51951;52290.738546307024;53070;8503.532305723245;8720.738377848675;8870.068642792414;9415.387999779992;9460.148586627236;34991.65008349884;35993.460098098025;37136.44295335518;37202.627973721;37371.439428408055;47464.28803568018;47707.76146119247;48151.277730834765;48911.755441222565;49006.5099349002;10526.368417894952;10542.26204165701;10845.295055821347;11421.942890285496;11954.103442241692;13193.60419187426;13345.799813002619;13353.866461335263;13708.3831227593;14004.299785010913;10592.470376481298;10854.620088296871;10871.836922446328;10928.50821713009;10936.398498082683;11840.940795295968;11946.462409191434;12426.528971430627;12654.936725316315;12847.229166250056;10157.54291056919;10772.784544308914;12304.507819687113;12450.875491244971;13056.543020994219;10622.521986510472;10758.085562727256;10894.182936279969;10956.945215273872;11045.447727613426;9717.368371055858;9826.803463930824;9919.504024798587;10066.949665251626;10097.394156350643 11:40:31 INFO - 2016-01-25 11:40:31,325 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:40:31 INFO - 2016-01-25 11:40:31,325 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:40:31 INFO - 2016-01-25 11:40:31,326 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,982 11:40:31 INFO - 2016-01-25 11:40:31,326 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:40:31 INFO - 2016-01-25 11:40:31,326 DEBUG : BROWSER_OUTPUT: __startTimestamp1453750831311__endTimestamp 11:40:31 INFO - 2016-01-25 11:40:31,326 DEBUG : BROWSER_OUTPUT: 11:40:31 INFO - 2016-01-25 11:40:31,326 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:40:31 INFO - 2016-01-25 11:40:31,326 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:40:31 INFO - 2016-01-25 11:40:31,326 DEBUG : BROWSER_OUTPUT: 11:40:31 INFO - 2016-01-25 11:40:31,326 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5430.62 Median:5642.61 stddev:606.18 (10.7%) stddev-sans-first:582.17 11:40:31 INFO - 2016-01-25 11:40:31,326 DEBUG : BROWSER_OUTPUT: Values: 3197.2 3224.6 3254.1 3257.6 3269.0 5436.3 5439.5 5448.5 5451.8 5493.4 5450.0 5454.4 5468.6 5471.0 5471.9 4807.9 4873.6 4941.3 4979.5 5007.7 4921.8 4969.8 4989.9 4991.4 4998.2 4873.5 4961.8 4987.3 5004.3 5029.4 4961.6 4970.2 4999.9 5018.5 5051.7 4768.9 4944.0 4967.0 4983.5 4991.0 5141.3 5207.0 5233.7 5283.2 5289.3 5846.9 5868.8 5884.6 5925.1 5925.9 5677.5 5955.9 5963.0 5971.9 5972.6 5357.8 5481.5 5586.2 5608.9 5617.8 6032.9 6049.3 6056.4 6060.5 6066.8 5592.0 5795.7 5812.7 5813.7 5847.8 5754.2 5761.8 5833.6 5850.8 5853.6 5809.2 5814.2 5852.7 5862.5 5864.4 5791.9 5819.2 5854.1 5855.1 5864.5 4349.4 4422.6 4434.4 4484.7 4508.1 4034.6 4045.9 4060.5 4069.7 4070.1 5401.4 5548.3 5556.3 5559.4 5566.2 5774.2 5828.4 5841.1 5854.1 5858.6 5538.6 5542.9 5554.4 5559.3 5564.1 5114.4 5120.9 5131.5 5134.1 5165.6 5858.9 5902.7 6008.9 6027.6 6085.0 5844.5 5849.1 5854.9 5861.7 5863.9 5870.6 6002.9 6048.1 6048.9 6056.4 5672.3 5697.4 5728.7 5751.8 5780.0 5884.9 5899.6 5926.9 5928.8 5932.6 5519.9 5619.5 5773.2 5787.5 5791.0 5599.7 5668.5 5671.5 5672.9 5704.7 5657.1 5668.3 5669.8 5674.5 5676.7 5546.1 5579.3 5642.6 5742.9 5787.3 5598.6 5671.6 5695.0 5697.8 5705.4 11:40:31 INFO - 2016-01-25 11:40:31,326 DEBUG : BROWSER_OUTPUT: 11:40:31 INFO - 2016-01-25 11:40:31,326 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:52254.83 Median:20019.99 stddev:91200.43 (455.5%) stddev-sans-first:91373.79 11:40:31 INFO - 2016-01-25 11:40:31,326 DEBUG : BROWSER_OUTPUT: Values: 594.7 640.6 649.2 659.5 660.4 31869.7 32656.5 41987.4 42774.1 42809.8 47876.5 48335.3 48415.5 48430.3 48453.3 8007.5 8128.5 9160.0 9312.3 9319.0 10948.4 11124.2 11135.3 11156.3 11167.7 10982.9 11095.9 11107.0 11112.9 11119.2 8108.5 8221.3 8255.8 8260.4 10953.8 11024.3 11276.7 11280.5 11286.0 11296.5 43877.6 44108.6 44302.0 44389.3 44402.3 3505.4 3683.7 3751.4 3827.6 3847.0 33846.5 34035.5 34315.5 34337.3 34348.8 3620.5 3767.7 3781.7 3798.0 3833.4 299284.0 300889.0 301217.0 303477.0 303676.0 61868.0 63044.7 68242.0 68639.0 68719.7 79950.0 81714.6 81878.7 81929.2 82021.6 17510.5 17768.2 17784.6 17788.7 17835.0 12257.4 12280.4 12291.5 12299.2 12300.7 22527.2 22777.0 22925.7 22948.0 22962.7 8160.0 8482.9 8489.9 8500.3 8507.3 1004.8 1045.0 1050.4 1147.6 1188.4 29349.6 29491.3 29748.6 29855.9 30552.8 1149.0 1159.7 1191.1 1194.9 1229.5 15529.1 15826.0 15896.5 18373.4 18427.0 465993.0 471519.0 472852.0 473278.0 473388.0 60672.4 60888.0 61451.7 61476.0 61508.0 1362.3 1480.4 1488.1 1490.2 1589.4 30745.8 30957.5 31227.2 31576.8 32129.0 49338.5 49615.5 50064.2 50709.7 56427.0 208248.0 208273.0 209831.0 210044.0 210480.0 32679.2 33063.5 33073.0 33073.2 33090.8 44003.6 44117.0 44682.8 44757.8 45489.5 37349.3 39740.8 46170.8 46971.0 48485.3 45623.3 45625.8 46533.0 46728.3 47182.8 39368.6 39968.8 40136.8 40193.8 40198.4 35519.8 36419.5 36890.0 36968.1 37097.6 26973.3 27237.5 27269.5 27319.9 27370.7 11:40:31 INFO - 2016-01-25 11:40:31,327 DEBUG : BROWSER_OUTPUT: 11:40:31 INFO - 2016-01-25 11:40:31,327 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:33745.24 Median:11078.44 stddev:113518.34 (1024.7%) stddev-sans-first:113809.11 11:40:31 INFO - 2016-01-25 11:40:31,328 DEBUG : BROWSER_OUTPUT: Values: 360.5 367.3 381.7 382.5 385.3 16468.4 17038.9 18634.2 18747.0 19105.3 11798.5 11966.7 12050.4 18577.0 18789.0 3974.1 5096.4 5210.9 5212.1 5212.8 4043.1 4055.7 4060.0 4074.5 5617.9 5721.6 5764.4 5766.9 5774.3 5841.6 6101.4 6166.8 6174.0 6176.9 6180.7 5417.0 5526.0 5527.3 5528.2 5568.0 14196.6 14355.3 14359.9 14463.5 14517.1 2214.4 2270.8 2322.1 2404.0 2455.6 9890.2 10094.2 13283.6 13934.7 14424.6 1909.5 1937.6 1950.8 1975.5 1976.6 66898.7 69591.0 71024.3 71598.0 72094.6 10042.7 10224.5 10353.5 10363.3 10453.2 13253.5 13261.9 13274.0 13289.4 13322.3 7970.6 7983.2 7987.5 7999.5 8017.4 8174.2 8182.3 8200.0 8246.3 8252.3 4210.7 4212.2 4234.1 4238.0 4244.2 1795.7 1838.3 1840.7 1934.8 1944.9 446.4 470.0 506.4 953.5 1112.9 10725.9 11542.2 11782.2 12092.4 12465.4 512.1 528.8 936.2 967.3 1019.4 7303.8 9824.3 9896.6 9918.2 10118.6 678737.0 682490.0 687961.0 708178.0 713119.0 88043.6 89080.0 91183.5 91328.0 92458.5 1182.5 1186.2 1188.8 1190.5 1191.1 15989.8 16146.3 16260.8 16306.6 16394.3 22520.0 35216.1 35849.3 36286.3 36501.5 50019.5 50612.0 50954.5 51646.5 54102.2 10587.5 10639.1 10644.1 10785.4 10800.0 16191.3 19375.5 19540.3 19854.5 19942.5 16059.1 16074.3 16212.7 16513.3 16535.3 15654.6 15891.8 15954.6 16262.3 16513.3 13594.7 15703.3 15996.1 16128.2 16281.2 9945.9 10116.9 10376.6 10404.0 10424.7 10630.9 10762.5 10916.7 10948.5 11101.3 11:40:31 INFO - 2016-01-25 11:40:31,328 DEBUG : BROWSER_OUTPUT: 11:40:31 INFO - 2016-01-25 11:40:31,328 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5405.74 Median:6596.20 stddev:2777.19 (42.1%) stddev-sans-first:2768.73 11:40:31 INFO - 2016-01-25 11:40:31,329 DEBUG : BROWSER_OUTPUT: Values: 1409.3 1558.3 1563.6 1813.9 1841.0 6943.4 7374.0 7502.1 7513.5 7513.7 7596.0 7848.4 7858.0 7862.2 7868.0 1841.1 1884.5 2171.7 2180.0 2213.5 2238.9 2240.1 2246.5 2254.9 2255.7 2077.0 2135.0 2152.5 2156.0 2158.0 2208.2 2235.4 2244.6 2279.9 2280.5 2244.1 2246.4 2273.7 2273.8 2279.9 7703.7 7757.3 7760.0 7764.8 7771.9 4514.8 4533.5 4539.3 4547.0 4629.4 2975.9 2994.6 3027.4 3046.6 3080.6 1017.5 1017.7 1037.1 1038.7 1052.8 10323.0 10336.5 10340.8 10355.5 10359.2 4043.5 4061.9 4093.2 4102.0 4116.0 9008.2 9010.1 9015.4 9017.6 9024.4 4569.5 4620.4 4620.8 4622.0 4623.8 4195.6 4234.9 4243.0 4243.6 4245.7 3329.3 3352.6 3542.6 3598.7 3661.7 1140.9 1141.7 1142.6 1145.4 1148.6 1182.9 1190.6 1210.4 1467.0 1489.4 7237.6 7238.4 7252.3 7354.4 7464.9 1143.5 1163.7 1170.3 1213.6 1218.6 5809.6 5881.9 5885.9 5896.3 5902.0 8676.1 9157.8 9289.2 9295.0 9323.6 9043.6 9102.5 9192.3 9214.4 9216.7 7195.2 7243.0 7253.2 7277.3 7320.9 7214.9 7249.3 7276.9 7289.3 7298.5 7968.5 7974.8 8077.8 8089.3 8262.2 8263.6 8279.7 8447.9 8452.7 8455.0 6630.4 6902.7 6921.8 6921.8 6925.5 6609.5 6939.9 6949.4 7191.7 7508.9 7096.4 7135.6 7168.8 7198.2 7250.7 6965.0 6966.3 7083.0 7099.0 7170.5 7130.5 7157.7 7196.5 7202.6 7208.9 6582.9 6629.1 6633.0 6638.6 6638.7 6628.1 6661.0 6675.2 6680.0 6683.3 11:40:31 INFO - 2016-01-25 11:40:31,329 DEBUG : BROWSER_OUTPUT: 11:40:31 INFO - 2016-01-25 11:40:31,329 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5493.64 Median:6225.74 stddev:1636.89 (26.3%) stddev-sans-first:1595.40 11:40:31 INFO - 2016-01-25 11:40:31,331 DEBUG : BROWSER_OUTPUT: Values: 355.4 358.5 359.4 359.6 363.5 6008.5 6160.0 6167.8 6177.9 6184.0 5947.8 6063.2 6102.4 6117.1 6118.4 4732.8 4736.2 4737.1 4748.2 4748.4 4533.2 4591.8 4624.1 4735.4 4738.9 4666.5 4686.3 4697.5 4711.7 4711.9 4682.6 4703.1 4716.0 4717.2 4756.8 4170.2 4175.0 4180.4 4191.6 4192.3 5738.2 5818.7 5820.2 5854.5 5888.5 5467.9 5469.9 5479.1 5481.4 5481.7 6223.0 6411.2 6469.5 6502.7 6507.6 4369.4 4556.7 4624.5 4625.4 4640.6 6671.7 6766.0 6777.3 6780.0 6789.7 4782.4 4783.8 4787.3 4791.2 4795.2 4777.4 4851.9 4865.2 4871.4 4875.7 5519.8 5520.0 5520.6 5525.5 5527.5 6522.7 6524.2 6528.8 6536.8 6538.8 1704.6 1719.7 1719.8 1721.6 1723.8 1177.7 1185.3 1187.3 1189.2 1195.7 6228.5 6281.8 6287.5 6289.2 6295.5 6691.7 6694.4 6696.7 6698.2 6705.7 6272.5 6272.7 6275.4 6279.8 6286.5 3588.3 3676.5 3681.0 3682.7 3684.7 7054.5 7074.8 7078.9 7079.9 7096.8 6855.1 6944.7 6980.8 6986.2 6988.7 6996.4 7002.3 7021.4 7063.8 7065.3 6496.2 6686.5 6728.0 6773.6 6775.3 6646.5 6701.3 6715.9 6729.2 6734.9 6982.4 7037.5 7045.2 7046.3 7049.4 4597.7 4644.3 4666.0 4679.6 4684.3 6736.4 6762.7 6788.4 6793.5 6801.6 6590.9 6606.1 6610.3 6611.1 6615.0 6472.5 6598.9 6606.0 6609.7 6610.3 6475.8 6476.1 6480.9 6485.8 6489.6 6605.9 6653.0 6653.9 6663.1 6665.4 6350.6 6438.9 6465.6 6467.5 6475.6 11:40:31 INFO - 2016-01-25 11:40:31,331 DEBUG : BROWSER_OUTPUT: 11:40:31 INFO - 2016-01-25 11:40:31,331 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:15087.27 Median:48959.13 stddev:17654.45 (36.1%) stddev-sans-first:17671.84 11:40:31 INFO - 2016-01-25 11:40:31,332 DEBUG : BROWSER_OUTPUT: Values: 900.9 917.7 927.5 936.1 954.5 14954.8 15254.6 15268.2 17190.7 17700.8 16057.8 16095.9 16117.8 16159.8 16204.8 896.3 914.0 914.8 915.0 915.2 763.0 770.0 905.5 907.7 914.7 945.4 946.4 953.5 954.1 954.2 793.8 795.6 945.8 950.2 950.7 705.4 708.9 715.7 719.1 720.1 14960.6 15069.4 15095.3 15098.6 15126.8 12334.7 12683.2 12727.2 12860.8 13062.5 11026.5 11207.2 11244.7 11431.4 11849.9 3651.1 3679.4 3689.8 3701.4 3745.7 53926.0 53929.0 54046.5 54137.7 54504.2 9801.1 10007.2 10029.9 10853.5 11197.7 19894.7 20052.3 20066.9 20070.3 20080.4 7778.8 7911.4 8041.5 8064.7 8194.8 4938.5 4946.8 4973.1 4975.6 5047.3 3333.2 3339.6 3355.4 3356.3 3360.0 545.2 558.2 562.4 568.1 568.5 632.7 671.2 709.7 722.1 740.9 8868.4 8928.3 8929.8 9237.7 10052.9 703.6 719.3 751.4 751.9 776.8 4204.2 4471.2 4518.9 4528.9 4553.9 62908.0 64575.0 64771.0 64889.7 65062.0 55111.4 55705.7 55764.7 56149.0 56850.7 50934.7 51370.7 51951.0 52290.7 53070.0 8503.5 8720.7 8870.1 9415.4 9460.1 34991.7 35993.5 37136.4 37202.6 37371.4 47464.3 47707.8 48151.3 48911.8 49006.5 10526.4 10542.3 10845.3 11421.9 11954.1 13193.6 13345.8 13353.9 13708.4 14004.3 10592.5 10854.6 10871.8 10928.5 10936.4 11840.9 11946.5 12426.5 12654.9 12847.2 10157.5 10772.8 12304.5 12450.9 13056.5 10622.5 10758.1 10894.2 10956.9 11045.4 9717.4 9826.8 9919.5 10066.9 10097.4 11:40:31 INFO - 2016-01-25 11:40:31,332 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:40:31 INFO - 2016-01-25 11:40:31,332 DEBUG : BROWSER_OUTPUT: 11:40:32 INFO - 2016-01-25 11:40:32,121 INFO : Browser exited with error code: 0 11:40:32 INFO - 2016-01-25 11:40:32,138 INFO : Completed test dromaeo_css (00:18:38) 11:40:32 INFO - 2016-01-25 11:40:32,138 INFO : Starting test kraken 11:40:32 INFO - 2016-01-25 11:40:32,138 DEBUG : operating with platform_type : linux_ 11:40:32 INFO - 2016-01-25 11:40:32,138 INFO : Initialising browser for kraken test... 11:40:32 INFO - 2016-01-25 11:40:32,144 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7MRkOE/profile http://localhost:40868/getInfo.html 11:40:36 INFO - 2016-01-25 11:40:36,949 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:40:36 INFO - 2016-01-25 11:40:36,949 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:40:36 INFO - 2016-01-25 11:40:36,950 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:40:36 INFO - 2016-01-25 11:40:36,950 DEBUG : BROWSER_OUTPUT: __metrics 11:40:37 INFO - 2016-01-25 11:40:37,187 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:40:38 INFO - 2016-01-25 11:40:38,764 INFO : Browser initialized. 11:40:38 INFO - 2016-01-25 11:40:38,765 INFO : Running cycle 1/1 for kraken test... 11:40:38 INFO - 2016-01-25 11:40:38,765 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7MRkOE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:40:50 INFO - 2016-01-25 11:40:50,551 DEBUG : BROWSER_OUTPUT: RSS: Main: 137338880 11:40:50 INFO - 2016-01-25 11:40:50,551 DEBUG : BROWSER_OUTPUT: 11:40:53 INFO - 2016-01-25 11:40:53,006 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40868/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40868/tests/kraken/driver.html?testName=audio-beat-detection) 11:40:53 INFO - 2016-01-25 11:40:53,580 DEBUG : BROWSER_OUTPUT: RSS: Main: 168538112 11:40:53 INFO - 2016-01-25 11:40:53,580 DEBUG : BROWSER_OUTPUT: 11:40:56 INFO - 2016-01-25 11:40:56,148 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40868/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40868/tests/kraken/driver.html?testName=audio-dft) 11:40:56 INFO - 2016-01-25 11:40:56,717 DEBUG : BROWSER_OUTPUT: RSS: Main: 167366656 11:40:56 INFO - 2016-01-25 11:40:56,717 DEBUG : BROWSER_OUTPUT: 11:40:59 INFO - 2016-01-25 11:40:59,501 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40868/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40868/tests/kraken/driver.html?testName=audio-fft) 11:41:00 INFO - 2016-01-25 11:41:00,067 DEBUG : BROWSER_OUTPUT: RSS: Main: 163627008 11:41:00 INFO - 2016-01-25 11:41:00,067 DEBUG : BROWSER_OUTPUT: 11:41:02 INFO - 2016-01-25 11:41:02,024 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40868/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40868/tests/kraken/driver.html?testName=audio-oscillator) 11:41:02 INFO - 2016-01-25 11:41:02,597 DEBUG : BROWSER_OUTPUT: RSS: Main: 165199872 11:41:02 INFO - 2016-01-25 11:41:02,597 DEBUG : BROWSER_OUTPUT: 11:41:04 INFO - 2016-01-25 11:41:04,771 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40868/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40868/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:41:05 INFO - 2016-01-25 11:41:05,332 DEBUG : BROWSER_OUTPUT: RSS: Main: 164552704 11:41:05 INFO - 2016-01-25 11:41:05,332 DEBUG : BROWSER_OUTPUT: 11:41:08 INFO - 2016-01-25 11:41:08,215 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40868/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40868/tests/kraken/driver.html?testName=imaging-darkroom) 11:41:08 INFO - 2016-01-25 11:41:08,797 DEBUG : BROWSER_OUTPUT: RSS: Main: 162762752 11:41:08 INFO - 2016-01-25 11:41:08,797 DEBUG : BROWSER_OUTPUT: 11:41:12 INFO - 2016-01-25 11:41:12,171 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40868/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40868/tests/kraken/driver.html?testName=imaging-desaturate) 11:41:12 INFO - 2016-01-25 11:41:12,741 DEBUG : BROWSER_OUTPUT: RSS: Main: 163778560 11:41:12 INFO - 2016-01-25 11:41:12,741 DEBUG : BROWSER_OUTPUT: 11:41:15 INFO - 2016-01-25 11:41:15,445 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40868/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40868/tests/kraken/driver.html?testName=json-parse-financial) 11:41:16 INFO - 2016-01-25 11:41:16,026 DEBUG : BROWSER_OUTPUT: RSS: Main: 163930112 11:41:16 INFO - 2016-01-25 11:41:16,027 DEBUG : BROWSER_OUTPUT: 11:41:17 INFO - 2016-01-25 11:41:17,546 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40868/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40868/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:41:18 INFO - 2016-01-25 11:41:18,107 DEBUG : BROWSER_OUTPUT: RSS: Main: 171601920 11:41:18 INFO - 2016-01-25 11:41:18,107 DEBUG : BROWSER_OUTPUT: 11:41:19 INFO - 2016-01-25 11:41:19,869 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40868/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40868/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:41:20 INFO - 2016-01-25 11:41:20,471 DEBUG : BROWSER_OUTPUT: RSS: Main: 168148992 11:41:20 INFO - 2016-01-25 11:41:20,471 DEBUG : BROWSER_OUTPUT: 11:41:22 INFO - 2016-01-25 11:41:22,475 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40868/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40868/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:41:23 INFO - 2016-01-25 11:41:23,048 DEBUG : BROWSER_OUTPUT: RSS: Main: 181997568 11:41:23 INFO - 2016-01-25 11:41:23,049 DEBUG : BROWSER_OUTPUT: 11:41:26 INFO - 2016-01-25 11:41:26,384 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40868/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40868/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:41:26 INFO - 2016-01-25 11:41:26,965 DEBUG : BROWSER_OUTPUT: RSS: Main: 187502592 11:41:26 INFO - 2016-01-25 11:41:26,965 DEBUG : BROWSER_OUTPUT: 11:41:29 INFO - 2016-01-25 11:41:29,460 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40868/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40868/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:41:30 INFO - 2016-01-25 11:41:30,026 DEBUG : BROWSER_OUTPUT: RSS: Main: 186286080 11:41:30 INFO - 2016-01-25 11:41:30,027 DEBUG : BROWSER_OUTPUT: 11:41:31 INFO - 2016-01-25 11:41:31,675 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40868/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40868/tests/kraken/driver.html?testName=ai-astar) 11:41:31 INFO - 2016-01-25 11:41:31,925 DEBUG : BROWSER_OUTPUT: RSS: Main: 243027968 11:41:31 INFO - 2016-01-25 11:41:31,926 DEBUG : BROWSER_OUTPUT: 11:41:31 INFO - 2016-01-25 11:41:31,926 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:41:31 INFO - 2016-01-25 11:41:31,926 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:41:31 INFO - 2016-01-25 11:41:31,926 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:41:31 INFO - 2016-01-25 11:41:31,927 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:41:31 INFO - 2016-01-25 11:41:31,927 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;111;103;110;111;111;100;111;110;100 11:41:31 INFO - 2016-01-25 11:41:31,927 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;120;149;169;123;145;151;126;163;124 11:41:31 INFO - 2016-01-25 11:41:31,927 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;160;161;162;159;160;159;159;161 11:41:31 INFO - 2016-01-25 11:41:31,928 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;70;71;142;71;73;70;71;156;73 11:41:31 INFO - 2016-01-25 11:41:31,928 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;92;144;93;91;92;134;91;92;131 11:41:31 INFO - 2016-01-25 11:41:31,928 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;109;110;109;109;110;110;109 11:41:31 INFO - 2016-01-25 11:41:31,929 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;145;146;145;145;145;145;145;146 11:41:31 INFO - 2016-01-25 11:41:31,929 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;96;95;96;95;95;96;96 11:41:31 INFO - 2016-01-25 11:41:31,929 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;55;55;55;56;57;55;56;55;53;54 11:41:31 INFO - 2016-01-25 11:41:31,930 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;62;63;64;63;64;67;63;63;64;64 11:41:31 INFO - 2016-01-25 11:41:31,930 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;87;80;81;81;81;81;82;90;81;82 11:41:31 INFO - 2016-01-25 11:41:31,930 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;111;115;111;109;126;111;116;114;116;113 11:41:31 INFO - 2016-01-25 11:41:31,930 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;134;150;147;157;137;138;147;148;138;137 11:41:31 INFO - 2016-01-25 11:41:31,931 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;64;66;64;65;66;64;66;65;64 11:41:31 INFO - 2016-01-25 11:41:31,931 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:41:31 INFO - 2016-01-25 11:41:31,931 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:41:31 INFO - 2016-01-25 11:41:31,931 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,937 11:41:31 INFO - 2016-01-25 11:41:31,932 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:41:31 INFO - 2016-01-25 11:41:31,932 DEBUG : BROWSER_OUTPUT: __startTimestamp1453750891925__endTimestamp 11:41:31 INFO - 2016-01-25 11:41:31,932 DEBUG : BROWSER_OUTPUT: 11:41:31 INFO - 2016-01-25 11:41:31,936 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:41:31 INFO - 2016-01-25 11:41:31,936 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:41:31 INFO - 2016-01-25 11:41:31,936 DEBUG : BROWSER_OUTPUT: 11:41:31 INFO - 2016-01-25 11:41:31,937 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.70 Median:110.50 stddev:4.72 (4.3%) stddev-sans-first:4.93 11:41:31 INFO - 2016-01-25 11:41:31,937 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 103.0 110.0 111.0 111.0 100.0 111.0 110.0 100.0 11:41:31 INFO - 2016-01-25 11:41:31,937 DEBUG : BROWSER_OUTPUT: 11:41:31 INFO - 2016-01-25 11:41:31,937 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.90 Median:149.00 stddev:17.58 (11.8%) stddev-sans-first:18.46 11:41:31 INFO - 2016-01-25 11:41:31,937 DEBUG : BROWSER_OUTPUT: Values: 149.0 120.0 149.0 169.0 123.0 145.0 151.0 126.0 163.0 124.0 11:41:31 INFO - 2016-01-25 11:41:31,937 DEBUG : BROWSER_OUTPUT: 11:41:31 INFO - 2016-01-25 11:41:31,938 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.30 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:1.09 11:41:31 INFO - 2016-01-25 11:41:31,938 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 160.0 161.0 162.0 159.0 160.0 159.0 159.0 161.0 11:41:31 INFO - 2016-01-25 11:41:31,938 DEBUG : BROWSER_OUTPUT: 11:41:31 INFO - 2016-01-25 11:41:31,938 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:86.90 Median:71.00 stddev:32.91 (46.4%) stddev-sans-first:34.46 11:41:31 INFO - 2016-01-25 11:41:31,938 DEBUG : BROWSER_OUTPUT: Values: 72.0 70.0 71.0 142.0 71.0 73.0 70.0 71.0 156.0 73.0 11:41:31 INFO - 2016-01-25 11:41:31,938 DEBUG : BROWSER_OUTPUT: 11:41:31 INFO - 2016-01-25 11:41:31,938 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.10 Median:91.50 stddev:21.80 (23.8%) stddev-sans-first:22.52 11:41:31 INFO - 2016-01-25 11:41:31,938 DEBUG : BROWSER_OUTPUT: Values: 91.0 92.0 144.0 93.0 91.0 92.0 134.0 91.0 92.0 131.0 11:41:31 INFO - 2016-01-25 11:41:31,938 DEBUG : BROWSER_OUTPUT: 11:41:31 INFO - 2016-01-25 11:41:31,938 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 11:41:31 INFO - 2016-01-25 11:41:31,938 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 109.0 110.0 109.0 109.0 110.0 110.0 109.0 11:41:31 INFO - 2016-01-25 11:41:31,939 DEBUG : BROWSER_OUTPUT: 11:41:31 INFO - 2016-01-25 11:41:31,939 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 11:41:31 INFO - 2016-01-25 11:41:31,939 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 145.0 146.0 145.0 145.0 145.0 145.0 145.0 146.0 11:41:31 INFO - 2016-01-25 11:41:31,939 DEBUG : BROWSER_OUTPUT: 11:41:31 INFO - 2016-01-25 11:41:31,939 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 11:41:31 INFO - 2016-01-25 11:41:31,939 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 96.0 96.0 11:41:31 INFO - 2016-01-25 11:41:31,940 DEBUG : BROWSER_OUTPUT: 11:41:31 INFO - 2016-01-25 11:41:31,940 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.00 stddev:1.10 (2.0%) stddev-sans-first:1.17 11:41:31 INFO - 2016-01-25 11:41:31,940 DEBUG : BROWSER_OUTPUT: Values: 55.0 55.0 55.0 56.0 57.0 55.0 56.0 55.0 53.0 54.0 11:41:31 INFO - 2016-01-25 11:41:31,940 DEBUG : BROWSER_OUTPUT: 11:41:31 INFO - 2016-01-25 11:41:31,940 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:1.34 (2.1%) stddev-sans-first:1.27 11:41:31 INFO - 2016-01-25 11:41:31,940 DEBUG : BROWSER_OUTPUT: Values: 62.0 63.0 64.0 63.0 64.0 67.0 63.0 63.0 64.0 64.0 11:41:31 INFO - 2016-01-25 11:41:31,940 DEBUG : BROWSER_OUTPUT: 11:41:31 INFO - 2016-01-25 11:41:31,940 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:81.50 stddev:3.24 (4.0%) stddev-sans-first:3.02 11:41:31 INFO - 2016-01-25 11:41:31,940 DEBUG : BROWSER_OUTPUT: Values: 87.0 80.0 81.0 81.0 81.0 81.0 82.0 90.0 81.0 82.0 11:41:31 INFO - 2016-01-25 11:41:31,940 DEBUG : BROWSER_OUTPUT: 11:41:31 INFO - 2016-01-25 11:41:31,940 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:114.20 Median:114.50 stddev:4.78 (4.2%) stddev-sans-first:4.93 11:41:31 INFO - 2016-01-25 11:41:31,940 DEBUG : BROWSER_OUTPUT: Values: 111.0 115.0 111.0 109.0 126.0 111.0 116.0 114.0 116.0 113.0 11:41:31 INFO - 2016-01-25 11:41:31,940 DEBUG : BROWSER_OUTPUT: 11:41:31 INFO - 2016-01-25 11:41:31,940 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.30 Median:147.00 stddev:7.48 (5.1%) stddev-sans-first:7.14 11:41:31 INFO - 2016-01-25 11:41:31,941 DEBUG : BROWSER_OUTPUT: Values: 134.0 150.0 147.0 157.0 137.0 138.0 147.0 148.0 138.0 137.0 11:41:31 INFO - 2016-01-25 11:41:31,941 DEBUG : BROWSER_OUTPUT: 11:41:31 INFO - 2016-01-25 11:41:31,941 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.50 stddev:1.10 (1.7%) stddev-sans-first:0.93 11:41:31 INFO - 2016-01-25 11:41:31,941 DEBUG : BROWSER_OUTPUT: Values: 67.0 64.0 66.0 64.0 65.0 66.0 64.0 66.0 65.0 64.0 11:41:31 INFO - 2016-01-25 11:41:31,941 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:41:31 INFO - 2016-01-25 11:41:31,941 DEBUG : BROWSER_OUTPUT: 11:41:32 INFO - 2016-01-25 11:41:32,782 INFO : Browser exited with error code: 0 11:41:32 INFO - 2016-01-25 11:41:32,835 INFO : Completed test kraken (00:01:00) 11:41:32 INFO - 2016-01-25 11:41:32,835 INFO : Starting test v8_7 11:41:32 INFO - 2016-01-25 11:41:32,835 DEBUG : operating with platform_type : linux_ 11:41:32 INFO - 2016-01-25 11:41:32,835 INFO : Initialising browser for v8_7 test... 11:41:32 INFO - 2016-01-25 11:41:32,841 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprTKSU_/profile http://localhost:40868/getInfo.html 11:41:37 INFO - 2016-01-25 11:41:37,688 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:41:37 INFO - 2016-01-25 11:41:37,688 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:41:37 INFO - 2016-01-25 11:41:37,688 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:41:37 INFO - 2016-01-25 11:41:37,688 DEBUG : BROWSER_OUTPUT: __metrics 11:41:37 INFO - 2016-01-25 11:41:37,870 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:41:38 INFO - 2016-01-25 11:41:38,910 INFO : Browser initialized. 11:41:38 INFO - 2016-01-25 11:41:38,910 INFO : Running cycle 1/1 for v8_7 test... 11:41:38 INFO - 2016-01-25 11:41:38,911 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprTKSU_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:41:50 INFO - 2016-01-25 11:41:50,698 DEBUG : BROWSER_OUTPUT: RSS: Main: 136454144 11:41:50 INFO - 2016-01-25 11:41:50,698 DEBUG : BROWSER_OUTPUT: 11:42:12 INFO - 2016-01-25 11:42:12,088 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40868/tests/v8_7/run.html (next: http://localhost:40868/tests/v8_7/run.html) 11:42:12 INFO - 2016-01-25 11:42:12,338 DEBUG : BROWSER_OUTPUT: RSS: Main: 427692032 11:42:12 INFO - 2016-01-25 11:42:12,339 DEBUG : BROWSER_OUTPUT: 11:42:12 INFO - 2016-01-25 11:42:12,340 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:42:12 INFO - 2016-01-25 11:42:12,340 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:42:12 INFO - 2016-01-25 11:42:12,340 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:42:12 INFO - 2016-01-25 11:42:12,340 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:42:12 INFO - 2016-01-25 11:42:12,340 DEBUG : BROWSER_OUTPUT: |0;Richards;165.01650165016503 11:42:12 INFO - 2016-01-25 11:42:12,341 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;167.19612104999163 11:42:12 INFO - 2016-01-25 11:42:12,341 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.87685418415896 11:42:12 INFO - 2016-01-25 11:42:12,341 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5235.602094240838 11:42:12 INFO - 2016-01-25 11:42:12,341 DEBUG : BROWSER_OUTPUT: |4;RayTrace;946.073793755913 11:42:12 INFO - 2016-01-25 11:42:12,341 DEBUG : BROWSER_OUTPUT: |5;Earley;553.7098560354374 11:42:12 INFO - 2016-01-25 11:42:12,341 DEBUG : BROWSER_OUTPUT: |6;Boyer;10989.010989010989 11:42:12 INFO - 2016-01-25 11:42:12,342 DEBUG : BROWSER_OUTPUT: |7;RegExp;23976.190476190477 11:42:12 INFO - 2016-01-25 11:42:12,342 DEBUG : BROWSER_OUTPUT: |8;Splay;538.7931034482758 11:42:12 INFO - 2016-01-25 11:42:12,342 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 11:42:12 INFO - 2016-01-25 11:42:12,342 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:42:12 INFO - 2016-01-25 11:42:12,342 DEBUG : BROWSER_OUTPUT: __startTimestamp1453750932339__endTimestamp 11:42:12 INFO - 2016-01-25 11:42:12,342 DEBUG : BROWSER_OUTPUT: 11:42:12 INFO - 2016-01-25 11:42:12,342 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:42:12 INFO - 2016-01-25 11:42:12,344 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:42:12 INFO - 2016-01-25 11:42:12,344 DEBUG : BROWSER_OUTPUT: 11:42:12 INFO - 2016-01-25 11:42:12,344 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.02 Median:165.02 stddev:0.00 (0.0%) 11:42:12 INFO - 2016-01-25 11:42:12,344 DEBUG : BROWSER_OUTPUT: Values: 165.0 11:42:12 INFO - 2016-01-25 11:42:12,345 DEBUG : BROWSER_OUTPUT: 11:42:12 INFO - 2016-01-25 11:42:12,345 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:167.20 Median:167.20 stddev:0.00 (0.0%) 11:42:12 INFO - 2016-01-25 11:42:12,345 DEBUG : BROWSER_OUTPUT: Values: 167.2 11:42:12 INFO - 2016-01-25 11:42:12,345 DEBUG : BROWSER_OUTPUT: 11:42:12 INFO - 2016-01-25 11:42:12,345 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.88 Median:279.88 stddev:0.00 (0.0%) 11:42:12 INFO - 2016-01-25 11:42:12,345 DEBUG : BROWSER_OUTPUT: Values: 279.9 11:42:12 INFO - 2016-01-25 11:42:12,345 DEBUG : BROWSER_OUTPUT: 11:42:12 INFO - 2016-01-25 11:42:12,346 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5235.60 Median:5235.60 stddev:0.00 (0.0%) 11:42:12 INFO - 2016-01-25 11:42:12,346 DEBUG : BROWSER_OUTPUT: Values: 5235.6 11:42:12 INFO - 2016-01-25 11:42:12,346 DEBUG : BROWSER_OUTPUT: 11:42:12 INFO - 2016-01-25 11:42:12,346 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:946.07 Median:946.07 stddev:0.00 (0.0%) 11:42:12 INFO - 2016-01-25 11:42:12,346 DEBUG : BROWSER_OUTPUT: Values: 946.1 11:42:12 INFO - 2016-01-25 11:42:12,346 DEBUG : BROWSER_OUTPUT: 11:42:12 INFO - 2016-01-25 11:42:12,346 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:553.71 Median:553.71 stddev:0.00 (0.0%) 11:42:12 INFO - 2016-01-25 11:42:12,346 DEBUG : BROWSER_OUTPUT: Values: 553.7 11:42:12 INFO - 2016-01-25 11:42:12,347 DEBUG : BROWSER_OUTPUT: 11:42:12 INFO - 2016-01-25 11:42:12,347 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10989.01 Median:10989.01 stddev:0.00 (0.0%) 11:42:12 INFO - 2016-01-25 11:42:12,347 DEBUG : BROWSER_OUTPUT: Values: 10989.0 11:42:12 INFO - 2016-01-25 11:42:12,347 DEBUG : BROWSER_OUTPUT: 11:42:12 INFO - 2016-01-25 11:42:12,347 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23976.19 Median:23976.19 stddev:0.00 (0.0%) 11:42:12 INFO - 2016-01-25 11:42:12,347 DEBUG : BROWSER_OUTPUT: Values: 23976.2 11:42:12 INFO - 2016-01-25 11:42:12,347 DEBUG : BROWSER_OUTPUT: 11:42:12 INFO - 2016-01-25 11:42:12,348 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:538.79 Median:538.79 stddev:0.00 (0.0%) 11:42:12 INFO - 2016-01-25 11:42:12,348 DEBUG : BROWSER_OUTPUT: Values: 538.8 11:42:12 INFO - 2016-01-25 11:42:12,348 DEBUG : BROWSER_OUTPUT: 11:42:12 INFO - 2016-01-25 11:42:12,348 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 11:42:12 INFO - 2016-01-25 11:42:12,348 DEBUG : BROWSER_OUTPUT: Values: 4826.9 11:42:12 INFO - 2016-01-25 11:42:12,348 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:42:12 INFO - 2016-01-25 11:42:12,348 DEBUG : BROWSER_OUTPUT: 11:42:13 INFO - 2016-01-25 11:42:13,110 INFO : Browser exited with error code: 0 11:42:13 INFO - 2016-01-25 11:42:13,124 INFO : Completed test v8_7 (00:00:40) 11:42:13 INFO - 2016-01-25 11:42:13,412 INFO : Completed test suite (00:20:20) 11:42:13 INFO - 2016-01-25 11:42:13,412 DEBUG : Working with test: dromaeo_css 11:42:13 INFO - 2016-01-25 11:42:13,412 DEBUG : Generating results file: dromaeo_css 11:42:13 INFO - 2016-01-25 11:42:13,413 DEBUG : Working with test: kraken 11:42:13 INFO - 2016-01-25 11:42:13,414 DEBUG : Generating results file: kraken 11:42:13 INFO - 2016-01-25 11:42:13,414 INFO : javascript benchmark 11:42:13 INFO - 2016-01-25 11:42:13,414 DEBUG : Working with test: v8_7 11:42:13 INFO - 2016-01-25 11:42:13,414 DEBUG : Generating results file: v8_7 11:42:13 INFO - 2016-01-25 11:42:13,415 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:42:13 INFO - 2016-01-25 11:42:13,470 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,35]] 11:42:13 INFO - 2016-01-25 11:42:13,470 DEBUG : process_Request line: dromaeo_css 7299.95 graph.html#tests=[[72,52,35]] 11:42:13 INFO - 2016-01-25 11:42:13,471 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:42:13 INFO - 2016-01-25 11:42:13,503 DEBUG : process_Request line: kraken 1476.20 graph.html#tests=[[232,52,35]] 11:42:13 INFO - 2016-01-25 11:42:13,503 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:42:13 INFO - 2016-01-25 11:42:13,536 DEBUG : process_Request line: v8_7 23080.30 graph.html#tests=[[230,52,35]] 11:42:13 INFO - 2016-01-25 11:42:13,538 INFO : javascript benchmark 11:42:13 INFO - 2016-01-25 11:42:13,541 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3197.2006998250436, 3224.596925384327, 3254.088855120567, 3257.576515053043, 3269.0356344878264, 5436.347638283407, 5439.5104440600335, 5448.536874365674, 5451.836444906654, 5493.368262649791, 5450.04624190767, 5454.372747134081, 5468.589855760814, 5471.0, 5471.945280547194, 4807.855764327058, 4873.5613794758465, 4941.3329200558, 4979.526944940243, 5007.699538027712, 4921.803127874899, 4969.776360063805, 4989.875253118665, 4991.351124353829, 4998.200287953928, 4873.463918968929, 4961.751912404384, 4987.326710894037, 5004.299398084253, 5029.396472423315, 4961.578265847407, 4970.179920313144, 4999.87502811868, 5018.5232402921665, 5051.747412629391, 4768.928466073012, 4943.975280123613, 4966.975165124188, 4983.501649835024, 4991.026749783794, 5141.254518094893, 5207.036698210805, 5233.712145831978, 5283.207518872162, 5289.338832645919, 5846.853828654275, 5868.823935281948, 5884.588078834483, 5925.111233314994, 5925.911111333334, 5677.489025987639, 5955.851103722398, 5963.045912653998, 5971.880562388771, 5972.641641501524, 5357.812476563302, 5481.451854814526, 5586.16207568868, 5608.85977850557, 5617.80337688183, 6032.909506357408, 6049.274087109575, 6056.36408177135, 6060.454559089703, 6066.787662431882, 5592.0, 5795.681237531976, 5812.738426770806, 5813.651180929158, 5847.766089356463, 5754.165645981309, 5761.827145185651, 5833.591648584643, 5850.824475265749, 5853.560982926298, 5809.186713860063, 5814.156947242626, 5852.707364631837, 5862.530997520188, 5864.38423965486, 5791.942080579141, 5819.185314056035, 5854.063349864086, 5855.063189889683, 5864.501517370986, 4349.391085248068, 4422.624076953431, 4434.401355816924, 4484.708493947883, 4508.098380323949, 4034.616711412411, 4045.8583949561626, 4060.451839001756, 4069.715119941635, 4070.063885306337, 5401.378841433207, 5548.278723765965, 5556.277683901067, 5559.360673522597, 5566.192902029264, 5774.191613174159, 5828.358880523224, 5841.1238314253205, 5854.121881717691, 5858.648481091148, 5538.584606154554, 5542.86142846424, 5554.361248456398, 5559.277293951841, 5564.081926482166, 5114.411842638145, 5120.92318615221, 5131.486851314913, 5134.075866344094, 5165.612579056586, 5858.882822343529, 5902.734376953047, 6008.909866352008, 6027.638341699424, 6084.999999999912, 5844.47399734009, 5849.064149736022, 5854.853628659318, 5861.677607731615, 5863.912041319299, 5870.647761134345, 6002.939970600238, 6048.0625503047095, 6048.939510605013, 6056.424639659225, 5672.262605861377, 5697.373288938296, 5728.684922329312, 5751.827445176651, 5780.046292361713, 5884.852878678067, 5899.616524925866, 5926.911096333644, 5928.822135335947, 5932.644041357532, 5519.9448005521035, 5619.494245517923, 5773.24947756789, 5787.508061814793, 5791.0, 5599.720013999366, 5668.5465162787705, 5671.461211184931, 5672.943270567242, 5704.657720536781, 5657.066584013756, 5668.26312579362, 5669.829905102853, 5674.460926212003, 5676.659400435987, 5546.057170280981, 5579.330480342385, 5642.605017648725, 5742.885142297214, 5787.276590426197, 5598.608097433141, 5671.574631902541, 5695.0, 5697.800576979786, 5705.372409035086], "unit": "ms", "name": "dojo.html", "value": 5390.962569911806}, {"lowerIsBetter": false, "replicates": [594.7085927895332, 640.564416196986, 649.156097073804, 659.47242206235, 660.3990368764422, 31869.68130318699, 32656.510152347735, 41987.37018944718, 42774.14451710964, 42809.78595107028, 47876.521234787644, 48335.27497087546, 48415.51584484154, 48430.27354589684, 48453.27320090202, 8007.51954882706, 8128.536863364592, 9160.038195989426, 9312.30157738169, 9318.953405232964, 10948.3978381189, 11124.221304508688, 11135.276207046556, 11156.274842135235, 11167.720806979809, 10982.945085274563, 11095.944520277428, 11107.0, 11112.888871111307, 11119.221654484189, 8108.513489190638, 8221.301189398908, 8255.793605159859, 8260.421770476069, 10953.83569246462, 11024.338539687644, 11276.661700149009, 11280.548778048951, 11286.040686541653, 11296.548138074468, 43877.56122438767, 44108.558914410765, 44302.0, 44389.33415998763, 44402.333964990554, 3505.439129739255, 3683.6684698377007, 3751.381022131345, 3827.559830619459, 3847.0, 33846.49230261548, 34035.48946765801, 34315.48526772075, 34337.313253734785, 34348.82825585881, 3620.529331186955, 3767.7362584619086, 3781.659650631429, 3798.0, 3833.4441505981754, 299284.0, 300889.0, 301217.0, 303477.0, 303676.0, 61868.0, 63044.68477657674, 68242.0, 68639.0, 68719.65640171767, 79950.0, 81714.59142704248, 81878.72485100529, 81929.18070819335, 82021.58989205016, 17510.474685759447, 17768.200430980636, 17784.644307113784, 17788.733169002477, 17835.0, 12257.448414821354, 12280.447379867928, 12291.508339666314, 12299.200551964093, 12300.692482687826, 22527.211547595754, 22777.0, 22925.656115158286, 22948.0, 22962.65556016661, 8159.98241512299, 8482.915170848337, 8489.872651910226, 8500.27747641445, 8507.276881465144, 1004.7588578741196, 1045.0124632222478, 1050.4327663062013, 1147.5753971030772, 1188.3820413385165, 29349.559756603667, 29491.262718432212, 29748.55377169344, 29855.850720746257, 30552.84723576368, 1148.9712757181137, 1159.721666799962, 1191.124523475245, 1194.8745381734966, 1229.4959066782576, 15529.145896975775, 15826.0, 15896.523104306889, 18373.356932507297, 18427.0, 465993.0, 471519.0, 472852.0, 473278.0, 473388.0, 60672.39327606667, 60888.0, 61451.692741536004, 61476.0, 61508.0, 1362.2848004797363, 1480.415235981781, 1488.0773920169563, 1490.2176357412445, 1589.4119175904757, 30745.846270769398, 30957.535636965913, 31227.219319517193, 31576.842115789274, 32129.0, 49338.50661493483, 49615.50384496109, 50064.249036263755, 50709.74645126751, 56427.0, 208248.0, 208273.0, 209831.0, 210044.0, 210480.0, 32679.18302042468, 33063.50404743979, 33073.0, 33073.173170669965, 33090.834545827114, 44003.559964399945, 44117.0, 44682.77658611816, 44757.77621111873, 45489.54510454853, 37349.25301494009, 39740.80129599333, 46170.76914615405, 46971.0, 48485.272720908506, 45623.31565026461, 45625.77187114176, 46533.0, 46728.29907551457, 47182.76408617935, 39368.60631393649, 39968.800156000194, 40136.799316003235, 40193.79903100466, 40198.39702404525, 35519.82240088783, 36419.45370819387, 36890.0, 36968.07579810526, 37097.6290237105, 26973.3256668577, 27237.45525089527, 27269.45461090807, 27319.86340068287, 27370.726292737614], "unit": "ms", "name": "ext.html", "value": 20607.56600599235}, {"lowerIsBetter": false, "replicates": [360.4935066231945, 367.31495760406847, 381.72515788632194, 382.54406708928667, 385.32183357291166, 16468.423605173823, 17038.91480542597, 18634.161462734177, 18746.99999999998, 19105.331313404033, 11798.528058877657, 11966.700832479193, 12050.397480125981, 18577.0, 18789.0, 3974.1455587048777, 5096.413912400066, 5210.921836172461, 5212.113940630083, 5212.791488340462, 4043.090304681438, 4055.675545956331, 4059.9797001014954, 4074.5110586729634, 5617.859553511154, 5721.628094173865, 5764.365919748845, 5766.855828604276, 5774.335951365584, 5841.591088623798, 6101.389861013885, 6166.84582885427, 6174.0, 6176.938230617681, 6180.660063696495, 5417.0, 5525.972370138164, 5527.336719593634, 5528.198411230389, 5567.972160139173, 14196.645083872883, 14355.282235888164, 14359.928200359036, 14463.493777717835, 14517.056391334529, 2214.3689048621227, 2270.8296877734238, 2322.129201549419, 2403.9639405408934, 2455.5579995600965, 9890.20878329732, 10094.192464602815, 13283.60149195516, 13934.721305573934, 14424.639384015378, 1909.493984094216, 1937.6415363157862, 1950.8439324853978, 1975.5258737902943, 1976.6046790641785, 66898.66550667264, 69591.0, 71024.28975710229, 71598.0, 72094.63952680255, 10042.748931276776, 10224.488775561193, 10353.534090965924, 10363.32638378503, 10453.21600879937, 13253.536126235536, 13261.867381326256, 13274.0, 13289.401976911062, 13322.333883305795, 7970.561619111005, 7983.2415920487465, 7987.520748755093, 7999.520028798291, 8017.398695097891, 8174.182581741778, 8182.263596276363, 8199.95900020496, 8246.299064579578, 8252.257296843312, 4210.7473551587, 4212.241796476664, 4234.1108367242605, 4237.978810105991, 4244.214820258262, 1795.7126859702385, 1838.301445450747, 1840.7115019486146, 1934.8355389791743, 1944.9027548622512, 446.3750748951429, 469.99295010574866, 506.3746273352407, 953.5422996961358, 1112.9054030407344, 10725.946370268099, 11542.19204655666, 11782.234154779911, 12092.395380230953, 12465.439055242536, 512.075703355447, 528.8096285337275, 936.2182577547687, 967.3180407812475, 1019.3527110285022, 7303.780886573411, 9824.263180261509, 9896.60413583463, 9918.206543476505, 10118.595256189818, 678737.0, 682490.0, 687961.0, 708178.0, 713119.0, 88043.55978220068, 89080.0, 91183.54408227916, 91328.0, 92458.53770731103, 1182.456070207714, 1186.1874615888144, 1188.8276199950958, 1190.5475919150667, 1191.065013964034, 15989.840101598835, 16146.273417696466, 16260.837391625932, 16306.613937815418, 16394.344226230816, 22520.0, 35216.11959701028, 35849.283014340086, 36286.27427451383, 36501.45247821232, 50019.49980500294, 50612.0, 50954.49045509497, 51646.48353516567, 54102.18846717224, 10587.470626468492, 10639.095676867244, 10644.095251903675, 10785.352878827296, 10800.0, 16191.271392787117, 19375.546833987224, 19540.31608893682, 19854.50363740918, 19942.50143746418, 16059.116748578941, 16074.276657550672, 16212.67574648524, 16513.256903439615, 16535.338586456408, 15654.608634784221, 15891.761623575887, 15954.60113497172, 16262.349506019627, 16513.33946642121, 13594.660133496345, 15703.293351799424, 15996.120213388376, 16128.193590320672, 16281.18594070268, 9945.900540994788, 10116.898831011596, 10376.636817711344, 10404.0, 10424.739381515523, 10630.893691062991, 10762.46187690628, 10916.672499825017, 10948.45257737126, 11101.333919964827], "unit": "ms", "name": "jquery.html", "value": 8966.027798406272}, {"lowerIsBetter": false, "replicates": [1409.3305679802088, 1558.290977605189, 1563.5856498028018, 1813.8911665300084, 1841.0426578179347, 6943.444524438046, 7374.041374621298, 7502.062242219723, 7513.511621744583, 7513.69945202192, 7595.9620201898915, 7848.372130229583, 7857.960710196441, 7862.213778622135, 7868.0, 1841.1346667066457, 1884.4911873794135, 2171.6525355943054, 2179.978200217993, 2213.513027134036, 2238.876861772602, 2240.137547044383, 2246.4608493961496, 2254.8534345267503, 2255.650374192003, 2076.9584608307823, 2135.028562004292, 2152.5156839711094, 2155.9892200538975, 2158.0396723458066, 2208.238157835552, 2235.3964429604, 2244.607193741097, 2279.943001424978, 2280.5096904165684, 2244.102359056374, 2246.3597874605657, 2273.6703178039093, 2273.783990520898, 2279.87460689662, 7703.653335599912, 7757.340626046793, 7759.9612001940195, 7764.805879852993, 7771.922280777233, 4514.796834142471, 4533.52397998212, 4539.296409056601, 4547.045120524694, 4629.398178236841, 2975.8809647614285, 2994.595729576501, 3027.3945210957677, 3046.6039414876145, 3080.553319768621, 1017.5268500147467, 1017.6896046705751, 1037.1132681557235, 1038.709161434792, 1052.7736536644582, 10323.019313165161, 10336.5348559315, 10340.844887326695, 10355.534000969974, 10359.22305827066, 4043.5147782266317, 4061.8578349757618, 4093.2427500912427, 4101.9950112222095, 4116.0, 9008.189262966365, 9010.053944335881, 9015.413998090104, 9017.594208260643, 9024.413413128126, 4569.543045695404, 4620.399348084795, 4620.792064357112, 4622.0, 4623.791929363187, 4195.622393984495, 4234.87295381139, 4243.0, 4243.618074373321, 4245.660347172219, 3329.267561136546, 3352.6479719629574, 3542.557180352456, 3598.712103031751, 3661.7253705972157, 1140.937248451343, 1141.7259857634274, 1142.5943789954613, 1145.352875625269, 1148.6496618531262, 1182.9290242585473, 1190.5773450425147, 1210.431097384228, 1467.039089396447, 1489.3521318226606, 7237.601931893796, 7238.384737297389, 7252.311030452099, 7354.374878135419, 7464.85070298591, 1143.451143451148, 1163.66253786401, 1170.280277629269, 1213.6177104212145, 1218.6405010521917, 5809.622374545641, 5881.852953676193, 5885.852853678693, 5896.262967129109, 5902.0, 8676.089010653917, 9157.816843663222, 9289.16397524226, 9294.953525232331, 9323.580438880266, 9043.638254469879, 9102.499362534993, 9192.310576706774, 9214.447133171898, 9216.677416290398, 7195.172555156119, 7243.022192004118, 7253.202147763742, 7277.345038946414, 7320.926790732131, 7214.855702886018, 7249.347558719741, 7276.854462910818, 7289.271072892669, 7298.489105762758, 7968.521888686697, 7974.760757177294, 8077.798055048435, 8089.271965523131, 8262.215089566482, 8263.628136733741, 8279.710210142615, 8447.91552084496, 8452.704155354533, 8454.957725211334, 6630.436412904957, 6902.654867256718, 6921.757738479129, 6921.792346229621, 6925.480588955747, 6609.537332386687, 6939.930600693929, 6949.444044476329, 7191.748288809867, 7508.924910750822, 7096.396806271525, 7135.571865688075, 7168.784936451915, 7198.244184360776, 7250.709971601077, 6964.965175174092, 6966.303369662993, 7082.964585177041, 7099.041629379967, 7170.498065135391, 7130.4625326605765, 7157.7136914522835, 7196.4962452627815, 7202.603856787927, 7208.855822883618, 6582.868342633024, 6629.105070815571, 6633.0, 6638.601683898982, 6638.668066596748, 6628.072069910313, 6661.034150048313, 6675.165604299463, 6679.966600166968, 6683.298253683293], "unit": "ms", "name": "mootools.html", "value": 4460.778766989285}, {"lowerIsBetter": false, "replicates": [355.4419561288777, 358.541067433685, 359.3728942994475, 359.559539564034, 363.54919899324847, 6008.459238668519, 6159.969200153993, 6167.784127555531, 6177.9382206177925, 6184.041473571592, 5947.791827286046, 6063.181470501481, 6102.420270074347, 6117.051856962167, 6118.449339559439, 4732.810687572493, 4736.242201247801, 4737.099951009297, 4748.240281554952, 4748.3589715388325, 4533.2066888294585, 4591.816327346902, 4624.12141693079, 4735.384400027991, 4738.90522189556, 4666.510016448275, 4686.343911852344, 4697.459792123898, 4711.693739906895, 4711.929321060187, 4682.6253899687945, 4703.082898834746, 4716.033213191287, 4717.1980763269985, 4756.7859446325, 4170.207660544487, 4174.958250417488, 4180.435641188431, 4191.643710284629, 4192.266353388145, 5738.167965644958, 5818.679972601505, 5820.243368362128, 5854.47309742121, 5888.5289176865745, 5467.9453205467835, 5469.890602187974, 5479.068558345051, 5481.369642491125, 5481.725913704299, 6222.968885155546, 6411.166548348731, 6469.547131700783, 6502.7398904043785, 6507.6420796856155, 4369.388285640013, 4556.749378784166, 4624.468186158601, 4625.375574297461, 4640.628749700016, 6671.699773510204, 6765.966170169167, 6777.288384719632, 6779.966100169468, 6789.694463749143, 4782.3543821584335, 4783.808647654125, 4787.305840653085, 4791.185498465269, 4795.20879054952, 4777.4267087949665, 4851.902961940741, 4865.221564549655, 4871.415430148405, 4875.7074575525585, 5519.751611177507, 5520.033994051106, 5520.558355331564, 5525.475079867406, 5527.53015993637, 6522.706478208492, 6524.151860258136, 6528.771492997722, 6536.7712130075215, 6538.803835884931, 1704.582377317565, 1719.7162468192857, 1719.819418960991, 1721.5868191633917, 1723.8103808581045, 1177.6584790410857, 1185.3421351150193, 1187.2935603316014, 1189.167582692119, 1195.6891208285733, 6228.5017198624, 6281.78013769525, 6287.528435367274, 6289.182406287154, 6295.496360291166, 6691.665416729144, 6694.397504224643, 6696.732130714717, 6698.22970358415, 6705.664716764142, 6272.466840318532, 6272.686365681789, 6275.435210831047, 6279.811605651837, 6286.528510361742, 3588.3361578108133, 3676.540432445944, 3681.0245284999496, 3682.6685598295744, 3684.705223582107, 7054.506184567031, 7074.787756367317, 7078.893816592756, 7079.92920070803, 7096.787096387116, 6855.108835851307, 6944.722211111499, 6980.825479363057, 6986.231514533397, 6988.6855091521, 6996.370326670624, 7002.334778196063, 7021.368076873106, 7063.752768653072, 7065.328793764585, 6496.220453545416, 6686.465082793462, 6727.966360168168, 6773.62745049027, 6775.288594697486, 6646.468282537482, 6701.262861085374, 6715.93284067153, 6729.1924969002075, 6734.8653026940165, 6982.371586557234, 7037.507374483737, 7045.225025247116, 7046.260142684944, 7049.436045116276, 4597.655175861757, 4644.303354496852, 4665.953340466552, 4679.555442232982, 4684.344191813081, 6736.393724564813, 6762.695678694372, 6788.355106264897, 6793.490488213305, 6801.625910574966, 6590.868182636224, 6606.10817539626, 6610.272869984202, 6611.140551728245, 6615.0, 6472.546921715623, 6598.868022639616, 6605.976073708583, 6609.669516524058, 6610.305917878553, 6475.838104047437, 6476.125723027331, 6480.935190648033, 6485.77299794505, 6489.5781774184525, 6605.933940660532, 6653.0, 6653.900191497035, 6663.100481435138, 6665.366790154928, 6350.618962862243, 6438.937575300023, 6465.612063276219, 6467.482601391784, 6475.579087359307], "unit": "ms", "name": "prototype.html", "value": 4971.440479768804}, {"lowerIsBetter": false, "replicates": [900.9279257659385, 917.6788124156544, 927.5130556457863, 936.134075979719, 954.5131982688827, 14954.775678364833, 15254.618634534143, 15268.16025118618, 17190.74213886793, 17700.822991770077, 16057.759133612975, 16095.919520402382, 16117.758233626504, 16159.83840161598, 16204.83795162048, 896.2874514760764, 914.008300993423, 914.7667344827094, 915.0300681277866, 915.199200699388, 763.0080894836718, 769.9730509432171, 905.4748246017294, 907.7412937312868, 914.711865762286, 945.4091193004373, 946.356477595235, 953.5184731710476, 954.1460392948308, 954.2175416158752, 793.821390187209, 795.645937557787, 945.8202941441139, 950.1638558068925, 950.7147855643314, 705.4039336760429, 708.9113860767404, 715.7494876793132, 719.0723966083746, 720.0747040053506, 14960.62598435037, 15069.397224111022, 15095.320710567941, 15098.622534436618, 15126.773098403533, 12334.691632709164, 12683.239005659598, 12727.172733772368, 12860.807087893596, 13062.477500899953, 11026.503807328609, 11207.159463040305, 11244.662660120128, 11431.428428578538, 11849.881501184964, 3651.1054791575966, 3679.4296883983025, 3689.760165589255, 3701.3522633539023, 3745.7190710696536, 53926.0, 53929.0, 54046.45953540454, 54137.729311353585, 54504.18243726347, 9801.117899388946, 10007.199424046059, 10029.946855580205, 10853.45732713377, 11197.66407007791, 19894.70157947632, 20052.298169563994, 20066.89966550158, 20070.297539586045, 20080.39758807209, 7778.8055298616855, 7911.406644501571, 8041.517508949481, 8064.717734879251, 8194.754157375288, 4938.456769755324, 4946.752662366867, 4973.104841128559, 4975.626827987915, 5047.343845300161, 3333.1833700743473, 3339.632640409553, 3355.3960287148548, 3356.3287342531103, 3360.0423879194313, 545.2148905575958, 558.2324304081887, 562.4010428893216, 568.0995621939272, 568.5394830187562, 632.6741728010079, 671.1677519875319, 709.670003448399, 722.1298335505703, 740.9433352395591, 8868.379213455126, 8928.330375221754, 8929.776755581033, 9237.722868313962, 10052.899471005343, 703.5673061067407, 719.2914978745931, 751.3726038757699, 751.8909608327782, 776.8174478997431, 4204.180184863983, 4471.195184866755, 4518.909621807546, 4528.909421811545, 4553.908921821545, 62908.0, 64575.0, 64771.0, 64889.67555162194, 65062.0, 55111.44888551063, 55705.72147139238, 55764.72117639386, 56149.0, 56850.71574642183, 50934.74532627313, 51370.74314628403, 51951.0, 52290.738546307024, 53070.0, 8503.532305723245, 8720.738377848675, 8870.068642792414, 9415.387999779992, 9460.148586627236, 34991.65008349884, 35993.460098098025, 37136.44295335518, 37202.627973721, 37371.439428408055, 47464.28803568018, 47707.76146119247, 48151.277730834765, 48911.755441222565, 49006.5099349002, 10526.368417894952, 10542.26204165701, 10845.295055821347, 11421.942890285496, 11954.103442241692, 13193.60419187426, 13345.799813002619, 13353.866461335263, 13708.3831227593, 14004.299785010913, 10592.470376481298, 10854.620088296871, 10871.836922446328, 10928.50821713009, 10936.398498082683, 11840.940795295968, 11946.462409191434, 12426.528971430627, 12654.936725316315, 12847.229166250056, 10157.54291056919, 10772.784544308914, 12304.507819687113, 12450.875491244971, 13056.543020994219, 10622.521986510472, 10758.085562727256, 10894.182936279969, 10956.945215273872, 11045.447727613426, 9717.368371055858, 9826.803463930824, 9919.504024798587, 10066.949665251626, 10097.394156350643], "unit": "ms", "name": "yui.html", "value": 6849.999217199046}], "name": "dromaeo_css", "value": 7299.945675963496}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 103.0, 110.0, 111.0, 111.0, 100.0, 111.0, 110.0, 100.0], "unit": "ms", "name": "ai-astar", "value": 107.7}, {"lowerIsBetter": true, "replicates": [149.0, 120.0, 149.0, 169.0, 123.0, 145.0, 151.0, 126.0, 163.0, 124.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.9}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 161.0, 162.0, 159.0, 160.0, 159.0, 159.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.3}, {"lowerIsBetter": true, "replicates": [72.0, 70.0, 71.0, 142.0, 71.0, 73.0, 70.0, 71.0, 156.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 86.9}, {"lowerIsBetter": true, "replicates": [91.0, 92.0, 144.0, 93.0, 91.0, 92.0, 134.0, 91.0, 92.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 105.1}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0, 110.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 55.0, 56.0, 57.0, 55.0, 56.0, 55.0, 53.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 55.1}, {"lowerIsBetter": true, "replicates": [62.0, 63.0, 64.0, 63.0, 64.0, 67.0, 63.0, 63.0, 64.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.7}, {"lowerIsBetter": true, "replicates": [87.0, 80.0, 81.0, 81.0, 81.0, 81.0, 82.0, 90.0, 81.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.6}, {"lowerIsBetter": true, "replicates": [111.0, 115.0, 111.0, 109.0, 126.0, 111.0, 116.0, 114.0, 116.0, 113.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 114.2}, {"lowerIsBetter": true, "replicates": [134.0, 150.0, 147.0, 157.0, 137.0, 138.0, 147.0, 148.0, 138.0, 137.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.3}, {"lowerIsBetter": true, "replicates": [67.0, 64.0, 66.0, 64.0, 65.0, 66.0, 64.0, 66.0, 65.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.1}], "name": "kraken", "value": 1476.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.01650165016503], "unit": "score", "name": "Richards", "value": 213.9301200000001}, {"lowerIsBetter": false, "replicates": [167.19612104999163], "unit": "score", "name": "DeltaBlue", "value": 395.4517579999999}, {"lowerIsBetter": false, "replicates": [279.87685418415896], "unit": "score", "name": "Encrypt", "value": 951.0647130000004}, {"lowerIsBetter": false, "replicates": [5235.602094240838], "unit": "score", "name": "Decrypt", "value": 50.84057100000005}, {"lowerIsBetter": false, "replicates": [946.073793755913], "unit": "score", "name": "RayTrace", "value": 782.1683729999996}, {"lowerIsBetter": false, "replicates": [553.7098560354374], "unit": "score", "name": "Earley", "value": 1203.6321779999998}, {"lowerIsBetter": false, "replicates": [10989.010989010989], "unit": "score", "name": "Boyer", "value": 60.64813299999995}, {"lowerIsBetter": false, "replicates": [23976.190476190477], "unit": "score", "name": "RegExp", "value": 37.995402184707075}, {"lowerIsBetter": false, "replicates": [538.7931034482758], "unit": "score", "name": "Splay", "value": 151.24729599999998}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 23080.29844395567}]} 11:42:13 INFO - RETURN: dromaeo_css: 7299.95 11:42:13 INFO - RETURN: kraken: 1476.20 11:42:13 INFO - RETURN: v8_7: 23080.30 11:42:13 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,35]]", "result": "23080.30"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,35]]", "result": "1476.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,35]]", "result": "7299.95"}}} 11:42:13 INFO - Return code: 0 11:42:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:42:13 INFO - # TBPL SUCCESS # 11:42:13 INFO - Running post-action listener: _resource_record_post_action 11:42:13 INFO - Running post-run listener: _resource_record_post_run 11:42:14 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 8163328; Write bytes: 401768448; Read time: 2648; Write time: 812160 11:42:14 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 5156864; Read time: 0; Write time: 456 11:42:14 INFO - run-tests - Wall time: 1222s; CPU: 13.0%; Read bytes: 6426624; Write bytes: 396611584; Read time: 2608; Write time: 811704 11:42:14 INFO - Running post-run listener: _upload_blobber_files 11:42:14 INFO - Blob upload gear active. 11:42:14 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:42:14 INFO - Copying logs to upload dir... 11:42:14 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1284.225442 ========= master_lag: -0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-01-25 11:42:14.723337) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-25 11:42:14.726803) ========= 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=5cf47e208febbcd81da23b2e0000026f-1453749648.78248-2057032723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009765 build_url: 'https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-25 11:42:14.778999) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:42:14.779386) ========= 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=5cf47e208febbcd81da23b2e0000026f-1453749648.78248-2057032723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004658 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:42:14.832114) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 11:42:14.833003) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 11:42:14.833689) ========= ========= Total master_lag: 0.15 =========