builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-008 starttime: 1453509459.85 results: success (0) buildid: 20160122140553 builduid: 4dc614e7ca3642e89df580e2d6ed592b revision: 1fa9b8e51c285b27bf7730655d7c0385d83383f8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:39.849319) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:39.850008) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:39.850327) ========= 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=32c5991c409366f7fec8a718000001d2-1453509391.88383-1622690170 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006368 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:39.887492) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:39.887818) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:39.906740) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:39.907024) ========= 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=32c5991c409366f7fec8a718000001d2-1453509391.88383-1622690170 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004570 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:39.956713) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:39.957062) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:39.957460) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:39.957788) ========= 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=32c5991c409366f7fec8a718000001d2-1453509391.88383-1622690170 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-22 16:37:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-01-22 16:37:40 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096954 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:40.073033) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:40.073361) ========= 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=32c5991c409366f7fec8a718000001d2-1453509391.88383-1622690170 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022414 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:40.128451) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:40.128835) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1fa9b8e51c285b27bf7730655d7c0385d83383f8 --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 1fa9b8e51c285b27bf7730655d7c0385d83383f8 --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=32c5991c409366f7fec8a718000001d2-1453509391.88383-1622690170 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-22 16:37:40,661 truncating revision to first 12 chars 2016-01-22 16:37:40,661 Setting DEBUG logging. 2016-01-22 16:37:40,661 attempt 1/10 2016-01-22 16:37:40,661 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1fa9b8e51c28?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-22 16:37:40,894 unpacking tar archive at: mozilla-aurora-1fa9b8e51c28/testing/mozharness/ program finished with exit code 0 elapsedTime=0.511025 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:40.652963) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:40.653343) ========= echo 1fa9b8e51c285b27bf7730655d7c0385d83383f8 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'1fa9b8e51c285b27bf7730655d7c0385d83383f8'] 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=32c5991c409366f7fec8a718000001d2-1453509391.88383-1622690170 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 1fa9b8e51c285b27bf7730655d7c0385d83383f8 program finished with exit code 0 elapsedTime=0.003343 script_repo_revision: '1fa9b8e51c285b27bf7730655d7c0385d83383f8' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:40.701323) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:40.701638) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 16:37:40.711698) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-01-22 16:37:40.712022) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1453509391.88383-1622690170 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:37:41 INFO - MultiFileLogger online at 20160122 16:37:41 in /builds/slave/test-pgo 16:37:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 16:37:41 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:37:41 INFO - {'append_to_log': False, 16:37:41 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:37:41 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:37:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:37:41 INFO - 'branch': 'Mozilla-Aurora', 16:37:41 INFO - 'buildbot_json_path': 'buildprops.json', 16:37:41 INFO - 'config_files': ('talos/linux_config.py',), 16:37:41 INFO - 'default_actions': ('clobber', 16:37:41 INFO - 'read-buildbot-config', 16:37:41 INFO - 'download-and-extract', 16:37:41 INFO - 'populate-webroot', 16:37:41 INFO - 'create-virtualenv', 16:37:41 INFO - 'install', 16:37:41 INFO - 'run-tests'), 16:37:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:37:41 INFO - 'download_minidump_stackwalk': True, 16:37:41 INFO - 'download_symbols': 'ondemand', 16:37:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:37:41 INFO - 'tooltool.py': '/tools/tooltool.py', 16:37:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:37:41 INFO - '/tools/misc-python/virtualenv.py')}, 16:37:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:37:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:37:41 INFO - 'installer_path': 'installer.exe', 16:37:41 INFO - 'log_level': 'info', 16:37:41 INFO - 'log_name': 'talos', 16:37:41 INFO - 'log_to_console': True, 16:37:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:37:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:37:41 INFO - 'opt_config_files': (), 16:37:41 INFO - 'pip_index': False, 16:37:41 INFO - 'sps_profile': False, 16:37:41 INFO - 'sps_profile_interval': 0, 16:37:41 INFO - 'suite': 'dromaeojs-e10s', 16:37:41 INFO - 'system_bits': '32', 16:37:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:37:41 INFO - 'title': 'talos-linux64-ix-008', 16:37:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:37:41 INFO - 'use_talos_json': True, 16:37:41 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:37:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:37:41 INFO - 'work_dir': 'build'} 16:37:41 INFO - ##### 16:37:41 INFO - ##### Running clobber step. 16:37:41 INFO - ##### 16:37:41 INFO - Running pre-action listener: _resource_record_pre_action 16:37:41 INFO - Running main action method: clobber 16:37:41 INFO - rmtree: /builds/slave/test-pgo/build 16:37:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:37:41 INFO - Running post-action listener: _resource_record_post_action 16:37:41 INFO - ##### 16:37:41 INFO - ##### Running read-buildbot-config step. 16:37:41 INFO - ##### 16:37:41 INFO - Running pre-action listener: _resource_record_pre_action 16:37:41 INFO - Running main action method: read_buildbot_config 16:37:41 INFO - Using buildbot properties: 16:37:41 INFO - { 16:37:41 INFO - "properties": { 16:37:41 INFO - "buildnumber": 104, 16:37:41 INFO - "product": "firefox", 16:37:41 INFO - "script_repo_revision": "production", 16:37:41 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 16:37:41 INFO - "repository": "", 16:37:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 16:37:41 INFO - "buildid": "20160122140553", 16:37:41 INFO - "slavename": "talos-linux64-ix-008", 16:37:41 INFO - "pgo_build": "True", 16:37:41 INFO - "basedir": "/builds/slave/test-pgo", 16:37:41 INFO - "project": "", 16:37:41 INFO - "platform": "ubuntu64_hw", 16:37:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:37:41 INFO - "slavebuilddir": "test", 16:37:41 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 16:37:41 INFO - "branch": "mozilla-aurora", 16:37:41 INFO - "repo_path": "releases/mozilla-aurora", 16:37:41 INFO - "stage_platform": "linux64-pgo", 16:37:41 INFO - "builduid": "4dc614e7ca3642e89df580e2d6ed592b", 16:37:41 INFO - "revision": "1fa9b8e51c285b27bf7730655d7c0385d83383f8" 16:37:41 INFO - }, 16:37:41 INFO - "sourcestamp": { 16:37:41 INFO - "repository": "", 16:37:41 INFO - "hasPatch": false, 16:37:41 INFO - "project": "", 16:37:41 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 16:37:41 INFO - "changes": [ 16:37:41 INFO - { 16:37:41 INFO - "category": null, 16:37:41 INFO - "files": [ 16:37:41 INFO - { 16:37:41 INFO - "url": null, 16:37:41 INFO - "name": "https://queue.taskcluster.net/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 16:37:41 INFO - } 16:37:41 INFO - ], 16:37:41 INFO - "repository": "", 16:37:41 INFO - "rev": "1fa9b8e51c285b27bf7730655d7c0385d83383f8", 16:37:41 INFO - "who": "eakhgari@mozilla.com", 16:37:41 INFO - "when": 1453509401, 16:37:41 INFO - "number": 7503740, 16:37:41 INFO - "comments": "Bug 1240916 - Part 2: Update the en-US dictionary to SCOWL 2016.01.19 a=sylvestre\n", 16:37:41 INFO - "project": "", 16:37:41 INFO - "at": "Fri 22 Jan 2016 16:36:41", 16:37:41 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 16:37:41 INFO - "revlink": "", 16:37:41 INFO - "properties": [ 16:37:41 INFO - [ 16:37:41 INFO - "buildid", 16:37:41 INFO - "20160122140553", 16:37:41 INFO - "Change" 16:37:41 INFO - ], 16:37:41 INFO - [ 16:37:41 INFO - "builduid", 16:37:41 INFO - "4dc614e7ca3642e89df580e2d6ed592b", 16:37:41 INFO - "Change" 16:37:41 INFO - ], 16:37:41 INFO - [ 16:37:41 INFO - "pgo_build", 16:37:41 INFO - "True", 16:37:41 INFO - "Change" 16:37:41 INFO - ] 16:37:41 INFO - ], 16:37:41 INFO - "revision": "1fa9b8e51c285b27bf7730655d7c0385d83383f8" 16:37:41 INFO - } 16:37:41 INFO - ], 16:37:41 INFO - "revision": "1fa9b8e51c285b27bf7730655d7c0385d83383f8" 16:37:41 INFO - } 16:37:41 INFO - } 16:37:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 16:37:41 INFO - Running post-action listener: _resource_record_post_action 16:37:41 INFO - ##### 16:37:41 INFO - ##### Running download-and-extract step. 16:37:41 INFO - ##### 16:37:41 INFO - Running pre-action listener: _resource_record_pre_action 16:37:41 INFO - Running main action method: download_and_extract 16:37:41 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:37:41 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')]} 16:37:41 INFO - https://queue.taskcluster.net/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:37:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/test_packages.json 16:37:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/test_packages.json 16:37:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:37:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:37:45 INFO - Downloaded 1302 bytes. 16:37:45 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:37:45 INFO - Using the following test package requirements: 16:37:45 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 16:37:45 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:37:45 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 16:37:45 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:37:45 INFO - u'jsshell-linux-x86_64.zip'], 16:37:45 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:37:45 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 16:37:45 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 16:37:45 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:37:45 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 16:37:45 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:37:45 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 16:37:45 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:37:45 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 16:37:45 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 16:37:45 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:37:45 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 16:37:45 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:37:45 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')]} 16:37:45 INFO - https://queue.taskcluster.net/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:37:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:37:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:37:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/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 16:37:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/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 16:37:54 INFO - Downloaded 23159542 bytes. 16:37: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 16:37:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:37: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 16:37:55 INFO - Return code: 0 16:37: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 16:37: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')]} 16:37:55 INFO - https://queue.taskcluster.net/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:37:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:37:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:37:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/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 16:37:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/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 16:37:57 INFO - Downloaded 23159542 bytes. 16:37:57 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 16:37:57 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:37:57 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 16:37:59 INFO - Return code: 0 16:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:59 INFO - https://queue.taskcluster.net/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:37:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 16:37:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 16:37:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/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 16:37:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/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 16:38:00 INFO - Downloaded 11132038 bytes. 16:38:00 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 16:38:00 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 16:38:00 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 16:38:00 INFO - Return code: 0 16:38:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:00 INFO - https://queue.taskcluster.net/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:38:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 16:38:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 16:38:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/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 16:38:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ybNU5KrkTpmf1LTCumLbdw/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 16:38:02 INFO - Downloaded 58024011 bytes. 16:38:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 16:38:02 INFO - mkdir: /builds/slave/test-pgo/properties 16:38:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:38:02 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:38:02 INFO - Contents: 16:38:02 INFO - build_url:https://queue.taskcluster.net/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 16:38:02 INFO - Running post-action listener: _resource_record_post_action 16:38:02 INFO - Running post-action listener: set_extra_try_arguments 16:38:02 INFO - ##### 16:38:02 INFO - ##### Running populate-webroot step. 16:38:02 INFO - ##### 16:38:02 INFO - Running pre-action listener: _resource_record_pre_action 16:38:02 INFO - Running main action method: populate_webroot 16:38:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:38:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:38:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:38:02 INFO - '--tppagecycles', 16:38:02 INFO - '7'], 16:38:02 INFO - 'tests': ['tsvgm']}}, 16:38:02 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:38:02 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:38:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:38:02 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:38:02 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:38:02 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:38:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:38:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:02 INFO - 'talos_options': ['--e10s'], 16:38:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:38:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:02 INFO - 'tests': ['damp', 'tps']}, 16:38:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:02 INFO - 'talos_options': ['--e10s'], 16:38:02 INFO - 'tests': ['damp', 'tps']}, 16:38:02 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:38:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:38:02 INFO - 'other': {'tests': ['a11yr', 16:38:02 INFO - 'ts_paint', 16:38:02 INFO - 'tpaint', 16:38:02 INFO - 'sessionrestore', 16:38:02 INFO - 'sessionrestore_no_auto_restore']}, 16:38:02 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:38:02 INFO - 'tests': ['a11yr', 16:38:02 INFO - 'ts_paint', 16:38:02 INFO - 'tpaint', 16:38:02 INFO - 'sessionrestore', 16:38:02 INFO - 'sessionrestore_no_auto_restore']}, 16:38:02 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:38:02 INFO - 'tests': ['a11yr', 16:38:02 INFO - 'ts_paint', 16:38:02 INFO - 'tpaint', 16:38:02 INFO - 'sessionrestore', 16:38:02 INFO - 'sessionrestore_no_auto_restore']}, 16:38:02 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:38:02 INFO - 'tests': ['a11yr', 16:38:02 INFO - 'ts_paint', 16:38:02 INFO - 'tpaint', 16:38:02 INFO - 'sessionrestore', 16:38:02 INFO - 'sessionrestore_no_auto_restore']}, 16:38:02 INFO - 'other_l64': {'tests': ['a11yr', 16:38:02 INFO - 'ts_paint', 16:38:02 INFO - 'tpaint', 16:38:02 INFO - 'sessionrestore', 16:38:02 INFO - 'sessionrestore_no_auto_restore']}, 16:38:02 INFO - 'other_nol64': {'tests': ['a11yr', 16:38:02 INFO - 'ts_paint', 16:38:02 INFO - 'tpaint', 16:38:02 INFO - 'sessionrestore', 16:38:02 INFO - 'sessionrestore_no_auto_restore']}, 16:38:02 INFO - 'svgr': {'tests': ['tsvgx', 16:38:02 INFO - 'tsvgr_opacity', 16:38:02 INFO - 'tart', 16:38:02 INFO - 'tscrollx', 16:38:02 INFO - 'cart']}, 16:38:02 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:38:02 INFO - 'tests': ['tsvgx', 16:38:02 INFO - 'tsvgr_opacity', 16:38:02 INFO - 'tart', 16:38:02 INFO - 'tscrollx', 16:38:02 INFO - 'cart']}, 16:38:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:02 INFO - 'tests': ['tp5o']}, 16:38:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:02 INFO - 'talos_options': ['--e10s'], 16:38:02 INFO - 'tests': ['tp5o']}, 16:38:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:02 INFO - 'talos_options': ['--xperf_path', 16:38:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:38:02 INFO - 'tests': ['tp5n']}, 16:38:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:02 INFO - 'talos_options': ['--e10s', 16:38:02 INFO - '--xperf_path', 16:38:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:38:02 INFO - 'tests': ['tp5n']}}, 16:38:02 INFO - 'talos.zip': {'path': '', 16:38:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:38:02 INFO - Running post-action listener: _resource_record_post_action 16:38:02 INFO - ##### 16:38:02 INFO - ##### Running create-virtualenv step. 16:38:02 INFO - ##### 16:38:02 INFO - Running pre-action listener: _resource_record_pre_action 16:38:02 INFO - Running main action method: create_virtualenv 16:38:02 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:38:02 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 16:38:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:38:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:38:02 INFO - Using real prefix '/usr' 16:38:02 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:38:02 INFO - Installing distribute.............................................................................................................................................................................................done. 16:38:04 INFO - Installing pip.................done. 16:38:04 INFO - Return code: 0 16:38:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:38: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')]} 16:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38: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')]} 16:38:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:04 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 0x7f1bdea50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a4450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1336a50>, '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 0x12a2550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a29e0>, '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': '32c5991c409366f7fec8a718000001d2-1453509391.88383-1622690170', '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 16:38:04 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 16:38:04 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 16:38:04 INFO - Using env: {'DISPLAY': ':0', 16:38:04 INFO - 'HOME': '/home/cltbld', 16:38:04 INFO - 'LANG': 'en_US.UTF-8', 16:38:04 INFO - 'LANGUAGE': 'en_US:en', 16:38:04 INFO - 'LOGNAME': 'cltbld', 16:38:04 INFO - 'MAIL': '/var/mail/cltbld', 16:38:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:04 INFO - 'MOZ_NO_REMOTE': '1', 16:38:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:04 INFO - 'NO_EM_RESTART': '1', 16:38:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:38:04 INFO - 'PWD': '/builds/slave/test-pgo', 16:38:04 INFO - 'SHELL': '/bin/bash', 16:38:04 INFO - 'SHLVL': '1', 16:38:04 INFO - 'TERM': 'linux', 16:38:04 INFO - 'TMOUT': '86400', 16:38:04 INFO - 'USER': 'cltbld', 16:38:04 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453509391.88383-1622690170', 16:38:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:04 INFO - '_': '/tools/buildbot/bin/python'} 16:38:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:04 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 16:38:04 INFO - Cleaning up... 16:38:04 INFO - Return code: 0 16:38:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:38: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')]} 16:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38: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')]} 16:38:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:04 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 0x7f1bdea50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a4450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1336a50>, '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 0x12a2550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a29e0>, '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': '32c5991c409366f7fec8a718000001d2-1453509391.88383-1622690170', '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 16:38:04 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 16:38:04 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 16:38:04 INFO - Using env: {'DISPLAY': ':0', 16:38:04 INFO - 'HOME': '/home/cltbld', 16:38:04 INFO - 'LANG': 'en_US.UTF-8', 16:38:04 INFO - 'LANGUAGE': 'en_US:en', 16:38:04 INFO - 'LOGNAME': 'cltbld', 16:38:04 INFO - 'MAIL': '/var/mail/cltbld', 16:38:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:04 INFO - 'MOZ_NO_REMOTE': '1', 16:38:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:04 INFO - 'NO_EM_RESTART': '1', 16:38:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:38:04 INFO - 'PWD': '/builds/slave/test-pgo', 16:38:04 INFO - 'SHELL': '/bin/bash', 16:38:04 INFO - 'SHLVL': '1', 16:38:04 INFO - 'TERM': 'linux', 16:38:04 INFO - 'TMOUT': '86400', 16:38:04 INFO - 'USER': 'cltbld', 16:38:04 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453509391.88383-1622690170', 16:38:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:04 INFO - '_': '/tools/buildbot/bin/python'} 16:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:05 INFO - Downloading/unpacking psutil>=0.7.1 16:38:05 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 16:38:05 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 16:38:05 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 16:38:05 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 16:38:05 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 16:38:05 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 16:38:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:38:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:38:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:38:06 INFO - Installing collected packages: psutil 16:38:06 INFO - Running setup.py install for psutil 16:38:07 INFO - building 'psutil._psutil_linux' extension 16:38:07 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 16:38:07 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 16:38:07 INFO - building 'psutil._psutil_posix' extension 16:38:07 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 16:38:07 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 16:38:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:38:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:38:07 INFO - Successfully installed psutil 16:38:07 INFO - Cleaning up... 16:38:07 INFO - Return code: 0 16:38:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:38:07 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')]} 16:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:07 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')]} 16:38:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:07 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 0x7f1bdea50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a4450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1336a50>, '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 0x12a2550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a29e0>, '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': '32c5991c409366f7fec8a718000001d2-1453509391.88383-1622690170', '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 16:38:07 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 16:38:07 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 16:38:07 INFO - Using env: {'DISPLAY': ':0', 16:38:07 INFO - 'HOME': '/home/cltbld', 16:38:07 INFO - 'LANG': 'en_US.UTF-8', 16:38:07 INFO - 'LANGUAGE': 'en_US:en', 16:38:07 INFO - 'LOGNAME': 'cltbld', 16:38:07 INFO - 'MAIL': '/var/mail/cltbld', 16:38:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:07 INFO - 'MOZ_NO_REMOTE': '1', 16:38:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:07 INFO - 'NO_EM_RESTART': '1', 16:38:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:38:07 INFO - 'PWD': '/builds/slave/test-pgo', 16:38:07 INFO - 'SHELL': '/bin/bash', 16:38:07 INFO - 'SHLVL': '1', 16:38:07 INFO - 'TERM': 'linux', 16:38:07 INFO - 'TMOUT': '86400', 16:38:07 INFO - 'USER': 'cltbld', 16:38:07 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453509391.88383-1622690170', 16:38:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:07 INFO - '_': '/tools/buildbot/bin/python'} 16:38:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:38:07 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 16:38:07 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 16:38:07 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 16:38:07 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 16:38:07 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 16:38:07 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 16:38:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:38:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:38:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:38:09 INFO - Installing collected packages: mozsystemmonitor 16:38:09 INFO - Running setup.py install for mozsystemmonitor 16:38:09 INFO - Successfully installed mozsystemmonitor 16:38:09 INFO - Cleaning up... 16:38:09 INFO - Return code: 0 16:38:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:38:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1bdea50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a4450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1336a50>, '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 0x12a2550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a29e0>, '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': '32c5991c409366f7fec8a718000001d2-1453509391.88383-1622690170', '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 16:38:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 16:38:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:38:09 INFO - Using env: {'DISPLAY': ':0', 16:38:09 INFO - 'HOME': '/home/cltbld', 16:38:09 INFO - 'LANG': 'en_US.UTF-8', 16:38:09 INFO - 'LANGUAGE': 'en_US:en', 16:38:09 INFO - 'LOGNAME': 'cltbld', 16:38:09 INFO - 'MAIL': '/var/mail/cltbld', 16:38:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:09 INFO - 'MOZ_NO_REMOTE': '1', 16:38:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:09 INFO - 'NO_EM_RESTART': '1', 16:38:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:38:09 INFO - 'PWD': '/builds/slave/test-pgo', 16:38:09 INFO - 'SHELL': '/bin/bash', 16:38:09 INFO - 'SHLVL': '1', 16:38:09 INFO - 'TERM': 'linux', 16:38:09 INFO - 'TMOUT': '86400', 16:38:09 INFO - 'USER': 'cltbld', 16:38:09 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453509391.88383-1622690170', 16:38:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:09 INFO - '_': '/tools/buildbot/bin/python'} 16:38:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:09 INFO - Downloading/unpacking blobuploader==1.2.4 16:38:09 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 16:38:09 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 16:38:09 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 16:38:09 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 16:38:09 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 16:38:09 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 16:38:11 INFO - Downloading blobuploader-1.2.4.tar.gz 16:38:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:38:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:38:11 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 16:38:11 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 16:38:11 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 16:38:11 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 16:38:11 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 16:38:11 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 16:38:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:38:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:12 INFO - Downloading docopt-0.6.1.tar.gz 16:38:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:38:12 INFO - Installing collected packages: blobuploader, requests, docopt 16:38:12 INFO - Running setup.py install for blobuploader 16:38:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:38:12 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:38:12 INFO - Running setup.py install for requests 16:38:12 INFO - Running setup.py install for docopt 16:38:12 INFO - Successfully installed blobuploader requests docopt 16:38:12 INFO - Cleaning up... 16:38:13 INFO - Return code: 0 16:38:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:38: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')]} 16:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38: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')]} 16:38:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:13 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 0x7f1bdea50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a4450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1336a50>, '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 0x12a2550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a29e0>, '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': '32c5991c409366f7fec8a718000001d2-1453509391.88383-1622690170', '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 16:38:13 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 16:38:13 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 16:38:13 INFO - Using env: {'DISPLAY': ':0', 16:38:13 INFO - 'HOME': '/home/cltbld', 16:38:13 INFO - 'LANG': 'en_US.UTF-8', 16:38:13 INFO - 'LANGUAGE': 'en_US:en', 16:38:13 INFO - 'LOGNAME': 'cltbld', 16:38:13 INFO - 'MAIL': '/var/mail/cltbld', 16:38:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:13 INFO - 'MOZ_NO_REMOTE': '1', 16:38:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:13 INFO - 'NO_EM_RESTART': '1', 16:38:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:38:13 INFO - 'PWD': '/builds/slave/test-pgo', 16:38:13 INFO - 'SHELL': '/bin/bash', 16:38:13 INFO - 'SHLVL': '1', 16:38:13 INFO - 'TERM': 'linux', 16:38:13 INFO - 'TMOUT': '86400', 16:38:13 INFO - 'USER': 'cltbld', 16:38:13 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453509391.88383-1622690170', 16:38:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:13 INFO - '_': '/tools/buildbot/bin/python'} 16:38:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:38:13 INFO - Running setup.py (path:/tmp/pip-98TYaP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:38:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:38:13 INFO - Running setup.py (path:/tmp/pip-VTIsFq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:38:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:38:13 INFO - Running setup.py (path:/tmp/pip-3qkx13-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:38:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:38:13 INFO - Running setup.py (path:/tmp/pip-mfyZ9M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:38:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:38:13 INFO - Running setup.py (path:/tmp/pip-iwgE3C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:38:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:38:13 INFO - Running setup.py (path:/tmp/pip-v_LbwY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:38:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:38:13 INFO - Running setup.py (path:/tmp/pip-ZLKD3f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:38:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:38:13 INFO - Running setup.py (path:/tmp/pip-JW2TDc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:38:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:38:13 INFO - Running setup.py (path:/tmp/pip-Y9udHy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:38:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:38:13 INFO - Running setup.py (path:/tmp/pip-Vtso5p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:38:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:38:13 INFO - Running setup.py (path:/tmp/pip-yib4ss-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:38:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:38:14 INFO - Running setup.py (path:/tmp/pip-j5uP2A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:38:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:38:14 INFO - Running setup.py (path:/tmp/pip-nswy7a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:38:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:38:14 INFO - Running setup.py (path:/tmp/pip-2StAQ1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:38:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:38:14 INFO - Running setup.py (path:/tmp/pip-KKldX3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:38:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:38:14 INFO - Running setup.py (path:/tmp/pip-w4FwWq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:38:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:38:14 INFO - Running setup.py (path:/tmp/pip-IfBXwa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:38:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:38:14 INFO - Running setup.py install for manifestparser 16:38:14 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:38:14 INFO - Running setup.py install for mozcrash 16:38:14 INFO - Running setup.py install for mozdebug 16:38:14 INFO - Running setup.py install for mozdevice 16:38:14 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:38:14 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:38:14 INFO - Running setup.py install for mozfile 16:38:14 INFO - Running setup.py install for mozhttpd 16:38:15 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:38:15 INFO - Running setup.py install for mozinfo 16:38:15 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:38:15 INFO - Running setup.py install for mozInstall 16:38:15 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:38:15 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:38:15 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:38:15 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:38:15 INFO - Running setup.py install for mozleak 16:38:15 INFO - Running setup.py install for mozlog 16:38:15 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:38:15 INFO - Running setup.py install for moznetwork 16:38:15 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:38:15 INFO - Running setup.py install for mozprocess 16:38:15 INFO - Running setup.py install for mozprofile 16:38:15 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:38:15 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:38:15 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:38:15 INFO - Running setup.py install for mozrunner 16:38:15 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:38:15 INFO - Running setup.py install for mozscreenshot 16:38:16 INFO - Running setup.py install for moztest 16:38:16 INFO - Running setup.py install for mozversion 16:38:16 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:38:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:38:16 INFO - Cleaning up... 16:38:16 INFO - Return code: 0 16:38:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:38:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:16 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 0x7f1bdea50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a4450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1336a50>, '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 0x12a2550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a29e0>, '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': '32c5991c409366f7fec8a718000001d2-1453509391.88383-1622690170', '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 16:38:16 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 16:38:16 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 16:38:16 INFO - Using env: {'DISPLAY': ':0', 16:38:16 INFO - 'HOME': '/home/cltbld', 16:38:16 INFO - 'LANG': 'en_US.UTF-8', 16:38:16 INFO - 'LANGUAGE': 'en_US:en', 16:38:16 INFO - 'LOGNAME': 'cltbld', 16:38:16 INFO - 'MAIL': '/var/mail/cltbld', 16:38:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:16 INFO - 'MOZ_NO_REMOTE': '1', 16:38:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:16 INFO - 'NO_EM_RESTART': '1', 16:38:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:38:16 INFO - 'PWD': '/builds/slave/test-pgo', 16:38:16 INFO - 'SHELL': '/bin/bash', 16:38:16 INFO - 'SHLVL': '1', 16:38:16 INFO - 'TERM': 'linux', 16:38:16 INFO - 'TMOUT': '86400', 16:38:16 INFO - 'USER': 'cltbld', 16:38:16 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453509391.88383-1622690170', 16:38:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:16 INFO - '_': '/tools/buildbot/bin/python'} 16:38:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:38:16 INFO - Running setup.py (path:/tmp/pip-mFwkJx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:38:16 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)) 16:38:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:38:16 INFO - Running setup.py (path:/tmp/pip-hadq7p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:38:16 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)) 16:38:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:38:16 INFO - Running setup.py (path:/tmp/pip-pqQXlI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:38:16 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)) 16:38:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:38:16 INFO - Running setup.py (path:/tmp/pip-BELPi3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:38:16 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)) 16:38:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:38:16 INFO - Running setup.py (path:/tmp/pip-MYgaXO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:38:16 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)) 16:38:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:38:16 INFO - Running setup.py (path:/tmp/pip-gOfsc6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:38:16 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)) 16:38:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:38:16 INFO - Running setup.py (path:/tmp/pip-1Jx2tA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:38:16 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)) 16:38:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:38:16 INFO - Running setup.py (path:/tmp/pip-LIItGx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:38:17 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)) 16:38:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:38:17 INFO - Running setup.py (path:/tmp/pip-R2tc9D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:38:17 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)) 16:38:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:38:17 INFO - Running setup.py (path:/tmp/pip-W_5Qld-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:38:17 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)) 16:38:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:38:17 INFO - Running setup.py (path:/tmp/pip-PoR60s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:38:17 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)) 16:38:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:38:17 INFO - Running setup.py (path:/tmp/pip-bwaB3z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:38:17 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)) 16:38:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:38:17 INFO - Running setup.py (path:/tmp/pip-fV6KcI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:38:17 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)) 16:38:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:38:17 INFO - Running setup.py (path:/tmp/pip-VCGJxi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:38:17 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)) 16:38:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:38:17 INFO - Running setup.py (path:/tmp/pip-jotdq6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:38:17 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)) 16:38:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:38:17 INFO - Running setup.py (path:/tmp/pip-Jddm4s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:38:17 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)) 16:38:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:38:17 INFO - Running setup.py (path:/tmp/pip-coz_vP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:38:17 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)) 16:38:17 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)) 16:38:17 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)) 16:38:17 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)) 16:38:17 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)) 16:38:17 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)) 16:38:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:19 INFO - Downloading blessings-1.6.tar.gz 16:38:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:38:19 INFO - Installing collected packages: blessings 16:38:19 INFO - Running setup.py install for blessings 16:38:19 INFO - Successfully installed blessings 16:38:19 INFO - Cleaning up... 16:38:19 INFO - Return code: 0 16:38:19 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:38:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:38:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:38:19 INFO - Reading from file tmpfile_stdout 16:38:19 INFO - Current package versions: 16:38:19 INFO - argparse == 1.2.1 16:38:19 INFO - blessings == 1.6 16:38:19 INFO - blobuploader == 1.2.4 16:38:19 INFO - docopt == 0.6.1 16:38:19 INFO - manifestparser == 1.1 16:38:19 INFO - mozInstall == 1.12 16:38:19 INFO - mozcrash == 0.16 16:38:19 INFO - mozdebug == 0.1 16:38:19 INFO - mozdevice == 0.47 16:38:19 INFO - mozfile == 1.2 16:38:19 INFO - mozhttpd == 0.7 16:38:19 INFO - mozinfo == 0.9 16:38:19 INFO - mozleak == 0.1 16:38:19 INFO - mozlog == 3.1 16:38:19 INFO - moznetwork == 0.27 16:38:19 INFO - mozprocess == 0.22 16:38:19 INFO - mozprofile == 0.27 16:38:19 INFO - mozrunner == 6.11 16:38:19 INFO - mozscreenshot == 0.1 16:38:19 INFO - mozsystemmonitor == 0.0 16:38:19 INFO - moztest == 0.7 16:38:19 INFO - mozversion == 1.4 16:38:19 INFO - psutil == 3.1.1 16:38:19 INFO - requests == 1.2.3 16:38:19 INFO - wsgiref == 0.1.2 16:38:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:19 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 0x7f1bdea50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a4450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1336a50>, '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 0x12a2550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a29e0>, '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': '32c5991c409366f7fec8a718000001d2-1453509391.88383-1622690170', '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 16:38:19 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 16:38:19 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 16:38:19 INFO - Using env: {'DISPLAY': ':0', 16:38:19 INFO - 'HOME': '/home/cltbld', 16:38:19 INFO - 'LANG': 'en_US.UTF-8', 16:38:19 INFO - 'LANGUAGE': 'en_US:en', 16:38:19 INFO - 'LOGNAME': 'cltbld', 16:38:19 INFO - 'MAIL': '/var/mail/cltbld', 16:38:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:19 INFO - 'MOZ_NO_REMOTE': '1', 16:38:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:19 INFO - 'NO_EM_RESTART': '1', 16:38:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:38:19 INFO - 'PWD': '/builds/slave/test-pgo', 16:38:19 INFO - 'SHELL': '/bin/bash', 16:38:19 INFO - 'SHLVL': '1', 16:38:19 INFO - 'TERM': 'linux', 16:38:19 INFO - 'TMOUT': '86400', 16:38:19 INFO - 'USER': 'cltbld', 16:38:19 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453509391.88383-1622690170', 16:38:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:19 INFO - '_': '/tools/buildbot/bin/python'} 16:38:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:20 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)) 16:38:20 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)) 16:38:20 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)) 16:38:20 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)) 16:38:20 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)) 16:38:20 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)) 16:38:20 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)) 16:38:20 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)) 16:38:20 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)) 16:38:20 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)) 16:38:20 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)) 16:38:20 INFO - Cleaning up... 16:38:20 INFO - Return code: 0 16:38:20 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:38:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:38:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:20 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 0x7f1bdea50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a4450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1336a50>, '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 0x12a2550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a29e0>, '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': '32c5991c409366f7fec8a718000001d2-1453509391.88383-1622690170', '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 16:38:20 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 16:38:20 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 16:38:20 INFO - Using env: {'DISPLAY': ':0', 16:38:20 INFO - 'HOME': '/home/cltbld', 16:38:20 INFO - 'LANG': 'en_US.UTF-8', 16:38:20 INFO - 'LANGUAGE': 'en_US:en', 16:38:20 INFO - 'LOGNAME': 'cltbld', 16:38:20 INFO - 'MAIL': '/var/mail/cltbld', 16:38:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:20 INFO - 'MOZ_NO_REMOTE': '1', 16:38:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:20 INFO - 'NO_EM_RESTART': '1', 16:38:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:38:20 INFO - 'PWD': '/builds/slave/test-pgo', 16:38:20 INFO - 'SHELL': '/bin/bash', 16:38:20 INFO - 'SHLVL': '1', 16:38:20 INFO - 'TERM': 'linux', 16:38:20 INFO - 'TMOUT': '86400', 16:38:20 INFO - 'USER': 'cltbld', 16:38:20 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453509391.88383-1622690170', 16:38:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:20 INFO - '_': '/tools/buildbot/bin/python'} 16:38:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:20 INFO - Downloading/unpacking jsonschema 16:38:20 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 16:38:20 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 16:38:20 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 16:38:20 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 16:38:20 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 16:38:20 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 16:38:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:38:22 INFO - Downloading/unpacking functools32 (from jsonschema) 16:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:22 INFO - Downloading functools32-3.2.3-2.tar.gz 16:38:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:38:22 INFO - warning: no files found matching '*.txt' 16:38:22 INFO - no previously-included directories found matching 'build' 16:38:22 INFO - no previously-included directories found matching 'dist' 16:38:22 INFO - no previously-included directories found matching '.git*' 16:38:22 INFO - Installing collected packages: jsonschema, functools32 16:38:22 INFO - Running setup.py install for functools32 16:38:22 INFO - warning: no files found matching '*.txt' 16:38:22 INFO - no previously-included directories found matching 'build' 16:38:22 INFO - no previously-included directories found matching 'dist' 16:38:22 INFO - no previously-included directories found matching '.git*' 16:38:22 INFO - Successfully installed jsonschema functools32 16:38:22 INFO - Cleaning up... 16:38:22 INFO - Return code: 0 16:38:22 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:38:22 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')]} 16:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:22 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')]} 16:38:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:38:22 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 0x7f1bdea50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a4450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1336a50>, '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 0x12a2550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a29e0>, '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': '32c5991c409366f7fec8a718000001d2-1453509391.88383-1622690170', '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 16:38:22 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 16:38:22 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 16:38:22 INFO - Using env: {'DISPLAY': ':0', 16:38:22 INFO - 'HOME': '/home/cltbld', 16:38:22 INFO - 'LANG': 'en_US.UTF-8', 16:38:22 INFO - 'LANGUAGE': 'en_US:en', 16:38:22 INFO - 'LOGNAME': 'cltbld', 16:38:22 INFO - 'MAIL': '/var/mail/cltbld', 16:38:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:22 INFO - 'MOZ_NO_REMOTE': '1', 16:38:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:22 INFO - 'NO_EM_RESTART': '1', 16:38:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:38:22 INFO - 'PWD': '/builds/slave/test-pgo', 16:38:22 INFO - 'SHELL': '/bin/bash', 16:38:22 INFO - 'SHLVL': '1', 16:38:22 INFO - 'TERM': 'linux', 16:38:22 INFO - 'TMOUT': '86400', 16:38:22 INFO - 'USER': 'cltbld', 16:38:22 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453509391.88383-1622690170', 16:38:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:22 INFO - '_': '/tools/buildbot/bin/python'} 16:38:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:22 INFO - Downloading/unpacking flake8 16:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:38:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:38:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:38:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:38:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:38:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:38:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:38:25 INFO - no previously-included directories found matching 'docs/_build' 16:38:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:38:25 INFO - Running setup.py install for pep8 16:38:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:38:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:38:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:38:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:38:25 INFO - no previously-included directories found matching 'docs/_build' 16:38:25 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:38:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:38:25 INFO - Cleaning up... 16:38:25 INFO - Return code: 0 16:38:25 INFO - Running post-action listener: _resource_record_post_action 16:38:25 INFO - Running post-action listener: _start_resource_monitoring 16:38:25 INFO - Starting resource monitoring. 16:38:25 INFO - ##### 16:38:25 INFO - ##### Running install step. 16:38:25 INFO - ##### 16:38:25 INFO - Running pre-action listener: _resource_record_pre_action 16:38:25 INFO - Running main action method: install 16:38:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:38:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:38:25 INFO - Reading from file tmpfile_stdout 16:38:25 INFO - Detecting whether we're running mozinstall >=1.0... 16:38:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:38:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:38:25 INFO - Reading from file tmpfile_stdout 16:38:25 INFO - Output received: 16:38:25 INFO - Usage: mozinstall [options] installer 16:38:25 INFO - Options: 16:38:25 INFO - -h, --help show this help message and exit 16:38:25 INFO - -d DEST, --destination=DEST 16:38:25 INFO - Directory to install application into. [default: 16:38:25 INFO - "/builds/slave/test-pgo"] 16:38:25 INFO - --app=APP Application being installed. [default: firefox] 16:38:25 INFO - mkdir: /builds/slave/test-pgo/build/application 16:38:25 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'] 16:38:25 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 16:38:40 INFO - Reading from file tmpfile_stdout 16:38:40 INFO - Output received: 16:38:40 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:38:40 INFO - Running post-action listener: _resource_record_post_action 16:38:40 INFO - ##### 16:38:40 INFO - ##### Running run-tests step. 16:38:40 INFO - ##### 16:38:40 INFO - Running pre-action listener: _resource_record_pre_action 16:38:40 INFO - Running main action method: run_tests 16:38:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:38:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:38:40 INFO - Python 2.7.3 16:38:40 INFO - Return code: 0 16:38:40 INFO - grabbing minidump binary from tooltool 16:38:40 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')]} 16:38:40 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 0x1336a50>, '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 0x12a2550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a29e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:38:40 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 16:38:40 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 16:38:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:38:40 INFO - Return code: 0 16:38:40 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:38:40 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:38:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:38:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:38:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:38:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:38:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:38:41 INFO - Return code: 0 16:38:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 16:38:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost 16:38:41 INFO - Using env: {'DISPLAY': ':0', 16:38:41 INFO - 'HOME': '/home/cltbld', 16:38:41 INFO - 'LANG': 'en_US.UTF-8', 16:38:41 INFO - 'LANGUAGE': 'en_US:en', 16:38:41 INFO - 'LOGNAME': 'cltbld', 16:38:41 INFO - 'MAIL': '/var/mail/cltbld', 16:38:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:38:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:38:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:41 INFO - 'MOZ_NO_REMOTE': '1', 16:38:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:38:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:41 INFO - 'NO_EM_RESTART': '1', 16:38:41 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:38:41 INFO - 'PWD': '/builds/slave/test-pgo', 16:38:41 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:38:41 INFO - 'SHELL': '/bin/bash', 16:38:41 INFO - 'SHLVL': '1', 16:38:41 INFO - 'TERM': 'linux', 16:38:41 INFO - 'TMOUT': '86400', 16:38:41 INFO - 'USER': 'cltbld', 16:38:41 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453509391.88383-1622690170', 16:38:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:41 INFO - '_': '/tools/buildbot/bin/python'} 16:38:41 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost'] with output_timeout 3600 16:38:41 INFO - mozversion INFO | application_buildid: 20160122140553 16:38:41 INFO - mozversion INFO | application_changeset: 1fa9b8e51c285b27bf7730655d7c0385d83383f8 16:38:41 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 16:38:41 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:38:41 INFO - mozversion INFO | application_name: Firefox 16:38:41 INFO - mozversion INFO | application_remotingname: firefox-dev 16:38:41 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:38:41 INFO - mozversion INFO | application_vendor: Mozilla 16:38:41 INFO - mozversion INFO | application_version: 45.0a2 16:38:41 INFO - mozversion INFO | platform_buildid: 20160122140553 16:38:41 INFO - mozversion INFO | platform_changeset: 1fa9b8e51c285b27bf7730655d7c0385d83383f8 16:38:41 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:38:41 INFO - mozversion INFO | platform_version: 45.0a2 16:38:41 INFO - 2016-01-22 16:38:41,701 DEBUG : using testdate: 1453509521 16:38:41 INFO - 2016-01-22 16:38:41,701 DEBUG : actual date: 1453509521 16:38:41 INFO - 2016-01-22 16:38:41,709 INFO : starting webserver on 'localhost:45494' 16:38:41 INFO - 2016-01-22 16:38:41,710 INFO : Starting test suite talos-linux64-ix-008.e 16:38:41 INFO - 2016-01-22 16:38:41,710 INFO : Starting test dromaeo_css 16:38:41 INFO - 2016-01-22 16:38:41,710 DEBUG : operating with platform_type : linux_ 16:38:41 INFO - 2016-01-22 16:38:41,710 INFO : Initialising browser for dromaeo_css test... 16:38:41 INFO - 2016-01-22 16:38:41,721 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9oyhVh/profile http://localhost:45494/getInfo.html 16:38:45 INFO - 2016-01-22 16:38:45,260 DEBUG : BROWSER_OUTPUT: 16:38:45 INFO - 2016-01-22 16:38:45,260 DEBUG : BROWSER_OUTPUT: (process:24116): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:38:46 INFO - 2016-01-22 16:38:46,103 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:38:46 INFO - 2016-01-22 16:38:46,103 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:38:46 INFO - 2016-01-22 16:38:46,103 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:38:46 INFO - 2016-01-22 16:38:46,103 DEBUG : BROWSER_OUTPUT: __metrics 16:38:47 INFO - 2016-01-22 16:38:47,101 INFO : Browser initialized. 16:38:47 INFO - 2016-01-22 16:38:47,102 INFO : Running cycle 1/1 for dromaeo_css test... 16:38:47 INFO - 2016-01-22 16:38:47,102 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9oyhVh/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:38:48 INFO - 2016-01-22 16:38:48,393 DEBUG : BROWSER_OUTPUT: 16:38:48 INFO - 2016-01-22 16:38:48,393 DEBUG : BROWSER_OUTPUT: (process:24228): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:38:58 INFO - 2016-01-22 16:38:58,889 DEBUG : BROWSER_OUTPUT: RSS: Main: 135766016 16:38:58 INFO - 2016-01-22 16:38:58,890 DEBUG : BROWSER_OUTPUT: 16:39:48 INFO - 2016-01-22 16:39:48,521 DEBUG : BROWSER_OUTPUT: 1453509588519 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] 16:41:56 INFO - 2016-01-22 16:41:56,330 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45494/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45494/tests/dromaeo/cssquery-ext.html) 16:41:57 INFO - 2016-01-22 16:41:57,382 DEBUG : BROWSER_OUTPUT: RSS: Main: 141127680 16:41:57 INFO - 2016-01-22 16:41:57,382 DEBUG : BROWSER_OUTPUT: 16:44:59 INFO - 2016-01-22 16:44:59,186 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45494/tests/dromaeo/cssquery-ext.html (next: http://localhost:45494/tests/dromaeo/cssquery-jquery.html) 16:44:59 INFO - 2016-01-22 16:44:59,772 DEBUG : BROWSER_OUTPUT: RSS: Main: 139452416 16:44:59 INFO - 2016-01-22 16:44:59,772 DEBUG : BROWSER_OUTPUT: 16:48:01 INFO - 2016-01-22 16:48:01,361 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45494/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45494/tests/dromaeo/cssquery-mootools.html) 16:48:01 INFO - 2016-01-22 16:48:01,949 DEBUG : BROWSER_OUTPUT: RSS: Main: 138317824 16:48:01 INFO - 2016-01-22 16:48:01,949 DEBUG : BROWSER_OUTPUT: 16:51:03 INFO - 2016-01-22 16:51:03,495 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45494/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45494/tests/dromaeo/cssquery-prototype.html) 16:51:04 INFO - 2016-01-22 16:51:04,103 DEBUG : BROWSER_OUTPUT: RSS: Main: 139055104 16:51:04 INFO - 2016-01-22 16:51:04,103 DEBUG : BROWSER_OUTPUT: 16:54:06 INFO - 2016-01-22 16:54:06,436 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45494/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45494/tests/dromaeo/cssquery-yui.html) 16:54:07 INFO - 2016-01-22 16:54:07,026 DEBUG : BROWSER_OUTPUT: RSS: Main: 140066816 16:54:07 INFO - 2016-01-22 16:54:07,026 DEBUG : BROWSER_OUTPUT: 16:57:08 INFO - 2016-01-22 16:57:08,982 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45494/tests/dromaeo/cssquery-yui.html (next: http://localhost:45494/tests/dromaeo/cssquery-dojo.html) 16:57:09 INFO - 2016-01-22 16:57:09,241 DEBUG : BROWSER_OUTPUT: RSS: Main: 141799424 16:57:09 INFO - 2016-01-22 16:57:09,241 DEBUG : BROWSER_OUTPUT: 16:57:09 INFO - 2016-01-22 16:57:09,241 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:57:09 INFO - 2016-01-22 16:57:09,241 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:57:09 INFO - 2016-01-22 16:57:09,241 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:57:09 INFO - 2016-01-22 16:57:09,241 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:57:09 INFO - 2016-01-22 16:57:09,241 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3267.1505408593766;3278.131295206772;3304.636489986103;3313.9337213255735;3326.7837590556605;5502.889942201158;5520.9999999999945;5529;5532.031894418481;5562.3881373048935;5610.523105536025;5619.5785316101255;5625.268715067045;5648.830535083944;5651.463111004458;5136.537711605945;5144.948550514484;5195.870103247411;5203.895922081556;5208.935873142512;5010.624203184758;5132.127538318477;5133.230015497668;5139.640225184238;5194.896102077956;5129.204973229155;5205;5207.739613019353;5277.050130976423;5318.760655770499;5236.502532259429;5266.183741520071;5266.2627232187715;5271.182966640177;5322.654027488201;4923.630727695401;5101.795928162906;5155.896882062375;5167.09575824233;5217.060929032773;5371.865703357447;5471.7264136793;5473.397926228112;5494.972525137388;5531.861703457405;6060.030395136757;6074.908876366858;6106.419890110433;6121.296050954153;6126.081087836816;5993.4006599340155;6040.637561746309;6130.724117414727;6177.845553861144;6187.690615469209;5744.195812586199;5817.941820581825;5819.010768169379;5822.737976791054;5828.5628577856405;6314.431701146918;6343.873122537523;6367.61794292344;6368.904466433008;6387.584806987624;5705.115707065412;5867.530597552186;5906.291245050621;6016.639001659827;6102.0541816018585;6066.939330606726;6113.938860611426;6118.204633397719;6137.202163718688;6154.599951003171;6056.576039677268;6058.27300723916;6097.207363042776;6102.72537735803;6109.7861574844665;5882.617629854046;5954.345022047572;5995.52035837132;6046.455818976313;6087.57386982907;4636.095961287517;4636.304554316879;4641.675082744176;4661.3707149534375;4668.883277918079;4023.5574086850424;4165.97917010419;4167.8958026049595;4181.749095054246;4184.748915065105;5741.3971532988435;5782.710864456844;5860.443257890493;5901.675407852609;5943.375945525744;6102.481289090389;6142.78500252489;6145.9692701536205;6149.0776383542825;6162.784302549389;5574.470425309589;5703.7148142592705;5745.913811292834;5759.136129580513;5759.308882934075;5263.184206448007;5316.680999140064;5320.281761962163;5335.973320133375;5365.222042803772;6247.656378899204;6280.623162610258;6281.214848143982;6288.685565721696;6298.685065746694;5911.7635294587735;6026.608270462406;6105.328413874381;6170.6914654268;6172.567920245539;6218.347073557211;6306.905396418965;6365.267994180544;6373.5857169283845;6390;6107.511399088151;6117.84705382369;6129.938700612936;6132.816015519542;6143.047827586731;5928.584999050025;6007.279126504847;6040.214772079602;6138.508919286535;6228.096925945803;6024.7288872001745;6126.632402055891;6129.816105516842;6130.049842274455;6132.846678833065;6056.5154787616;6120.08198770188;6121.3572574879;6122.020476723703;6130.50955923534;5679.233303504139;5720.45655662728;5779.36426993022;5811.680357580204;5996.910046349395;6046.244219472566;6074.42292982166;6113.419225173601;6135.938640613536;6146.354632763496;5968;5984.19213406202;5985.461308482258;5986.580939334205;6003.669798161143 16:57:09 INFO - 2016-01-22 16:57:09,241 DEBUG : BROWSER_OUTPUT: |1;ext.html;574.8304250246177;602.1990752299442;615.8545106102649;620.4075108271601;689.8896176611743;31882.20294492639;33238.83380583097;41411.58588414115;41440.585594144046;41557;45809;45946;45960;46078.078438431214;46325;9068.637254509811;9238.491882946435;9267.814643707121;9269.768255793626;9285.489298088602;8972.102789721008;9091.863622045674;9117.088291170863;9126.406783559081;9130;9057.275417966546;9075.319351048665;9100.271978241724;9138.588763505659;9170.770730731718;9087.045860184684;9122.315826313054;9146.31402644801;9162.816743665122;9184.954075229647;8971.820563588692;9110;9118.452892826452;9126.13301736334;9148.359614826964;40965;41396.79301603503;41941.1611767766;41963.790181049204;42243;3220.983895080533;3347.2468694543777;3458.325626502833;3504.8598056077726;3752.43713442983;30711.846440767877;30894.845525772453;30909.381812363852;31337.37325253482;31597.36805263882;3377.0881861897396;3388.542546756206;3425.0752296879705;3430.382531144393;3462.0998540379683;282326;283723;283846;284841;285942;62911.68544157341;64147;71821.6408917952;72255;72391.63804180945;64333.356666433676;64574.354256456834;64651.35348646547;64700.35299647038;64893;17861.374851880122;18320.26718931228;18372.632547349247;18437.815621843878;18520.444386668423;13316.866831331563;13488.797668034988;13562.728745425036;13569.321533923265;13801.171929684251;21840.453988650093;22110.447238819157;22221.44446388821;22228.777712222993;22232.221872234717;7245.203027666952;7253;7351.772730679773;7375.668094935741;7463.664135113933;962.7978124593914;988.2538683294067;1059.4384975962753;1141.2981016674685;1171.0338970349496;27932.894127489435;28508.572371414444;28877.27806804847;28997;29068.854655726587;1089.1831126655009;1171.625079974417;1185.2829038431796;1201.1411840533885;1225.148521777356;15014.924925375302;15205.61985950338;15243.314050867737;15526.9223653881;15546.9222653886;423466;770543;775589;777716;820282;58540.121898171565;60641.393586064456;60676.08985865216;60839.479013024145;60951.39048609546;1509.260462373451;1534.0412242348755;1535.992320038415;1537.4080978823233;1550.674358384752;31084.222894426915;31344.529832052995;31358.843205783825;31661;31974.200644984063;48797.512024879295;48855;48924.75537622289;49308;49331.75334123307;324815;325872.4825503524;327252;327891;329523;33217.667823321455;33561.83219083889;33767;33834.66165338315;33985.32029359449;44663.33005004862;45058.09883802371;45161;45685.314720278555;45754.4835034063;38752.41871371988;38803.61196388113;39796.80101599474;44303.77848110739;46006.309905352115;38418.42372364361;38581.614183858925;38654.42018369783;38828.41757373698;38999.2200156001;43326.350104749086;43796;44318.335224972296;44487.332690009025;44866.327005094296;33530.329393411506;38663.131774585454;38937.41593876037;39380.80309598434;40184.1963160741;27449.725502744717;28359.57460638051;28639;29895.252618684706;30759.69240307568 16:57:09 INFO - 2016-01-22 16:57:09,242 DEBUG : BROWSER_OUTPUT: |2;jquery.html;387.08068337697966;391.43437732476576;391.59078762693;391.78451851481697;397.72954391014133;16038.919805400987;16974;17719.645607087852;18362.724559131606;18473.35343262986;11434.970852623263;11630.651080467578;11656.417179141052;11692.532298708042;11852.644420667371;5030.622703297258;5148.948510514884;5151.175811870102;5162.561182299491;5180.067587834188;5367.785288588452;5411.864703382407;5544.91682624761;5547.223388725582;5560.916586251189;5417.106177480711;5458.5087342139195;5467.589930755189;5912.9113063304085;6290.339514350973;6238.344973777756;6242.313345531988;6248.593841400295;6250.562460627758;6259.780907668232;5102.158143906251;5162.561182299509;5222.73886305687;5543.805966791183;5582.441755824426;13313.600591982256;13411.865881341158;13443.731125377535;13504.852087572568;13640.113392629448;2200.207925146946;2258.9322320330416;2274.5223503064376;2315.2938353802083;2422.200673777649;10009.349392289478;10217.693469195936;10239.692809215736;10320.845187322197;10331.48342582868;1902.79069302378;1940.640981418428;1946.153423260886;2034.206659402834;2062.3709768520594;63774;65467.345326547074;65664.3433565663;66458.66770666116;66480;10863.45682715861;11111.111111111091;11113.83329250062;11198.44007799623;11243.100551955824;14573.271336433136;14730.263486825615;14758.483453079305;14779.704405911822;14799.556013319618;8137.715179968673;8154.714584989497;8176.264136227649;8201.917980820235;8203.8359232815;7932.960335198402;7993.120756716757;8005.719799806979;8006.039275287003;8038;4517.81928722854;4648.604868586208;4802.255650374198;4836.733979631154;4859.198232291632;1987.4335814292858;2023.6458619741486;2043.673012318022;2050.0774651406928;2055.6094342075257;935.3873213045466;1007.7178390050798;1048.3028785857318;1086.788076325109;1090.1605763562013;17173.484795456156;18157.45527634173;18224.45326640203;18497.352592659194;18532.444026679223;870.3994243971639;947.6967370441392;955.3551352836807;976.199516396548;1003.0922015575916;9493.715188544355;9664.371815831948;9679.612815487442;9824.4105353679;9953.153981911473;649159.7542012354;653880;668438;704330.478347605;706064;81667.50476721511;87726;88194.11805881988;89435.55282223548;89439.55280223557;1203.6930582701355;1214.168294718121;1215.2404747033104;1218.281214083695;1225.2158618484177;16660.166991650127;16813.66372672564;16821.747673785147;16831.579210519834;16947;37565.06087347838;37764.62235377611;37827;38184.427233592076;38198.045048874;45459.77270113628;47875;49212;49811.25283120829;49939;9788.657396991071;10180.032896874785;10214.795704085727;10253.384796912209;10300.639477618248;17513.38703145435;17522.386716464862;17624.383146589807;18095.728564071287;18560.071996400395;14919.179445130188;15133.54599362021;15233.466828660943;15286.541403757905;15455.84544154544;15169.696606068037;15489.457868974532;15689.921550392175;15704.136272505122;15920.52238432849;15544.455944041903;15925.920370398075;16093.873428859868;16223.432179873647;16499.83500165031;9923.05730955587;10211.897881021094;10371.585136594753;10725.356478611307;10816.891831081588;10152;10700;15558;15780.447684330993;15836.92081539585 16:57:09 INFO - 2016-01-22 16:57:09,242 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1580.581145996311;1595.8643515301198;1838.8436982856456;1882.604653022865;1888.9905550472245;8297.460665056782;8390.496570205783;8595.613197406115;8604.612792424348;8667.73996780096;8580.785480362978;8590.570471476416;8624.698135565257;8659.480431174119;8707.521086340248;2360.9527809443803;2395.9880200598973;2397.676313697646;2402.5555272274596;2404.5311164322966;2348.9295321140394;2403.5433267679086;2444.828861979662;2446.0338166424253;2457.766512181349;2088.3734879536155;2163.1996161420298;2403.627437747152;2427.9757202428013;2449.9020039198413;2348.765123487646;2362.3739708977137;2371.34787933318;2376.619740841457;2377.061060880951;2449.1060762821444;2458.0782206672498;2488.639147323646;2489.4025433895918;2491.426971796479;8450.366222533334;8498.405111642187;8509.872351914726;8511.616977236039;8535.061143274235;5054.393472783289;5104.897902041938;5116.872078198037;5128.666636668605;5133.6149788765615;3232;3268.329992351586;3329.583802024747;3352.4971254311804;3355.127666806648;965.6041023180533;984.8670429491998;998.8901220865699;1035.8342665173611;1056.0284538224776;11783.469743861548;11935.582254621047;11952.462139203757;11955.282683039046;11986.580469683606;4435.600795928317;4462.44219472566;4487.057717879282;4527.456705195397;4552.954470455253;9465;9516.90483095174;9546.42721436716;9610;9638.614455421844;5049.419316778544;5055.317532133188;5064.240363945438;5079.466656001141;5087.796488140507;4633.930491042637;4661.160991021648;4673.719576825401;4688.765561721901;4702.553257440606;3653.963460365362;3700.407934730484;3719.0702324418894;3751.5685696144747;3770.1140232045445;1112.9276597021167;1113.3820729495208;1113.6325012745936;1113.6993011886746;1116.6594188772503;1088.8584484017026;1095.0090168397612;1153.9844936455866;1322.9470821167238;1324.291504045331;7744.341730952932;7779.494332868346;7795.103563090317;7805.37556995439;7816.452848300564;1180.451090243041;1181.539199712113;1188.8811118888043;1190.9285442873456;1212.0727643352843;6242.188515492957;6246.063090536456;6280.685965701697;6295.18162638854;6301.936980630227;9941.80116397668;10099.7475063124;10266.6406675766;10353.534090965773;10363.585456581803;10100.292979491513;10121.898781012243;10204.081632653097;10209.132223760915;10267.383956962607;7840.3335716464735;7976.641051152712;8024.598770061591;8094.473859199134;8119.5534245617055;7654.885176722242;7730.304272615492;7757.26306000929;7773.261540153676;7788.88316675239;9017.368784185044;9085.954570227106;9148.817023659623;9300.39547429415;9308;9313.953430232805;9321.114494123047;9423;9466.2427005838;9619;7206.459515536251;7217.530860494051;7230.13238411394;7240.420766338575;7302.525335853153;8130.471519351223;8154.143814899588;8219.589020549069;8236.34109271245;8237.093919668952;7594.31651151399;7599.392048635986;7644.961775191088;7748.535087894745;7777.377809775091;6653.168353955755;6684.4318232950745;7384.96307518459;7497.137829149718;7625.275598818103;7722.266384693445;7768.223177682186;7789.7273595423885;7790.493617914817;7814.21857814214;7084.504084714226;7113.75101871432;7116.786496405116;7123.928760712327;7134.928650713427;6951.930480695129;6970.477214208853;6971;7040.894386584103;7056.682449289691 16:57:09 INFO - 2016-01-22 16:57:09,242 DEBUG : BROWSER_OUTPUT: |4;prototype.html;377.7072768604332;380.04039799506245;380.3382115119692;381.4507109761941;390.23319177815586;6444.226692796859;6471.1263979362775;6491;6538.967305163479;6627.403533681968;6398.680065996693;6429.067785171147;6457.03144528321;6458.773942911999;6467.9029814552705;4947.628927830409;4948.97525512372;4957.702537847723;4959.380077490314;4967.950320496785;4969.950300497003;4972.801087956477;4972.875678108058;4974.37820272466;4987;4719.339292499053;4719.740414277213;4782.1153086678905;4782.521747825224;4868.148074087038;4725.787339569728;4740.1704701677245;4746.169420351424;4749.0027094310235;4749.358836557055;4221.155768846243;4238.978805105986;4241.278982572939;4244.639205667522;4245.448091748084;5954.523638108941;5961.8807623847715;5967.850803729898;5970.283565972111;5973.761049558012;5520.420355862617;5592.804251851166;5602.215689803431;5606.131049687305;5616.943830561724;6621.602703837785;6622.602643841385;6622.9006564901565;6626.171728533934;6637.1703537057865;4631.3516107744945;4644.489106198315;4676.415448068991;4677.789499472532;4679.227927391977;6865.725370985155;6935.791926242221;7009.439244860348;7022.12223472066;7039.120109986252;4841.8547443576745;4851.636127290467;4856.271559266138;4868.123737727172;4868.294097355863;4929.605631549467;4930.235813448921;4932.087563800708;4938.308636790852;4942.654014218971;5611.7755289788765;5655.632383895034;5657.236273103161;5658.773649054074;5676.943230567642;6702.061711360413;6838.965805170942;6876.209235937831;6883.586984780929;6901.102856628606;1713.4260022892222;1731.8527925126252;1736.817634148396;1738.5827401423567;1739.625980414217;1166.9591564295208;1177.264209868832;1187.673389817807;1200.2438463767771;1202.675277675023;6544.3782840630065;6549.770758023446;6552;6555.770548030796;6558.278589355167;7089.184743754431;7116.825723755626;7130.180029296594;7133.750318738923;7145.92854071463;6558.80323590293;6566.67166641666;6575.112359831457;6684.6991885364305;6689.230738465041;3868.129670824042;3872.3029854625875;3879.86420475282;3891.5135608048995;3910.3547914593773;7275.4179665626625;7309.89035164473;7330.083739532559;7373.81565460857;7382.4094072475145;7205;7367.852642947111;7368.926310736932;7373.004644372941;7375.336219740142;7294.598797066106;7300.7079716811795;7345.375643070292;7357.632118394166;7361.595112268877;7145.785626431215;7184.281571842774;7192.388646965067;7193.028941092885;7202.423806095395;6924.272951340036;7096.361327480551;7111.53775004623;7113.75101871432;7121.216666166614;7326.267373262845;7334.889976650461;7372.520786148883;7402.740904068547;7409.296116868889;4911.336969509213;4943.20908654628;4946.183879659816;4956.132676781477;4961;6955.547889387173;7138.607376594129;7195.784126476214;7202.495825292389;7223.205447400676;6944.687489063105;6993.650317484004;6999.720011199495;7002.299770022957;7007.089078419773;6797.28628494001;6851.280615535297;6865.210500792473;6882.277360877036;7001;6803.217629972419;6807.353301436356;6878.449724022166;6879.346462086094;6883.827904302432;6961.825954351182;6979.441644668516;7006.194287656985;7029.05107810439;7047.894281585678;6700.095487109178;6792.320767923168;6799.626020568916;6841.726330946905;6851.45188384918 16:57:09 INFO - 2016-01-22 16:57:09,242 DEBUG : BROWSER_OUTPUT: |5;yui.html;767.202109805802;789.0649580247407;803.9758807235785;824.4393812207699;892.4377642085485;16999;17384.13079346034;17393.826061739393;17442.999999999985;17443;14242.501512447066;14287.071340362894;14322.427102915872;14400.27998600071;14442.783358249635;913.4610579757941;930.3069213435982;933.020328654913;936.148105224246;936.8220038192756;928.317686500425;929.7722058095776;934.3039435620439;934.3739694404732;934.8784657994486;912.4935660708304;970.4856426094146;971.6939164163301;974.1135566634364;974.4153507895277;947.8957314695378;969.6412327438893;969.7817990952014;971.4414211828228;971.9319647624669;709.2234003765868;716.0762616225063;720.6576875983918;721.8700633885899;722.9674664640104;14518.637034074232;14688.192149431778;14698.044627099205;14702.705945881022;14722.852771472362;11903.761924761457;12210.267383956902;12840.486380544768;12853.80719289202;13063.301770769835;9863.950680246624;10531.104856087242;10715.83926241107;10786.676399708022;10808.189385796097;3709.962900370989;3787.734858559902;3790.5261842269715;3794.677452416548;3809.561900381464;47008.764956175;47212.527874721156;47403.288950665425;47467.73284942985;47690.807729806686;9895.703128906145;10123.898761012442;10150.949245253727;10187.643432479976;10274.434906080238;18339.541511462052;18496.44510664682;18505.259789608535;18867.339643112424;18891.14989825461;7500;7721.150673425918;7967.760967170994;7969.402294827911;8248.381371397048;4517.34498497716;4531.331301568463;4596.49438561758;4620.3993480847275;4820.783064762094;3175.063356309894;3199.6480387157394;3218.5494030835703;3230.80615163091;3234.498652708834;565.801969310738;569.8262030080865;571.9942800571941;572.3389485144664;573.888091822099;583.5506659871875;624.8719012602405;658.5028303630728;663.9170103737033;691.2638040486866;9275.30435217348;9477.336586439022;9501.714948551555;9550.140487356033;9922;660.3693472733528;682.6040896280145;694.4617921111179;698.3226270517691;701.6035939694057;3832.5400951885395;3858.9035274118373;3891.9416208756893;3902.941455878164;3991.860284890015;58273.70863145742;58415.70792146097;58575.414245857;58926.705366472896;59364.40635593589;49148;49284.50715492871;50508.24237636438;51008.74495627498;51339.22991155136;45534.08931821279;45999.31001034987;46454;46529.5347046532;46831.29753053707;8715;8741.825163496567;8792.120787921156;8968.506732129796;9258.814823703622;35181;35728.28543429169;35795.463068053476;37526.06184845401;38317.2336553273;43950.560494394646;45346;45360.546394536956;45834.77082614699;45940.081198376516;10766.084882785051;10873.695156581261;10945;11502.482388292714;11683.766324673628;12624.74750505003;12662.746745064864;12833.614991550268;13450.798238026242;13720.93139534336;11143.888561114285;11639.59261425846;11850.170488065753;11956.34240116767;12397.938010310252;11314.717132071435;11396.94301528487;11413.486393112164;11616.767664646828;11623.070154387799;11071.501782419971;11165.49755260999;11195.328280303207;11270.49282782293;11412.600558980728;10219.693409197736;10438.843417348899;10543.42011189392;10747.516361763583;10807.08139808125;9277.48973806447;9406.247500200105;9487;9877.50612469388;9952.303338766216 16:57:09 INFO - 2016-01-22 16:57:09,242 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:57:09 INFO - 2016-01-22 16:57:09,242 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:57:09 INFO - 2016-01-22 16:57:09,242 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,306 16:57:09 INFO - 2016-01-22 16:57:09,242 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:57:09 INFO - 2016-01-22 16:57:09,242 DEBUG : BROWSER_OUTPUT: __startTimestamp1453510629234__endTimestamp 16:57:09 INFO - 2016-01-22 16:57:09,242 DEBUG : BROWSER_OUTPUT: 16:57:09 INFO - 2016-01-22 16:57:09,242 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:57:09 INFO - 2016-01-22 16:57:09,243 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:57:09 INFO - 2016-01-22 16:57:09,243 DEBUG : BROWSER_OUTPUT: 16:57:09 INFO - 2016-01-22 16:57:09,243 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5670.31 Median:5911.76 stddev:657.65 (11.1%) stddev-sans-first:632.07 16:57:09 INFO - 2016-01-22 16:57:09,244 DEBUG : BROWSER_OUTPUT: Values: 3267.2 3278.1 3304.6 3313.9 3326.8 5502.9 5521.0 5529.0 5532.0 5562.4 5610.5 5619.6 5625.3 5648.8 5651.5 5136.5 5144.9 5195.9 5203.9 5208.9 5010.6 5132.1 5133.2 5139.6 5194.9 5129.2 5205.0 5207.7 5277.1 5318.8 5236.5 5266.2 5266.3 5271.2 5322.7 4923.6 5101.8 5155.9 5167.1 5217.1 5371.9 5471.7 5473.4 5495.0 5531.9 6060.0 6074.9 6106.4 6121.3 6126.1 5993.4 6040.6 6130.7 6177.8 6187.7 5744.2 5817.9 5819.0 5822.7 5828.6 6314.4 6343.9 6367.6 6368.9 6387.6 5705.1 5867.5 5906.3 6016.6 6102.1 6066.9 6113.9 6118.2 6137.2 6154.6 6056.6 6058.3 6097.2 6102.7 6109.8 5882.6 5954.3 5995.5 6046.5 6087.6 4636.1 4636.3 4641.7 4661.4 4668.9 4023.6 4166.0 4167.9 4181.7 4184.7 5741.4 5782.7 5860.4 5901.7 5943.4 6102.5 6142.8 6146.0 6149.1 6162.8 5574.5 5703.7 5745.9 5759.1 5759.3 5263.2 5316.7 5320.3 5336.0 5365.2 6247.7 6280.6 6281.2 6288.7 6298.7 5911.8 6026.6 6105.3 6170.7 6172.6 6218.3 6306.9 6365.3 6373.6 6390.0 6107.5 6117.8 6129.9 6132.8 6143.0 5928.6 6007.3 6040.2 6138.5 6228.1 6024.7 6126.6 6129.8 6130.0 6132.8 6056.5 6120.1 6121.4 6122.0 6130.5 5679.2 5720.5 5779.4 5811.7 5996.9 6046.2 6074.4 6113.4 6135.9 6146.4 5968.0 5984.2 5985.5 5986.6 6003.7 16:57:09 INFO - 2016-01-22 16:57:09,244 DEBUG : BROWSER_OUTPUT: 16:57:09 INFO - 2016-01-22 16:57:09,244 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:60787.49 Median:39588.80 stddev:131664.80 (332.6%) stddev-sans-first:131956.54 16:57:09 INFO - 2016-01-22 16:57:09,244 DEBUG : BROWSER_OUTPUT: Values: 574.8 602.2 615.9 620.4 689.9 31882.2 33238.8 41411.6 41440.6 41557.0 45809.0 45946.0 45960.0 46078.1 46325.0 9068.6 9238.5 9267.8 9269.8 9285.5 8972.1 9091.9 9117.1 9126.4 9130.0 9057.3 9075.3 9100.3 9138.6 9170.8 9087.0 9122.3 9146.3 9162.8 9185.0 8971.8 9110.0 9118.5 9126.1 9148.4 40965.0 41396.8 41941.2 41963.8 42243.0 3221.0 3347.2 3458.3 3504.9 3752.4 30711.8 30894.8 30909.4 31337.4 31597.4 3377.1 3388.5 3425.1 3430.4 3462.1 282326.0 283723.0 283846.0 284841.0 285942.0 62911.7 64147.0 71821.6 72255.0 72391.6 64333.4 64574.4 64651.4 64700.4 64893.0 17861.4 18320.3 18372.6 18437.8 18520.4 13316.9 13488.8 13562.7 13569.3 13801.2 21840.5 22110.4 22221.4 22228.8 22232.2 7245.2 7253.0 7351.8 7375.7 7463.7 962.8 988.3 1059.4 1141.3 1171.0 27932.9 28508.6 28877.3 28997.0 29068.9 1089.2 1171.6 1185.3 1201.1 1225.1 15014.9 15205.6 15243.3 15526.9 15546.9 423466.0 770543.0 775589.0 777716.0 820282.0 58540.1 60641.4 60676.1 60839.5 60951.4 1509.3 1534.0 1536.0 1537.4 1550.7 31084.2 31344.5 31358.8 31661.0 31974.2 48797.5 48855.0 48924.8 49308.0 49331.8 324815.0 325872.5 327252.0 327891.0 329523.0 33217.7 33561.8 33767.0 33834.7 33985.3 44663.3 45058.1 45161.0 45685.3 45754.5 38752.4 38803.6 39796.8 44303.8 46006.3 38418.4 38581.6 38654.4 38828.4 38999.2 43326.4 43796.0 44318.3 44487.3 44866.3 33530.3 38663.1 38937.4 39380.8 40184.2 27449.7 28359.6 28639.0 29895.3 30759.7 16:57:09 INFO - 2016-01-22 16:57:09,244 DEBUG : BROWSER_OUTPUT: 16:57:09 INFO - 2016-01-22 16:57:09,244 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:33236.92 Median:2052.84 stddev:110557.47 (5385.6%) stddev-sans-first:110840.09 16:57:09 INFO - 2016-01-22 16:57:09,246 DEBUG : BROWSER_OUTPUT: Values: 387.1 391.4 391.6 391.8 397.7 16038.9 16974.0 17719.6 18362.7 18473.4 11435.0 11630.7 11656.4 11692.5 11852.6 5030.6 5148.9 5151.2 5162.6 5180.1 5367.8 5411.9 5544.9 5547.2 5560.9 5417.1 5458.5 5467.6 5912.9 6290.3 6238.3 6242.3 6248.6 6250.6 6259.8 5102.2 5162.6 5222.7 5543.8 5582.4 13313.6 13411.9 13443.7 13504.9 13640.1 2200.2 2258.9 2274.5 2315.3 2422.2 10009.3 10217.7 10239.7 10320.8 10331.5 1902.8 1940.6 1946.2 2034.2 2062.4 63774.0 65467.3 65664.3 66458.7 66480.0 10863.5 11111.1 11113.8 11198.4 11243.1 14573.3 14730.3 14758.5 14779.7 14799.6 8137.7 8154.7 8176.3 8201.9 8203.8 7933.0 7993.1 8005.7 8006.0 8038.0 4517.8 4648.6 4802.3 4836.7 4859.2 1987.4 2023.6 2043.7 2050.1 2055.6 935.4 1007.7 1048.3 1086.8 1090.2 17173.5 18157.5 18224.5 18497.4 18532.4 870.4 947.7 955.4 976.2 1003.1 9493.7 9664.4 9679.6 9824.4 9953.2 649159.8 653880.0 668438.0 704330.5 706064.0 81667.5 87726.0 88194.1 89435.6 89439.6 1203.7 1214.2 1215.2 1218.3 1225.2 16660.2 16813.7 16821.7 16831.6 16947.0 37565.1 37764.6 37827.0 38184.4 38198.0 45459.8 47875.0 49212.0 49811.3 49939.0 9788.7 10180.0 10214.8 10253.4 10300.6 17513.4 17522.4 17624.4 18095.7 18560.1 14919.2 15133.5 15233.5 15286.5 15455.8 15169.7 15489.5 15689.9 15704.1 15920.5 15544.5 15925.9 16093.9 16223.4 16499.8 9923.1 10211.9 10371.6 10725.4 10816.9 10152.0 10700.0 15558.0 15780.4 15836.9 16:57:09 INFO - 2016-01-22 16:57:09,246 DEBUG : BROWSER_OUTPUT: 16:57:09 INFO - 2016-01-22 16:57:09,246 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5907.93 Median:5687.90 stddev:3112.11 (54.7%) stddev-sans-first:3103.84 16:57:09 INFO - 2016-01-22 16:57:09,246 DEBUG : BROWSER_OUTPUT: Values: 1580.6 1595.9 1838.8 1882.6 1889.0 8297.5 8390.5 8595.6 8604.6 8667.7 8580.8 8590.6 8624.7 8659.5 8707.5 2361.0 2396.0 2397.7 2402.6 2404.5 2348.9 2403.5 2444.8 2446.0 2457.8 2088.4 2163.2 2403.6 2428.0 2449.9 2348.8 2362.4 2371.3 2376.6 2377.1 2449.1 2458.1 2488.6 2489.4 2491.4 8450.4 8498.4 8509.9 8511.6 8535.1 5054.4 5104.9 5116.9 5128.7 5133.6 3232.0 3268.3 3329.6 3352.5 3355.1 965.6 984.9 998.9 1035.8 1056.0 11783.5 11935.6 11952.5 11955.3 11986.6 4435.6 4462.4 4487.1 4527.5 4553.0 9465.0 9516.9 9546.4 9610.0 9638.6 5049.4 5055.3 5064.2 5079.5 5087.8 4633.9 4661.2 4673.7 4688.8 4702.6 3654.0 3700.4 3719.1 3751.6 3770.1 1112.9 1113.4 1113.6 1113.7 1116.7 1088.9 1095.0 1154.0 1322.9 1324.3 7744.3 7779.5 7795.1 7805.4 7816.5 1180.5 1181.5 1188.9 1190.9 1212.1 6242.2 6246.1 6280.7 6295.2 6301.9 9941.8 10099.7 10266.6 10353.5 10363.6 10100.3 10121.9 10204.1 10209.1 10267.4 7840.3 7976.6 8024.6 8094.5 8119.6 7654.9 7730.3 7757.3 7773.3 7788.9 9017.4 9086.0 9148.8 9300.4 9308.0 9314.0 9321.1 9423.0 9466.2 9619.0 7206.5 7217.5 7230.1 7240.4 7302.5 8130.5 8154.1 8219.6 8236.3 8237.1 7594.3 7599.4 7645.0 7748.5 7777.4 6653.2 6684.4 7385.0 7497.1 7625.3 7722.3 7768.2 7789.7 7790.5 7814.2 7084.5 7113.8 7116.8 7123.9 7134.9 6951.9 6970.5 6971.0 7040.9 7056.7 16:57:09 INFO - 2016-01-22 16:57:09,246 DEBUG : BROWSER_OUTPUT: 16:57:09 INFO - 2016-01-22 16:57:09,246 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5734.93 Median:6550.89 stddev:1741.44 (26.6%) stddev-sans-first:1699.26 16:57:09 INFO - 2016-01-22 16:57:09,247 DEBUG : BROWSER_OUTPUT: Values: 377.7 380.0 380.3 381.5 390.2 6444.2 6471.1 6491.0 6539.0 6627.4 6398.7 6429.1 6457.0 6458.8 6467.9 4947.6 4949.0 4957.7 4959.4 4968.0 4970.0 4972.8 4972.9 4974.4 4987.0 4719.3 4719.7 4782.1 4782.5 4868.1 4725.8 4740.2 4746.2 4749.0 4749.4 4221.2 4239.0 4241.3 4244.6 4245.4 5954.5 5961.9 5967.9 5970.3 5973.8 5520.4 5592.8 5602.2 5606.1 5616.9 6621.6 6622.6 6622.9 6626.2 6637.2 4631.4 4644.5 4676.4 4677.8 4679.2 6865.7 6935.8 7009.4 7022.1 7039.1 4841.9 4851.6 4856.3 4868.1 4868.3 4929.6 4930.2 4932.1 4938.3 4942.7 5611.8 5655.6 5657.2 5658.8 5676.9 6702.1 6839.0 6876.2 6883.6 6901.1 1713.4 1731.9 1736.8 1738.6 1739.6 1167.0 1177.3 1187.7 1200.2 1202.7 6544.4 6549.8 6552.0 6555.8 6558.3 7089.2 7116.8 7130.2 7133.8 7145.9 6558.8 6566.7 6575.1 6684.7 6689.2 3868.1 3872.3 3879.9 3891.5 3910.4 7275.4 7309.9 7330.1 7373.8 7382.4 7205.0 7367.9 7368.9 7373.0 7375.3 7294.6 7300.7 7345.4 7357.6 7361.6 7145.8 7184.3 7192.4 7193.0 7202.4 6924.3 7096.4 7111.5 7113.8 7121.2 7326.3 7334.9 7372.5 7402.7 7409.3 4911.3 4943.2 4946.2 4956.1 4961.0 6955.5 7138.6 7195.8 7202.5 7223.2 6944.7 6993.7 6999.7 7002.3 7007.1 6797.3 6851.3 6865.2 6882.3 7001.0 6803.2 6807.4 6878.4 6879.3 6883.8 6961.8 6979.4 7006.2 7029.1 7047.9 6700.1 6792.3 6799.6 6841.7 6851.5 16:57:09 INFO - 2016-01-22 16:57:09,247 DEBUG : BROWSER_OUTPUT: 16:57:09 INFO - 2016-01-22 16:57:09,248 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14180.53 Median:25268.29 stddev:15978.04 (63.2%) stddev-sans-first:15991.11 16:57:09 INFO - 2016-01-22 16:57:09,248 DEBUG : BROWSER_OUTPUT: Values: 767.2 789.1 804.0 824.4 892.4 16999.0 17384.1 17393.8 17443.0 17443.0 14242.5 14287.1 14322.4 14400.3 14442.8 913.5 930.3 933.0 936.1 936.8 928.3 929.8 934.3 934.4 934.9 912.5 970.5 971.7 974.1 974.4 947.9 969.6 969.8 971.4 971.9 709.2 716.1 720.7 721.9 723.0 14518.6 14688.2 14698.0 14702.7 14722.9 11903.8 12210.3 12840.5 12853.8 13063.3 9864.0 10531.1 10715.8 10786.7 10808.2 3710.0 3787.7 3790.5 3794.7 3809.6 47008.8 47212.5 47403.3 47467.7 47690.8 9895.7 10123.9 10150.9 10187.6 10274.4 18339.5 18496.4 18505.3 18867.3 18891.1 7500.0 7721.2 7967.8 7969.4 8248.4 4517.3 4531.3 4596.5 4620.4 4820.8 3175.1 3199.6 3218.5 3230.8 3234.5 565.8 569.8 572.0 572.3 573.9 583.6 624.9 658.5 663.9 691.3 9275.3 9477.3 9501.7 9550.1 9922.0 660.4 682.6 694.5 698.3 701.6 3832.5 3858.9 3891.9 3902.9 3991.9 58273.7 58415.7 58575.4 58926.7 59364.4 49148.0 49284.5 50508.2 51008.7 51339.2 45534.1 45999.3 46454.0 46529.5 46831.3 8715.0 8741.8 8792.1 8968.5 9258.8 35181.0 35728.3 35795.5 37526.1 38317.2 43950.6 45346.0 45360.5 45834.8 45940.1 10766.1 10873.7 10945.0 11502.5 11683.8 12624.7 12662.7 12833.6 13450.8 13720.9 11143.9 11639.6 11850.2 11956.3 12397.9 11314.7 11396.9 11413.5 11616.8 11623.1 11071.5 11165.5 11195.3 11270.5 11412.6 10219.7 10438.8 10543.4 10747.5 10807.1 9277.5 9406.2 9487.0 9877.5 9952.3 16:57:09 INFO - 2016-01-22 16:57:09,248 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:57:09 INFO - 2016-01-22 16:57:09,248 DEBUG : BROWSER_OUTPUT: 16:57:09 INFO - 2016-01-22 16:57:09,913 INFO : Browser exited with error code: 0 16:57:09 INFO - 2016-01-22 16:57:09,930 INFO : Completed test dromaeo_css (00:18:28) 16:57:09 INFO - 2016-01-22 16:57:09,930 INFO : Starting test kraken 16:57:09 INFO - 2016-01-22 16:57:09,930 DEBUG : operating with platform_type : linux_ 16:57:09 INFO - 2016-01-22 16:57:09,930 INFO : Initialising browser for kraken test... 16:57:09 INFO - 2016-01-22 16:57:09,936 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpogmTli/profile http://localhost:45494/getInfo.html 16:57:13 INFO - 2016-01-22 16:57:13,278 DEBUG : BROWSER_OUTPUT: 16:57:13 INFO - 2016-01-22 16:57:13,278 DEBUG : BROWSER_OUTPUT: (process:24489): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:57:14 INFO - 2016-01-22 16:57:14,052 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:57:14 INFO - 2016-01-22 16:57:14,053 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:57:14 INFO - 2016-01-22 16:57:14,053 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:57:14 INFO - 2016-01-22 16:57:14,053 DEBUG : BROWSER_OUTPUT: __metrics 16:57:15 INFO - 2016-01-22 16:57:15,009 INFO : Browser initialized. 16:57:15 INFO - 2016-01-22 16:57:15,010 INFO : Running cycle 1/1 for kraken test... 16:57:15 INFO - 2016-01-22 16:57:15,010 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpogmTli/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:57:16 INFO - 2016-01-22 16:57:16,300 DEBUG : BROWSER_OUTPUT: 16:57:16 INFO - 2016-01-22 16:57:16,300 DEBUG : BROWSER_OUTPUT: (process:24606): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:57:26 INFO - 2016-01-22 16:57:26,799 DEBUG : BROWSER_OUTPUT: RSS: Main: 135938048 16:57:26 INFO - 2016-01-22 16:57:26,799 DEBUG : BROWSER_OUTPUT: 16:57:29 INFO - 2016-01-22 16:57:29,238 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45494/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45494/tests/kraken/driver.html?testName=audio-beat-detection) 16:57:29 INFO - 2016-01-22 16:57:29,849 DEBUG : BROWSER_OUTPUT: RSS: Main: 138055680 16:57:29 INFO - 2016-01-22 16:57:29,849 DEBUG : BROWSER_OUTPUT: 16:57:32 INFO - 2016-01-22 16:57:32,433 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45494/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45494/tests/kraken/driver.html?testName=audio-dft) 16:57:33 INFO - 2016-01-22 16:57:33,027 DEBUG : BROWSER_OUTPUT: RSS: Main: 138932224 16:57:33 INFO - 2016-01-22 16:57:33,027 DEBUG : BROWSER_OUTPUT: 16:57:35 INFO - 2016-01-22 16:57:35,830 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45494/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45494/tests/kraken/driver.html?testName=audio-fft) 16:57:36 INFO - 2016-01-22 16:57:36,410 DEBUG : BROWSER_OUTPUT: RSS: Main: 138473472 16:57:36 INFO - 2016-01-22 16:57:36,411 DEBUG : BROWSER_OUTPUT: 16:57:38 INFO - 2016-01-22 16:57:38,463 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45494/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45494/tests/kraken/driver.html?testName=audio-oscillator) 16:57:39 INFO - 2016-01-22 16:57:39,044 DEBUG : BROWSER_OUTPUT: RSS: Main: 139268096 16:57:39 INFO - 2016-01-22 16:57:39,044 DEBUG : BROWSER_OUTPUT: 16:57:41 INFO - 2016-01-22 16:57:41,238 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45494/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45494/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:57:41 INFO - 2016-01-22 16:57:41,821 DEBUG : BROWSER_OUTPUT: RSS: Main: 138526720 16:57:41 INFO - 2016-01-22 16:57:41,821 DEBUG : BROWSER_OUTPUT: 16:57:44 INFO - 2016-01-22 16:57:44,780 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45494/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45494/tests/kraken/driver.html?testName=imaging-darkroom) 16:57:45 INFO - 2016-01-22 16:57:45,354 DEBUG : BROWSER_OUTPUT: RSS: Main: 139005952 16:57:45 INFO - 2016-01-22 16:57:45,354 DEBUG : BROWSER_OUTPUT: 16:57:48 INFO - 2016-01-22 16:57:48,676 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45494/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45494/tests/kraken/driver.html?testName=imaging-desaturate) 16:57:49 INFO - 2016-01-22 16:57:49,278 DEBUG : BROWSER_OUTPUT: RSS: Main: 139558912 16:57:49 INFO - 2016-01-22 16:57:49,278 DEBUG : BROWSER_OUTPUT: 16:57:52 INFO - 2016-01-22 16:57:52,081 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45494/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45494/tests/kraken/driver.html?testName=json-parse-financial) 16:57:52 INFO - 2016-01-22 16:57:52,667 DEBUG : BROWSER_OUTPUT: RSS: Main: 139694080 16:57:52 INFO - 2016-01-22 16:57:52,668 DEBUG : BROWSER_OUTPUT: 16:57:54 INFO - 2016-01-22 16:57:54,249 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45494/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45494/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:57:54 INFO - 2016-01-22 16:57:54,822 DEBUG : BROWSER_OUTPUT: RSS: Main: 139280384 16:57:54 INFO - 2016-01-22 16:57:54,822 DEBUG : BROWSER_OUTPUT: 16:57:56 INFO - 2016-01-22 16:57:56,598 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45494/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45494/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:57:57 INFO - 2016-01-22 16:57:57,205 DEBUG : BROWSER_OUTPUT: RSS: Main: 139079680 16:57:57 INFO - 2016-01-22 16:57:57,205 DEBUG : BROWSER_OUTPUT: 16:57:59 INFO - 2016-01-22 16:57:59,217 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45494/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45494/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:57:59 INFO - 2016-01-22 16:57:59,804 DEBUG : BROWSER_OUTPUT: RSS: Main: 138932224 16:57:59 INFO - 2016-01-22 16:57:59,804 DEBUG : BROWSER_OUTPUT: 16:58:02 INFO - 2016-01-22 16:58:02,224 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45494/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45494/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:58:02 INFO - 2016-01-22 16:58:02,818 DEBUG : BROWSER_OUTPUT: RSS: Main: 138932224 16:58:02 INFO - 2016-01-22 16:58:02,818 DEBUG : BROWSER_OUTPUT: 16:58:05 INFO - 2016-01-22 16:58:05,365 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45494/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45494/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:58:05 INFO - 2016-01-22 16:58:05,955 DEBUG : BROWSER_OUTPUT: RSS: Main: 139911168 16:58:05 INFO - 2016-01-22 16:58:05,956 DEBUG : BROWSER_OUTPUT: 16:58:07 INFO - 2016-01-22 16:58:07,630 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45494/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45494/tests/kraken/driver.html?testName=ai-astar) 16:58:07 INFO - 2016-01-22 16:58:07,881 DEBUG : BROWSER_OUTPUT: RSS: Main: 140410880 16:58:07 INFO - 2016-01-22 16:58:07,881 DEBUG : BROWSER_OUTPUT: 16:58:07 INFO - 2016-01-22 16:58:07,882 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:58:07 INFO - 2016-01-22 16:58:07,883 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:58:07 INFO - 2016-01-22 16:58:07,884 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:58:07 INFO - 2016-01-22 16:58:07,884 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:58:07 INFO - 2016-01-22 16:58:07,884 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;103;109;109;110;120;110;109;111;110 16:58:07 INFO - 2016-01-22 16:58:07,884 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;122;155;160;122;157;158;128;152;122 16:58:07 INFO - 2016-01-22 16:58:07,885 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;162;161;164;161;162;163;162;161 16:58:07 INFO - 2016-01-22 16:58:07,885 DEBUG : BROWSER_OUTPUT: |3;audio-fft;78;75;72;162;75;74;77;73;176;74 16:58:07 INFO - 2016-01-22 16:58:07,885 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;134;92;92;93;142;92;93;135 16:58:07 INFO - 2016-01-22 16:58:07,885 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;109;110;110;110;110;110;110 16:58:07 INFO - 2016-01-22 16:58:07,885 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;148;146;147;147;147;147;146;147 16:58:07 INFO - 2016-01-22 16:58:07,885 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;96;97;95;96;97 16:58:07 INFO - 2016-01-22 16:58:07,886 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;60;62;63;61;61;60;61;60;60 16:58:07 INFO - 2016-01-22 16:58:07,886 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;64;64;65;70;65;65;65;64;64 16:58:07 INFO - 2016-01-22 16:58:07,886 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;82;84;82;83;90;82;82;89;82 16:58:07 INFO - 2016-01-22 16:58:07,886 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;123;117;119;127;121;115;127;115;117 16:58:07 INFO - 2016-01-22 16:58:07,886 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;153;144;147;150;144;146;143;144;147 16:58:07 INFO - 2016-01-22 16:58:07,886 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;72;65;66;68;67;69;72;65;66 16:58:07 INFO - 2016-01-22 16:58:07,886 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:58:07 INFO - 2016-01-22 16:58:07,886 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:58:07 INFO - 2016-01-22 16:58:07,887 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,703 16:58:07 INFO - 2016-01-22 16:58:07,887 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:58:07 INFO - 2016-01-22 16:58:07,887 DEBUG : BROWSER_OUTPUT: __startTimestamp1453510687882__endTimestamp 16:58:07 INFO - 2016-01-22 16:58:07,887 DEBUG : BROWSER_OUTPUT: 16:58:07 INFO - 2016-01-22 16:58:07,890 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:58:07 INFO - 2016-01-22 16:58:07,891 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:58:07 INFO - 2016-01-22 16:58:07,891 DEBUG : BROWSER_OUTPUT: 16:58:07 INFO - 2016-01-22 16:58:07,891 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.30 Median:110.00 stddev:4.16 (3.8%) stddev-sans-first:4.37 16:58:07 INFO - 2016-01-22 16:58:07,891 DEBUG : BROWSER_OUTPUT: Values: 112.0 103.0 109.0 109.0 110.0 120.0 110.0 109.0 111.0 110.0 16:58:07 INFO - 2016-01-22 16:58:07,892 DEBUG : BROWSER_OUTPUT: 16:58:07 INFO - 2016-01-22 16:58:07,892 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.80 Median:153.50 stddev:16.88 (11.0%) stddev-sans-first:17.57 16:58:07 INFO - 2016-01-22 16:58:07,892 DEBUG : BROWSER_OUTPUT: Values: 152.0 122.0 155.0 160.0 122.0 157.0 158.0 128.0 152.0 122.0 16:58:07 INFO - 2016-01-22 16:58:07,892 DEBUG : BROWSER_OUTPUT: 16:58:07 INFO - 2016-01-22 16:58:07,893 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.03 (0.6%) stddev-sans-first:1.05 16:58:07 INFO - 2016-01-22 16:58:07,893 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 162.0 161.0 164.0 161.0 162.0 163.0 162.0 161.0 16:58:07 INFO - 2016-01-22 16:58:07,893 DEBUG : BROWSER_OUTPUT: 16:58:07 INFO - 2016-01-22 16:58:07,893 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:93.60 Median:74.50 stddev:39.91 (53.6%) stddev-sans-first:41.93 16:58:07 INFO - 2016-01-22 16:58:07,893 DEBUG : BROWSER_OUTPUT: Values: 78.0 75.0 72.0 162.0 75.0 74.0 77.0 73.0 176.0 74.0 16:58:07 INFO - 2016-01-22 16:58:07,893 DEBUG : BROWSER_OUTPUT: 16:58:07 INFO - 2016-01-22 16:58:07,894 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.90 Median:92.50 stddev:21.56 (23.3%) stddev-sans-first:22.36 16:58:07 INFO - 2016-01-22 16:58:07,894 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 134.0 92.0 92.0 93.0 142.0 92.0 93.0 135.0 16:58:07 INFO - 2016-01-22 16:58:07,894 DEBUG : BROWSER_OUTPUT: 16:58:07 INFO - 2016-01-22 16:58:07,894 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 16:58:07 INFO - 2016-01-22 16:58:07,894 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 109.0 110.0 110.0 110.0 110.0 110.0 110.0 16:58:07 INFO - 2016-01-22 16:58:07,894 DEBUG : BROWSER_OUTPUT: 16:58:07 INFO - 2016-01-22 16:58:07,894 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 16:58:07 INFO - 2016-01-22 16:58:07,894 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 148.0 146.0 147.0 147.0 147.0 147.0 146.0 147.0 16:58:07 INFO - 2016-01-22 16:58:07,894 DEBUG : BROWSER_OUTPUT: 16:58:07 INFO - 2016-01-22 16:58:07,894 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 16:58:07 INFO - 2016-01-22 16:58:07,894 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 96.0 97.0 95.0 96.0 97.0 16:58:07 INFO - 2016-01-22 16:58:07,894 DEBUG : BROWSER_OUTPUT: 16:58:07 INFO - 2016-01-22 16:58:07,895 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.80 Median:61.00 stddev:1.03 (1.7%) stddev-sans-first:1.05 16:58:07 INFO - 2016-01-22 16:58:07,895 DEBUG : BROWSER_OUTPUT: Values: 60.0 60.0 62.0 63.0 61.0 61.0 60.0 61.0 60.0 60.0 16:58:07 INFO - 2016-01-22 16:58:07,895 DEBUG : BROWSER_OUTPUT: 16:58:07 INFO - 2016-01-22 16:58:07,895 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:1.79 (2.8%) stddev-sans-first:1.90 16:58:07 INFO - 2016-01-22 16:58:07,895 DEBUG : BROWSER_OUTPUT: Values: 65.0 64.0 64.0 65.0 70.0 65.0 65.0 65.0 64.0 64.0 16:58:07 INFO - 2016-01-22 16:58:07,895 DEBUG : BROWSER_OUTPUT: 16:58:07 INFO - 2016-01-22 16:58:07,895 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:82.50 stddev:3.08 (3.7%) stddev-sans-first:3.20 16:58:07 INFO - 2016-01-22 16:58:07,895 DEBUG : BROWSER_OUTPUT: Values: 82.0 82.0 84.0 82.0 83.0 90.0 82.0 82.0 89.0 82.0 16:58:07 INFO - 2016-01-22 16:58:07,895 DEBUG : BROWSER_OUTPUT: 16:58:07 INFO - 2016-01-22 16:58:07,895 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.20 Median:121.00 stddev:4.44 (3.7%) stddev-sans-first:4.70 16:58:07 INFO - 2016-01-22 16:58:07,895 DEBUG : BROWSER_OUTPUT: Values: 121.0 123.0 117.0 119.0 127.0 121.0 115.0 127.0 115.0 117.0 16:58:07 INFO - 2016-01-22 16:58:07,896 DEBUG : BROWSER_OUTPUT: 16:58:07 INFO - 2016-01-22 16:58:07,896 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.10 Median:146.50 stddev:3.28 (2.2%) stddev-sans-first:3.28 16:58:07 INFO - 2016-01-22 16:58:07,896 DEBUG : BROWSER_OUTPUT: Values: 143.0 153.0 144.0 147.0 150.0 144.0 146.0 143.0 144.0 147.0 16:58:07 INFO - 2016-01-22 16:58:07,896 DEBUG : BROWSER_OUTPUT: 16:58:07 INFO - 2016-01-22 16:58:07,896 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.50 stddev:2.72 (4.0%) stddev-sans-first:2.73 16:58:07 INFO - 2016-01-22 16:58:07,896 DEBUG : BROWSER_OUTPUT: Values: 65.0 72.0 65.0 66.0 68.0 67.0 69.0 72.0 65.0 66.0 16:58:07 INFO - 2016-01-22 16:58:07,896 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:58:07 INFO - 2016-01-22 16:58:07,896 DEBUG : BROWSER_OUTPUT: 16:58:08 INFO - 2016-01-22 16:58:08,725 INFO : Browser exited with error code: 0 16:58:08 INFO - 2016-01-22 16:58:08,774 INFO : Completed test kraken (00:00:58) 16:58:08 INFO - 2016-01-22 16:58:08,774 INFO : Starting test v8_7 16:58:08 INFO - 2016-01-22 16:58:08,774 DEBUG : operating with platform_type : linux_ 16:58:08 INFO - 2016-01-22 16:58:08,774 INFO : Initialising browser for v8_7 test... 16:58:08 INFO - 2016-01-22 16:58:08,780 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSTnrFH/profile http://localhost:45494/getInfo.html 16:58:12 INFO - 2016-01-22 16:58:12,116 DEBUG : BROWSER_OUTPUT: 16:58:12 INFO - 2016-01-22 16:58:12,116 DEBUG : BROWSER_OUTPUT: (process:24913): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:58:12 INFO - 2016-01-22 16:58:12,947 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:58:12 INFO - 2016-01-22 16:58:12,947 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:58:12 INFO - 2016-01-22 16:58:12,947 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:58:12 INFO - 2016-01-22 16:58:12,947 DEBUG : BROWSER_OUTPUT: __metrics 16:58:13 INFO - 2016-01-22 16:58:13,913 INFO : Browser initialized. 16:58:13 INFO - 2016-01-22 16:58:13,914 INFO : Running cycle 1/1 for v8_7 test... 16:58:13 INFO - 2016-01-22 16:58:13,914 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSTnrFH/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:58:15 INFO - 2016-01-22 16:58:15,170 DEBUG : BROWSER_OUTPUT: 16:58:15 INFO - 2016-01-22 16:58:15,170 DEBUG : BROWSER_OUTPUT: (process:25027): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:58:25 INFO - 2016-01-22 16:58:25,679 DEBUG : BROWSER_OUTPUT: RSS: Main: 136450048 16:58:25 INFO - 2016-01-22 16:58:25,679 DEBUG : BROWSER_OUTPUT: 16:58:46 INFO - 2016-01-22 16:58:46,949 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45494/tests/v8_7/run.html (next: http://localhost:45494/tests/v8_7/run.html) 16:58:47 INFO - 2016-01-22 16:58:47,199 DEBUG : BROWSER_OUTPUT: RSS: Main: 136335360 16:58:47 INFO - 2016-01-22 16:58:47,200 DEBUG : BROWSER_OUTPUT: 16:58:47 INFO - 2016-01-22 16:58:47,201 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:58:47 INFO - 2016-01-22 16:58:47,201 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:58:47 INFO - 2016-01-22 16:58:47,201 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:58:47 INFO - 2016-01-22 16:58:47,201 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:58:47 INFO - 2016-01-22 16:58:47,201 DEBUG : BROWSER_OUTPUT: |0;Richards;164.0150893882237 16:58:47 INFO - 2016-01-22 16:58:47,202 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;166.91704223001167 16:58:47 INFO - 2016-01-22 16:58:47,202 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.78449958182324 16:58:47 INFO - 2016-01-22 16:58:47,202 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5196.891191709845 16:58:47 INFO - 2016-01-22 16:58:47,202 DEBUG : BROWSER_OUTPUT: |4;RayTrace;919.9632014719411 16:58:47 INFO - 2016-01-22 16:58:47,202 DEBUG : BROWSER_OUTPUT: |5;Earley;548.2456140350877 16:58:47 INFO - 2016-01-22 16:58:47,203 DEBUG : BROWSER_OUTPUT: |6;Boyer;10989.010989010989 16:58:47 INFO - 2016-01-22 16:58:47,203 DEBUG : BROWSER_OUTPUT: |7;RegExp;25717.94871794872 16:58:47 INFO - 2016-01-22 16:58:47,203 DEBUG : BROWSER_OUTPUT: |8;Splay;500.2496255616575 16:58:47 INFO - 2016-01-22 16:58:47,203 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 16:58:47 INFO - 2016-01-22 16:58:47,204 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:58:47 INFO - 2016-01-22 16:58:47,204 DEBUG : BROWSER_OUTPUT: __startTimestamp1453510727200__endTimestamp 16:58:47 INFO - 2016-01-22 16:58:47,204 DEBUG : BROWSER_OUTPUT: 16:58:47 INFO - 2016-01-22 16:58:47,204 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:58:47 INFO - 2016-01-22 16:58:47,205 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:58:47 INFO - 2016-01-22 16:58:47,205 DEBUG : BROWSER_OUTPUT: 16:58:47 INFO - 2016-01-22 16:58:47,205 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.02 Median:164.02 stddev:0.00 (0.0%) 16:58:47 INFO - 2016-01-22 16:58:47,205 DEBUG : BROWSER_OUTPUT: Values: 164.0 16:58:47 INFO - 2016-01-22 16:58:47,205 DEBUG : BROWSER_OUTPUT: 16:58:47 INFO - 2016-01-22 16:58:47,205 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:166.92 Median:166.92 stddev:0.00 (0.0%) 16:58:47 INFO - 2016-01-22 16:58:47,205 DEBUG : BROWSER_OUTPUT: Values: 166.9 16:58:47 INFO - 2016-01-22 16:58:47,206 DEBUG : BROWSER_OUTPUT: 16:58:47 INFO - 2016-01-22 16:58:47,206 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.78 Median:278.78 stddev:0.00 (0.0%) 16:58:47 INFO - 2016-01-22 16:58:47,206 DEBUG : BROWSER_OUTPUT: Values: 278.8 16:58:47 INFO - 2016-01-22 16:58:47,206 DEBUG : BROWSER_OUTPUT: 16:58:47 INFO - 2016-01-22 16:58:47,206 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 16:58:47 INFO - 2016-01-22 16:58:47,206 DEBUG : BROWSER_OUTPUT: Values: 5196.9 16:58:47 INFO - 2016-01-22 16:58:47,206 DEBUG : BROWSER_OUTPUT: 16:58:47 INFO - 2016-01-22 16:58:47,206 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:919.96 Median:919.96 stddev:0.00 (0.0%) 16:58:47 INFO - 2016-01-22 16:58:47,207 DEBUG : BROWSER_OUTPUT: Values: 920.0 16:58:47 INFO - 2016-01-22 16:58:47,207 DEBUG : BROWSER_OUTPUT: 16:58:47 INFO - 2016-01-22 16:58:47,207 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:548.25 Median:548.25 stddev:0.00 (0.0%) 16:58:47 INFO - 2016-01-22 16:58:47,207 DEBUG : BROWSER_OUTPUT: Values: 548.2 16:58:47 INFO - 2016-01-22 16:58:47,207 DEBUG : BROWSER_OUTPUT: 16:58:47 INFO - 2016-01-22 16:58:47,207 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10989.01 Median:10989.01 stddev:0.00 (0.0%) 16:58:47 INFO - 2016-01-22 16:58:47,207 DEBUG : BROWSER_OUTPUT: Values: 10989.0 16:58:47 INFO - 2016-01-22 16:58:47,207 DEBUG : BROWSER_OUTPUT: 16:58:47 INFO - 2016-01-22 16:58:47,207 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25717.95 Median:25717.95 stddev:0.00 (0.0%) 16:58:47 INFO - 2016-01-22 16:58:47,209 DEBUG : BROWSER_OUTPUT: Values: 25717.9 16:58:47 INFO - 2016-01-22 16:58:47,209 DEBUG : BROWSER_OUTPUT: 16:58:47 INFO - 2016-01-22 16:58:47,209 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:500.25 Median:500.25 stddev:0.00 (0.0%) 16:58:47 INFO - 2016-01-22 16:58:47,209 DEBUG : BROWSER_OUTPUT: Values: 500.2 16:58:47 INFO - 2016-01-22 16:58:47,209 DEBUG : BROWSER_OUTPUT: 16:58:47 INFO - 2016-01-22 16:58:47,209 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 16:58:47 INFO - 2016-01-22 16:58:47,209 DEBUG : BROWSER_OUTPUT: Values: 4840.6 16:58:47 INFO - 2016-01-22 16:58:47,209 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:58:47 INFO - 2016-01-22 16:58:47,209 DEBUG : BROWSER_OUTPUT: 16:58:48 INFO - 2016-01-22 16:58:48,041 INFO : Browser exited with error code: 0 16:58:48 INFO - 2016-01-22 16:58:48,060 INFO : Completed test v8_7 (00:00:39) 16:58:48 INFO - 2016-01-22 16:58:48,309 INFO : Completed test suite (00:20:06) 16:58:48 INFO - 2016-01-22 16:58:48,309 DEBUG : Working with test: dromaeo_css 16:58:48 INFO - 2016-01-22 16:58:48,309 DEBUG : Generating results file: dromaeo_css 16:58:48 INFO - 2016-01-22 16:58:48,310 DEBUG : Working with test: kraken 16:58:48 INFO - 2016-01-22 16:58:48,310 DEBUG : Generating results file: kraken 16:58:48 INFO - 2016-01-22 16:58:48,310 INFO : javascript benchmark 16:58:48 INFO - 2016-01-22 16:58:48,311 DEBUG : Working with test: v8_7 16:58:48 INFO - 2016-01-22 16:58:48,311 DEBUG : Generating results file: v8_7 16:58:48 INFO - 2016-01-22 16:58:48,311 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:58:48 INFO - 2016-01-22 16:58:48,360 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 16:58:48 INFO - 2016-01-22 16:58:48,360 DEBUG : process_Request line: dromaeo_css 7479.64 graph.html#tests=[[72,52,43]] 16:58:48 INFO - 2016-01-22 16:58:48,361 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:58:48 INFO - 2016-01-22 16:58:48,398 DEBUG : process_Request line: kraken 1510.50 graph.html#tests=[[232,52,43]] 16:58:48 INFO - 2016-01-22 16:58:48,398 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:58:48 INFO - 2016-01-22 16:58:48,430 DEBUG : process_Request line: v8_7 23218.50 graph.html#tests=[[230,52,43]] 16:58:48 INFO - 2016-01-22 16:58:48,432 INFO : javascript benchmark 16:58:48 INFO - 2016-01-22 16:58:48,435 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3267.1505408593766, 3278.131295206772, 3304.636489986103, 3313.9337213255735, 3326.7837590556605, 5502.889942201158, 5520.9999999999945, 5529.0, 5532.031894418481, 5562.3881373048935, 5610.523105536025, 5619.5785316101255, 5625.268715067045, 5648.830535083944, 5651.463111004458, 5136.537711605945, 5144.948550514484, 5195.870103247411, 5203.895922081556, 5208.935873142512, 5010.624203184758, 5132.127538318477, 5133.230015497668, 5139.640225184238, 5194.896102077956, 5129.204973229155, 5205.0, 5207.739613019353, 5277.050130976423, 5318.760655770499, 5236.502532259429, 5266.183741520071, 5266.2627232187715, 5271.182966640177, 5322.654027488201, 4923.630727695401, 5101.795928162906, 5155.896882062375, 5167.09575824233, 5217.060929032773, 5371.865703357447, 5471.7264136793, 5473.397926228112, 5494.972525137388, 5531.861703457405, 6060.030395136757, 6074.908876366858, 6106.419890110433, 6121.296050954153, 6126.081087836816, 5993.4006599340155, 6040.637561746309, 6130.724117414727, 6177.845553861144, 6187.690615469209, 5744.195812586199, 5817.941820581825, 5819.010768169379, 5822.737976791054, 5828.5628577856405, 6314.431701146918, 6343.873122537523, 6367.61794292344, 6368.904466433008, 6387.584806987624, 5705.115707065412, 5867.530597552186, 5906.291245050621, 6016.639001659827, 6102.0541816018585, 6066.939330606726, 6113.938860611426, 6118.204633397719, 6137.202163718688, 6154.599951003171, 6056.576039677268, 6058.27300723916, 6097.207363042776, 6102.72537735803, 6109.7861574844665, 5882.617629854046, 5954.345022047572, 5995.52035837132, 6046.455818976313, 6087.57386982907, 4636.095961287517, 4636.304554316879, 4641.675082744176, 4661.3707149534375, 4668.883277918079, 4023.5574086850424, 4165.97917010419, 4167.8958026049595, 4181.749095054246, 4184.748915065105, 5741.3971532988435, 5782.710864456844, 5860.443257890493, 5901.675407852609, 5943.375945525744, 6102.481289090389, 6142.78500252489, 6145.9692701536205, 6149.0776383542825, 6162.784302549389, 5574.470425309589, 5703.7148142592705, 5745.913811292834, 5759.136129580513, 5759.308882934075, 5263.184206448007, 5316.680999140064, 5320.281761962163, 5335.973320133375, 5365.222042803772, 6247.656378899204, 6280.623162610258, 6281.214848143982, 6288.685565721696, 6298.685065746694, 5911.7635294587735, 6026.608270462406, 6105.328413874381, 6170.6914654268, 6172.567920245539, 6218.347073557211, 6306.905396418965, 6365.267994180544, 6373.5857169283845, 6390.0, 6107.511399088151, 6117.84705382369, 6129.938700612936, 6132.816015519542, 6143.047827586731, 5928.584999050025, 6007.279126504847, 6040.214772079602, 6138.508919286535, 6228.096925945803, 6024.7288872001745, 6126.632402055891, 6129.816105516842, 6130.049842274455, 6132.846678833065, 6056.5154787616, 6120.08198770188, 6121.3572574879, 6122.020476723703, 6130.50955923534, 5679.233303504139, 5720.45655662728, 5779.36426993022, 5811.680357580204, 5996.910046349395, 6046.244219472566, 6074.42292982166, 6113.419225173601, 6135.938640613536, 6146.354632763496, 5968.0, 5984.19213406202, 5985.461308482258, 5986.580939334205, 6003.669798161143], "unit": "ms", "name": "dojo.html", "value": 5625.229001280472}, {"lowerIsBetter": false, "replicates": [574.8304250246177, 602.1990752299442, 615.8545106102649, 620.4075108271601, 689.8896176611743, 31882.20294492639, 33238.83380583097, 41411.58588414115, 41440.585594144046, 41557.0, 45809.0, 45946.0, 45960.0, 46078.078438431214, 46325.0, 9068.637254509811, 9238.491882946435, 9267.814643707121, 9269.768255793626, 9285.489298088602, 8972.102789721008, 9091.863622045674, 9117.088291170863, 9126.406783559081, 9130.0, 9057.275417966546, 9075.319351048665, 9100.271978241724, 9138.588763505659, 9170.770730731718, 9087.045860184684, 9122.315826313054, 9146.31402644801, 9162.816743665122, 9184.954075229647, 8971.820563588692, 9110.0, 9118.452892826452, 9126.13301736334, 9148.359614826964, 40965.0, 41396.79301603503, 41941.1611767766, 41963.790181049204, 42243.0, 3220.983895080533, 3347.2468694543777, 3458.325626502833, 3504.8598056077726, 3752.43713442983, 30711.846440767877, 30894.845525772453, 30909.381812363852, 31337.37325253482, 31597.36805263882, 3377.0881861897396, 3388.542546756206, 3425.0752296879705, 3430.382531144393, 3462.0998540379683, 282326.0, 283723.0, 283846.0, 284841.0, 285942.0, 62911.68544157341, 64147.0, 71821.6408917952, 72255.0, 72391.63804180945, 64333.356666433676, 64574.354256456834, 64651.35348646547, 64700.35299647038, 64893.0, 17861.374851880122, 18320.26718931228, 18372.632547349247, 18437.815621843878, 18520.444386668423, 13316.866831331563, 13488.797668034988, 13562.728745425036, 13569.321533923265, 13801.171929684251, 21840.453988650093, 22110.447238819157, 22221.44446388821, 22228.777712222993, 22232.221872234717, 7245.203027666952, 7253.0, 7351.772730679773, 7375.668094935741, 7463.664135113933, 962.7978124593914, 988.2538683294067, 1059.4384975962753, 1141.2981016674685, 1171.0338970349496, 27932.894127489435, 28508.572371414444, 28877.27806804847, 28997.0, 29068.854655726587, 1089.1831126655009, 1171.625079974417, 1185.2829038431796, 1201.1411840533885, 1225.148521777356, 15014.924925375302, 15205.61985950338, 15243.314050867737, 15526.9223653881, 15546.9222653886, 423466.0, 770543.0, 775589.0, 777716.0, 820282.0, 58540.121898171565, 60641.393586064456, 60676.08985865216, 60839.479013024145, 60951.39048609546, 1509.260462373451, 1534.0412242348755, 1535.992320038415, 1537.4080978823233, 1550.674358384752, 31084.222894426915, 31344.529832052995, 31358.843205783825, 31661.0, 31974.200644984063, 48797.512024879295, 48855.0, 48924.75537622289, 49308.0, 49331.75334123307, 324815.0, 325872.4825503524, 327252.0, 327891.0, 329523.0, 33217.667823321455, 33561.83219083889, 33767.0, 33834.66165338315, 33985.32029359449, 44663.33005004862, 45058.09883802371, 45161.0, 45685.314720278555, 45754.4835034063, 38752.41871371988, 38803.61196388113, 39796.80101599474, 44303.77848110739, 46006.309905352115, 38418.42372364361, 38581.614183858925, 38654.42018369783, 38828.41757373698, 38999.2200156001, 43326.350104749086, 43796.0, 44318.335224972296, 44487.332690009025, 44866.327005094296, 33530.329393411506, 38663.131774585454, 38937.41593876037, 39380.80309598434, 40184.1963160741, 27449.725502744717, 28359.57460638051, 28639.0, 29895.252618684706, 30759.69240307568], "unit": "ms", "name": "ext.html", "value": 20300.825186301}, {"lowerIsBetter": false, "replicates": [387.08068337697966, 391.43437732476576, 391.59078762693, 391.78451851481697, 397.72954391014133, 16038.919805400987, 16974.0, 17719.645607087852, 18362.724559131606, 18473.35343262986, 11434.970852623263, 11630.651080467578, 11656.417179141052, 11692.532298708042, 11852.644420667371, 5030.622703297258, 5148.948510514884, 5151.175811870102, 5162.561182299491, 5180.067587834188, 5367.785288588452, 5411.864703382407, 5544.91682624761, 5547.223388725582, 5560.916586251189, 5417.106177480711, 5458.5087342139195, 5467.589930755189, 5912.9113063304085, 6290.339514350973, 6238.344973777756, 6242.313345531988, 6248.593841400295, 6250.562460627758, 6259.780907668232, 5102.158143906251, 5162.561182299509, 5222.73886305687, 5543.805966791183, 5582.441755824426, 13313.600591982256, 13411.865881341158, 13443.731125377535, 13504.852087572568, 13640.113392629448, 2200.207925146946, 2258.9322320330416, 2274.5223503064376, 2315.2938353802083, 2422.200673777649, 10009.349392289478, 10217.693469195936, 10239.692809215736, 10320.845187322197, 10331.48342582868, 1902.79069302378, 1940.640981418428, 1946.153423260886, 2034.206659402834, 2062.3709768520594, 63774.0, 65467.345326547074, 65664.3433565663, 66458.66770666116, 66480.0, 10863.45682715861, 11111.111111111091, 11113.83329250062, 11198.44007799623, 11243.100551955824, 14573.271336433136, 14730.263486825615, 14758.483453079305, 14779.704405911822, 14799.556013319618, 8137.715179968673, 8154.714584989497, 8176.264136227649, 8201.917980820235, 8203.8359232815, 7932.960335198402, 7993.120756716757, 8005.719799806979, 8006.039275287003, 8038.0, 4517.81928722854, 4648.604868586208, 4802.255650374198, 4836.733979631154, 4859.198232291632, 1987.4335814292858, 2023.6458619741486, 2043.673012318022, 2050.0774651406928, 2055.6094342075257, 935.3873213045466, 1007.7178390050798, 1048.3028785857318, 1086.788076325109, 1090.1605763562013, 17173.484795456156, 18157.45527634173, 18224.45326640203, 18497.352592659194, 18532.444026679223, 870.3994243971639, 947.6967370441392, 955.3551352836807, 976.199516396548, 1003.0922015575916, 9493.715188544355, 9664.371815831948, 9679.612815487442, 9824.4105353679, 9953.153981911473, 649159.7542012354, 653880.0, 668438.0, 704330.478347605, 706064.0, 81667.50476721511, 87726.0, 88194.11805881988, 89435.55282223548, 89439.55280223557, 1203.6930582701355, 1214.168294718121, 1215.2404747033104, 1218.281214083695, 1225.2158618484177, 16660.166991650127, 16813.66372672564, 16821.747673785147, 16831.579210519834, 16947.0, 37565.06087347838, 37764.62235377611, 37827.0, 38184.427233592076, 38198.045048874, 45459.77270113628, 47875.0, 49212.0, 49811.25283120829, 49939.0, 9788.657396991071, 10180.032896874785, 10214.795704085727, 10253.384796912209, 10300.639477618248, 17513.38703145435, 17522.386716464862, 17624.383146589807, 18095.728564071287, 18560.071996400395, 14919.179445130188, 15133.54599362021, 15233.466828660943, 15286.541403757905, 15455.84544154544, 15169.696606068037, 15489.457868974532, 15689.921550392175, 15704.136272505122, 15920.52238432849, 15544.455944041903, 15925.920370398075, 16093.873428859868, 16223.432179873647, 16499.83500165031, 9923.05730955587, 10211.897881021094, 10371.585136594753, 10725.356478611307, 10816.891831081588, 10152.0, 10700.0, 15558.0, 15780.447684330993, 15836.92081539585], "unit": "ms", "name": "jquery.html", "value": 9280.157881445646}, {"lowerIsBetter": false, "replicates": [1580.581145996311, 1595.8643515301198, 1838.8436982856456, 1882.604653022865, 1888.9905550472245, 8297.460665056782, 8390.496570205783, 8595.613197406115, 8604.612792424348, 8667.73996780096, 8580.785480362978, 8590.570471476416, 8624.698135565257, 8659.480431174119, 8707.521086340248, 2360.9527809443803, 2395.9880200598973, 2397.676313697646, 2402.5555272274596, 2404.5311164322966, 2348.9295321140394, 2403.5433267679086, 2444.828861979662, 2446.0338166424253, 2457.766512181349, 2088.3734879536155, 2163.1996161420298, 2403.627437747152, 2427.9757202428013, 2449.9020039198413, 2348.765123487646, 2362.3739708977137, 2371.34787933318, 2376.619740841457, 2377.061060880951, 2449.1060762821444, 2458.0782206672498, 2488.639147323646, 2489.4025433895918, 2491.426971796479, 8450.366222533334, 8498.405111642187, 8509.872351914726, 8511.616977236039, 8535.061143274235, 5054.393472783289, 5104.897902041938, 5116.872078198037, 5128.666636668605, 5133.6149788765615, 3232.0, 3268.329992351586, 3329.583802024747, 3352.4971254311804, 3355.127666806648, 965.6041023180533, 984.8670429491998, 998.8901220865699, 1035.8342665173611, 1056.0284538224776, 11783.469743861548, 11935.582254621047, 11952.462139203757, 11955.282683039046, 11986.580469683606, 4435.600795928317, 4462.44219472566, 4487.057717879282, 4527.456705195397, 4552.954470455253, 9465.0, 9516.90483095174, 9546.42721436716, 9610.0, 9638.614455421844, 5049.419316778544, 5055.317532133188, 5064.240363945438, 5079.466656001141, 5087.796488140507, 4633.930491042637, 4661.160991021648, 4673.719576825401, 4688.765561721901, 4702.553257440606, 3653.963460365362, 3700.407934730484, 3719.0702324418894, 3751.5685696144747, 3770.1140232045445, 1112.9276597021167, 1113.3820729495208, 1113.6325012745936, 1113.6993011886746, 1116.6594188772503, 1088.8584484017026, 1095.0090168397612, 1153.9844936455866, 1322.9470821167238, 1324.291504045331, 7744.341730952932, 7779.494332868346, 7795.103563090317, 7805.37556995439, 7816.452848300564, 1180.451090243041, 1181.539199712113, 1188.8811118888043, 1190.9285442873456, 1212.0727643352843, 6242.188515492957, 6246.063090536456, 6280.685965701697, 6295.18162638854, 6301.936980630227, 9941.80116397668, 10099.7475063124, 10266.6406675766, 10353.534090965773, 10363.585456581803, 10100.292979491513, 10121.898781012243, 10204.081632653097, 10209.132223760915, 10267.383956962607, 7840.3335716464735, 7976.641051152712, 8024.598770061591, 8094.473859199134, 8119.5534245617055, 7654.885176722242, 7730.304272615492, 7757.26306000929, 7773.261540153676, 7788.88316675239, 9017.368784185044, 9085.954570227106, 9148.817023659623, 9300.39547429415, 9308.0, 9313.953430232805, 9321.114494123047, 9423.0, 9466.2427005838, 9619.0, 7206.459515536251, 7217.530860494051, 7230.13238411394, 7240.420766338575, 7302.525335853153, 8130.471519351223, 8154.143814899588, 8219.589020549069, 8236.34109271245, 8237.093919668952, 7594.31651151399, 7599.392048635986, 7644.961775191088, 7748.535087894745, 7777.377809775091, 6653.168353955755, 6684.4318232950745, 7384.96307518459, 7497.137829149718, 7625.275598818103, 7722.266384693445, 7768.223177682186, 7789.7273595423885, 7790.493617914817, 7814.21857814214, 7084.504084714226, 7113.75101871432, 7116.786496405116, 7123.928760712327, 7134.928650713427, 6951.930480695129, 6970.477214208853, 6971.0, 7040.894386584103, 7056.682449289691], "unit": "ms", "name": "mootools.html", "value": 4810.145532953416}, {"lowerIsBetter": false, "replicates": [377.7072768604332, 380.04039799506245, 380.3382115119692, 381.4507109761941, 390.23319177815586, 6444.226692796859, 6471.1263979362775, 6491.0, 6538.967305163479, 6627.403533681968, 6398.680065996693, 6429.067785171147, 6457.03144528321, 6458.773942911999, 6467.9029814552705, 4947.628927830409, 4948.97525512372, 4957.702537847723, 4959.380077490314, 4967.950320496785, 4969.950300497003, 4972.801087956477, 4972.875678108058, 4974.37820272466, 4987.0, 4719.339292499053, 4719.740414277213, 4782.1153086678905, 4782.521747825224, 4868.148074087038, 4725.787339569728, 4740.1704701677245, 4746.169420351424, 4749.0027094310235, 4749.358836557055, 4221.155768846243, 4238.978805105986, 4241.278982572939, 4244.639205667522, 4245.448091748084, 5954.523638108941, 5961.8807623847715, 5967.850803729898, 5970.283565972111, 5973.761049558012, 5520.420355862617, 5592.804251851166, 5602.215689803431, 5606.131049687305, 5616.943830561724, 6621.602703837785, 6622.602643841385, 6622.9006564901565, 6626.171728533934, 6637.1703537057865, 4631.3516107744945, 4644.489106198315, 4676.415448068991, 4677.789499472532, 4679.227927391977, 6865.725370985155, 6935.791926242221, 7009.439244860348, 7022.12223472066, 7039.120109986252, 4841.8547443576745, 4851.636127290467, 4856.271559266138, 4868.123737727172, 4868.294097355863, 4929.605631549467, 4930.235813448921, 4932.087563800708, 4938.308636790852, 4942.654014218971, 5611.7755289788765, 5655.632383895034, 5657.236273103161, 5658.773649054074, 5676.943230567642, 6702.061711360413, 6838.965805170942, 6876.209235937831, 6883.586984780929, 6901.102856628606, 1713.4260022892222, 1731.8527925126252, 1736.817634148396, 1738.5827401423567, 1739.625980414217, 1166.9591564295208, 1177.264209868832, 1187.673389817807, 1200.2438463767771, 1202.675277675023, 6544.3782840630065, 6549.770758023446, 6552.0, 6555.770548030796, 6558.278589355167, 7089.184743754431, 7116.825723755626, 7130.180029296594, 7133.750318738923, 7145.92854071463, 6558.80323590293, 6566.67166641666, 6575.112359831457, 6684.6991885364305, 6689.230738465041, 3868.129670824042, 3872.3029854625875, 3879.86420475282, 3891.5135608048995, 3910.3547914593773, 7275.4179665626625, 7309.89035164473, 7330.083739532559, 7373.81565460857, 7382.4094072475145, 7205.0, 7367.852642947111, 7368.926310736932, 7373.004644372941, 7375.336219740142, 7294.598797066106, 7300.7079716811795, 7345.375643070292, 7357.632118394166, 7361.595112268877, 7145.785626431215, 7184.281571842774, 7192.388646965067, 7193.028941092885, 7202.423806095395, 6924.272951340036, 7096.361327480551, 7111.53775004623, 7113.75101871432, 7121.216666166614, 7326.267373262845, 7334.889976650461, 7372.520786148883, 7402.740904068547, 7409.296116868889, 4911.336969509213, 4943.20908654628, 4946.183879659816, 4956.132676781477, 4961.0, 6955.547889387173, 7138.607376594129, 7195.784126476214, 7202.495825292389, 7223.205447400676, 6944.687489063105, 6993.650317484004, 6999.720011199495, 7002.299770022957, 7007.089078419773, 6797.28628494001, 6851.280615535297, 6865.210500792473, 6882.277360877036, 7001.0, 6803.217629972419, 6807.353301436356, 6878.449724022166, 6879.346462086094, 6883.827904302432, 6961.825954351182, 6979.441644668516, 7006.194287656985, 7029.05107810439, 7047.894281585678, 6700.095487109178, 6792.320767923168, 6799.626020568916, 6841.726330946905, 6851.45188384918], "unit": "ms", "name": "prototype.html", "value": 5177.42723567237}, {"lowerIsBetter": false, "replicates": [767.202109805802, 789.0649580247407, 803.9758807235785, 824.4393812207699, 892.4377642085485, 16999.0, 17384.13079346034, 17393.826061739393, 17442.999999999985, 17443.0, 14242.501512447066, 14287.071340362894, 14322.427102915872, 14400.27998600071, 14442.783358249635, 913.4610579757941, 930.3069213435982, 933.020328654913, 936.148105224246, 936.8220038192756, 928.317686500425, 929.7722058095776, 934.3039435620439, 934.3739694404732, 934.8784657994486, 912.4935660708304, 970.4856426094146, 971.6939164163301, 974.1135566634364, 974.4153507895277, 947.8957314695378, 969.6412327438893, 969.7817990952014, 971.4414211828228, 971.9319647624669, 709.2234003765868, 716.0762616225063, 720.6576875983918, 721.8700633885899, 722.9674664640104, 14518.637034074232, 14688.192149431778, 14698.044627099205, 14702.705945881022, 14722.852771472362, 11903.761924761457, 12210.267383956902, 12840.486380544768, 12853.80719289202, 13063.301770769835, 9863.950680246624, 10531.104856087242, 10715.83926241107, 10786.676399708022, 10808.189385796097, 3709.962900370989, 3787.734858559902, 3790.5261842269715, 3794.677452416548, 3809.561900381464, 47008.764956175, 47212.527874721156, 47403.288950665425, 47467.73284942985, 47690.807729806686, 9895.703128906145, 10123.898761012442, 10150.949245253727, 10187.643432479976, 10274.434906080238, 18339.541511462052, 18496.44510664682, 18505.259789608535, 18867.339643112424, 18891.14989825461, 7500.0, 7721.150673425918, 7967.760967170994, 7969.402294827911, 8248.381371397048, 4517.34498497716, 4531.331301568463, 4596.49438561758, 4620.3993480847275, 4820.783064762094, 3175.063356309894, 3199.6480387157394, 3218.5494030835703, 3230.80615163091, 3234.498652708834, 565.801969310738, 569.8262030080865, 571.9942800571941, 572.3389485144664, 573.888091822099, 583.5506659871875, 624.8719012602405, 658.5028303630728, 663.9170103737033, 691.2638040486866, 9275.30435217348, 9477.336586439022, 9501.714948551555, 9550.140487356033, 9922.0, 660.3693472733528, 682.6040896280145, 694.4617921111179, 698.3226270517691, 701.6035939694057, 3832.5400951885395, 3858.9035274118373, 3891.9416208756893, 3902.941455878164, 3991.860284890015, 58273.70863145742, 58415.70792146097, 58575.414245857, 58926.705366472896, 59364.40635593589, 49148.0, 49284.50715492871, 50508.24237636438, 51008.74495627498, 51339.22991155136, 45534.08931821279, 45999.31001034987, 46454.0, 46529.5347046532, 46831.29753053707, 8715.0, 8741.825163496567, 8792.120787921156, 8968.506732129796, 9258.814823703622, 35181.0, 35728.28543429169, 35795.463068053476, 37526.06184845401, 38317.2336553273, 43950.560494394646, 45346.0, 45360.546394536956, 45834.77082614699, 45940.081198376516, 10766.084882785051, 10873.695156581261, 10945.0, 11502.482388292714, 11683.766324673628, 12624.74750505003, 12662.746745064864, 12833.614991550268, 13450.798238026242, 13720.93139534336, 11143.888561114285, 11639.59261425846, 11850.170488065753, 11956.34240116767, 12397.938010310252, 11314.717132071435, 11396.94301528487, 11413.486393112164, 11616.767664646828, 11623.070154387799, 11071.501782419971, 11165.49755260999, 11195.328280303207, 11270.49282782293, 11412.600558980728, 10219.693409197736, 10438.843417348899, 10543.42011189392, 10747.516361763583, 10807.08139808125, 9277.48973806447, 9406.247500200105, 9487.0, 9877.50612469388, 9952.303338766216], "unit": "ms", "name": "yui.html", "value": 6633.826915919878}], "name": "dromaeo_css", "value": 7479.634512601878}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 103.0, 109.0, 109.0, 110.0, 120.0, 110.0, 109.0, 111.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 110.3}, {"lowerIsBetter": true, "replicates": [152.0, 122.0, 155.0, 160.0, 122.0, 157.0, 158.0, 128.0, 152.0, 122.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.8}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 162.0, 161.0, 164.0, 161.0, 162.0, 163.0, 162.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [78.0, 75.0, 72.0, 162.0, 75.0, 74.0, 77.0, 73.0, 176.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 93.6}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 134.0, 92.0, 92.0, 93.0, 142.0, 92.0, 93.0, 135.0], "unit": "ms", "name": "audio-oscillator", "value": 105.9}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 148.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 95.0, 96.0, 97.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 62.0, 63.0, 61.0, 61.0, 60.0, 61.0, 60.0, 60.0], "unit": "ms", "name": "json-parse-financial", "value": 60.8}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 64.0, 65.0, 70.0, 65.0, 65.0, 65.0, 64.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.1}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 84.0, 82.0, 83.0, 90.0, 82.0, 82.0, 89.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.8}, {"lowerIsBetter": true, "replicates": [121.0, 123.0, 117.0, 119.0, 127.0, 121.0, 115.0, 127.0, 115.0, 117.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 120.2}, {"lowerIsBetter": true, "replicates": [143.0, 153.0, 144.0, 147.0, 150.0, 144.0, 146.0, 143.0, 144.0, 147.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.1}, {"lowerIsBetter": true, "replicates": [65.0, 72.0, 65.0, 66.0, 68.0, 67.0, 69.0, 72.0, 65.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.5}], "name": "kraken", "value": 1510.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.0150893882237], "unit": "score", "name": "Richards", "value": 215.23629400000002}, {"lowerIsBetter": false, "replicates": [166.91704223001167], "unit": "score", "name": "DeltaBlue", "value": 396.11293800000004}, {"lowerIsBetter": false, "replicates": [278.78449958182324], "unit": "score", "name": "Encrypt", "value": 954.7912470000005}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [919.9632014719411], "unit": "score", "name": "RayTrace", "value": 804.368043}, {"lowerIsBetter": false, "replicates": [548.2456140350877], "unit": "score", "name": "Earley", "value": 1215.6285119999995}, {"lowerIsBetter": false, "replicates": [10989.010989010989], "unit": "score", "name": "Boyer", "value": 60.64813299999995}, {"lowerIsBetter": false, "replicates": [25717.94871794872], "unit": "score", "name": "RegExp", "value": 35.42214855433696}, {"lowerIsBetter": false, "replicates": [500.2496255616575], "unit": "score", "name": "Splay", "value": 162.9006716566866}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 23218.49913581168}]} 16:58:48 INFO - RETURN: dromaeo_css: 7479.64 16:58:48 INFO - RETURN: kraken: 1510.50 16:58:48 INFO - RETURN: v8_7: 23218.50 16:58:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23218.50"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1510.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7479.64"}}} 16:58:48 INFO - Return code: 0 16:58:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 16:58:48 INFO - # TBPL SUCCESS # 16:58:48 INFO - Running post-action listener: _resource_record_post_action 16:58:48 INFO - Running post-run listener: _resource_record_post_run 16:58:49 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 0; Write bytes: 502128640; Read time: 0; Write time: 373988 16:58:49 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 236998656; Read time: 0; Write time: 207376 16:58:49 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 0; Write bytes: 264839168; Read time: 0; Write time: 166588 16:58:49 INFO - Running post-run listener: _upload_blobber_files 16:58:49 INFO - Blob upload gear active. 16:58:49 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:58:49 INFO - Copying logs to upload dir... 16:58:49 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1268.516451 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-01-22 16:58:49.240315) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-22 16:58:49.244063) ========= 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=32c5991c409366f7fec8a718000001d2-1453509391.88383-1622690170 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009982 build_url: 'https://queue.taskcluster.net/v1/task/ybNU5KrkTpmf1LTCumLbdw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-22 16:58:49.294426) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 16:58:49.294743) ========= 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=32c5991c409366f7fec8a718000001d2-1453509391.88383-1622690170 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004615 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 16:58:49.346286) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 16:58:49.347128) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 16:58:49.348424) ========= ========= Total master_lag: 0.28 =========