builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-058 starttime: 1453607195.08 results: success (0) buildid: 20160123171907 builduid: 36dc3c163afa47e98a6ab344e59d1cbc revision: 7ede46ba62979809bafb3c1507745a4eeaec1c57 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-23 19:46:35.085129) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-23 19:46:35.086144) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-23 19:46:35.086523) ========= 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=0e2a256762fed810e2f0f810000001b3-1453607194.963659-698467002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004514 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-23 19:46:35.106948) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-23 19:46:35.107492) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-23 19:46:35.135660) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 19:46:35.136386) ========= 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=0e2a256762fed810e2f0f810000001b3-1453607194.963659-698467002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023346 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 19:46:35.188853) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-23 19:46:35.189558) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-23 19:46:35.190148) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 19:46:35.190626) ========= 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=0e2a256762fed810e2f0f810000001b3-1453607194.963659-698467002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-23 19:46:35-- 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% 35.2M=0s 2016-01-23 19:46:35 (35.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.170001 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 19:46:35.378379) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 19:46:35.379194) ========= 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=0e2a256762fed810e2f0f810000001b3-1453607194.963659-698467002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.047515 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 19:46:35.441496) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 19:46:35.442380) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7ede46ba62979809bafb3c1507745a4eeaec1c57 --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 7ede46ba62979809bafb3c1507745a4eeaec1c57 --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=0e2a256762fed810e2f0f810000001b3-1453607194.963659-698467002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-23 19:46:36,078 truncating revision to first 12 chars 2016-01-23 19:46:36,078 Setting DEBUG logging. 2016-01-23 19:46:36,078 attempt 1/10 2016-01-23 19:46:36,078 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7ede46ba6297?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-23 19:46:36,647 unpacking tar archive at: mozilla-aurora-7ede46ba6297/testing/mozharness/ program finished with exit code 0 elapsedTime=0.862834 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 19:46:36.321887) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-23 19:46:36.322532) ========= echo 7ede46ba62979809bafb3c1507745a4eeaec1c57 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7ede46ba62979809bafb3c1507745a4eeaec1c57'] 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=0e2a256762fed810e2f0f810000001b3-1453607194.963659-698467002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 7ede46ba62979809bafb3c1507745a4eeaec1c57 program finished with exit code 0 elapsedTime=0.004644 script_repo_revision: '7ede46ba62979809bafb3c1507745a4eeaec1c57' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-23 19:46:36.377667) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-23 19:46:36.378553) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-23 19:46:36.389630) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-01-23 19:46:36.389975) ========= /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=0e2a256762fed810e2f0f810000001b3-1453607194.963659-698467002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:46:37 INFO - MultiFileLogger online at 20160123 19:46:37 in /builds/slave/test-pgo 19:46:37 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 19:46:37 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:46:37 INFO - {'append_to_log': False, 19:46:37 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:46:37 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:46:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:46:37 INFO - 'branch': 'Mozilla-Aurora', 19:46:37 INFO - 'buildbot_json_path': 'buildprops.json', 19:46:37 INFO - 'config_files': ('talos/linux_config.py',), 19:46:37 INFO - 'default_actions': ('clobber', 19:46:37 INFO - 'read-buildbot-config', 19:46:37 INFO - 'download-and-extract', 19:46:37 INFO - 'populate-webroot', 19:46:37 INFO - 'create-virtualenv', 19:46:37 INFO - 'install', 19:46:37 INFO - 'run-tests'), 19:46:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:46:37 INFO - 'download_minidump_stackwalk': True, 19:46:37 INFO - 'download_symbols': 'ondemand', 19:46:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:46:37 INFO - 'tooltool.py': '/tools/tooltool.py', 19:46:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:46:37 INFO - '/tools/misc-python/virtualenv.py')}, 19:46:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:46:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:46:37 INFO - 'installer_path': 'installer.exe', 19:46:37 INFO - 'log_level': 'info', 19:46:37 INFO - 'log_name': 'talos', 19:46:37 INFO - 'log_to_console': True, 19:46:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:46:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:46:37 INFO - 'opt_config_files': (), 19:46:37 INFO - 'pip_index': False, 19:46:37 INFO - 'sps_profile': False, 19:46:37 INFO - 'sps_profile_interval': 0, 19:46:37 INFO - 'suite': 'dromaeojs-e10s', 19:46:37 INFO - 'system_bits': '32', 19:46:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:46:37 INFO - 'title': 'talos-linux64-ix-058', 19:46:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:46:37 INFO - 'use_talos_json': True, 19:46:37 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:46:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:46:37 INFO - 'work_dir': 'build'} 19:46:37 INFO - ##### 19:46:37 INFO - ##### Running clobber step. 19:46:37 INFO - ##### 19:46:37 INFO - Running pre-action listener: _resource_record_pre_action 19:46:37 INFO - Running main action method: clobber 19:46:37 INFO - rmtree: /builds/slave/test-pgo/build 19:46:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:46:38 INFO - Running post-action listener: _resource_record_post_action 19:46:38 INFO - ##### 19:46:38 INFO - ##### Running read-buildbot-config step. 19:46:38 INFO - ##### 19:46:38 INFO - Running pre-action listener: _resource_record_pre_action 19:46:38 INFO - Running main action method: read_buildbot_config 19:46:38 INFO - Using buildbot properties: 19:46:38 INFO - { 19:46:38 INFO - "properties": { 19:46:38 INFO - "buildnumber": 105, 19:46:38 INFO - "product": "firefox", 19:46:38 INFO - "script_repo_revision": "production", 19:46:38 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 19:46:38 INFO - "repository": "", 19:46:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 19:46:38 INFO - "buildid": "20160123171907", 19:46:38 INFO - "slavename": "talos-linux64-ix-058", 19:46:38 INFO - "pgo_build": "True", 19:46:38 INFO - "basedir": "/builds/slave/test-pgo", 19:46:38 INFO - "project": "", 19:46:38 INFO - "platform": "ubuntu64_hw", 19:46:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:46:38 INFO - "slavebuilddir": "test", 19:46:38 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 19:46:38 INFO - "branch": "mozilla-aurora", 19:46:38 INFO - "repo_path": "releases/mozilla-aurora", 19:46:38 INFO - "stage_platform": "linux64-pgo", 19:46:38 INFO - "builduid": "36dc3c163afa47e98a6ab344e59d1cbc", 19:46:38 INFO - "revision": "7ede46ba62979809bafb3c1507745a4eeaec1c57" 19:46:38 INFO - }, 19:46:38 INFO - "sourcestamp": { 19:46:38 INFO - "repository": "", 19:46:38 INFO - "hasPatch": false, 19:46:38 INFO - "project": "", 19:46:38 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 19:46:38 INFO - "changes": [ 19:46:38 INFO - { 19:46:38 INFO - "category": null, 19:46:38 INFO - "files": [ 19:46:38 INFO - { 19:46:38 INFO - "url": null, 19:46:38 INFO - "name": "https://queue.taskcluster.net/v1/task/FlIfbGpYSsGQN0TxwWzcLA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 19:46:38 INFO - } 19:46:38 INFO - ], 19:46:38 INFO - "repository": "", 19:46:38 INFO - "rev": "7ede46ba62979809bafb3c1507745a4eeaec1c57", 19:46:38 INFO - "who": "ryanvm@gmail.com", 19:46:38 INFO - "when": 1453606838, 19:46:38 INFO - "number": 7507154, 19:46:38 INFO - "comments": "Bug 1135315 - Re-enable the WebIDE mochitest-chrome tests on OSX debug. r+a=test-only", 19:46:38 INFO - "project": "", 19:46:38 INFO - "at": "Sat 23 Jan 2016 19:40:38", 19:46:38 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 19:46:38 INFO - "revlink": "", 19:46:38 INFO - "properties": [ 19:46:38 INFO - [ 19:46:38 INFO - "buildid", 19:46:38 INFO - "20160123171907", 19:46:38 INFO - "Change" 19:46:38 INFO - ], 19:46:38 INFO - [ 19:46:38 INFO - "builduid", 19:46:38 INFO - "36dc3c163afa47e98a6ab344e59d1cbc", 19:46:38 INFO - "Change" 19:46:38 INFO - ], 19:46:38 INFO - [ 19:46:38 INFO - "pgo_build", 19:46:38 INFO - "True", 19:46:38 INFO - "Change" 19:46:38 INFO - ] 19:46:38 INFO - ], 19:46:38 INFO - "revision": "7ede46ba62979809bafb3c1507745a4eeaec1c57" 19:46:38 INFO - } 19:46:38 INFO - ], 19:46:38 INFO - "revision": "7ede46ba62979809bafb3c1507745a4eeaec1c57" 19:46:38 INFO - } 19:46:38 INFO - } 19:46:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/FlIfbGpYSsGQN0TxwWzcLA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 19:46:38 INFO - Running post-action listener: _resource_record_post_action 19:46:38 INFO - ##### 19:46:38 INFO - ##### Running download-and-extract step. 19:46:38 INFO - ##### 19:46:38 INFO - Running pre-action listener: _resource_record_pre_action 19:46:38 INFO - Running main action method: download_and_extract 19:46:38 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:46:38 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')]} 19:46:38 INFO - https://queue.taskcluster.net/v1/task/FlIfbGpYSsGQN0TxwWzcLA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:46:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FlIfbGpYSsGQN0TxwWzcLA/artifacts/public/build/test_packages.json 19:46:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FlIfbGpYSsGQN0TxwWzcLA/artifacts/public/build/test_packages.json 19:46:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FlIfbGpYSsGQN0TxwWzcLA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:46:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FlIfbGpYSsGQN0TxwWzcLA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:46:39 INFO - Downloaded 1302 bytes. 19:46:39 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:46:39 INFO - Using the following test package requirements: 19:46:39 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 19:46:39 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 19:46:39 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 19:46:39 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 19:46:39 INFO - u'jsshell-linux-x86_64.zip'], 19:46:39 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 19:46:39 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 19:46:39 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 19:46:39 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 19:46:39 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 19:46:39 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 19:46:39 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 19:46:39 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 19:46:39 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 19:46:39 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 19:46:39 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 19:46:39 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 19:46:39 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:46:39 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')]} 19:46:39 INFO - https://queue.taskcluster.net/v1/task/FlIfbGpYSsGQN0TxwWzcLA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:46:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FlIfbGpYSsGQN0TxwWzcLA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 19:46:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FlIfbGpYSsGQN0TxwWzcLA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 19:46:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FlIfbGpYSsGQN0TxwWzcLA/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 19:46:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FlIfbGpYSsGQN0TxwWzcLA/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 19:46:40 INFO - Downloaded 23159158 bytes. 19:46:40 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 19:46:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 19:46:40 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 19:46:41 INFO - Return code: 0 19:46:41 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 19:46: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')]} 19:46:41 INFO - https://queue.taskcluster.net/v1/task/FlIfbGpYSsGQN0TxwWzcLA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:46:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FlIfbGpYSsGQN0TxwWzcLA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 19:46:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FlIfbGpYSsGQN0TxwWzcLA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 19:46:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FlIfbGpYSsGQN0TxwWzcLA/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 19:46:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FlIfbGpYSsGQN0TxwWzcLA/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 19:46:42 INFO - Downloaded 23159158 bytes. 19:46:42 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 19:46:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 19:46:42 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 19:46:43 INFO - Return code: 0 19:46:43 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')]} 19:46:43 INFO - https://queue.taskcluster.net/v1/task/FlIfbGpYSsGQN0TxwWzcLA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:46:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FlIfbGpYSsGQN0TxwWzcLA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 19:46:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FlIfbGpYSsGQN0TxwWzcLA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 19:46:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FlIfbGpYSsGQN0TxwWzcLA/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 19:46:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FlIfbGpYSsGQN0TxwWzcLA/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 19:46:44 INFO - Downloaded 11132038 bytes. 19:46:44 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 19:46:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 19:46:44 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 19:46:44 INFO - Return code: 0 19:46:44 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')]} 19:46:44 INFO - https://queue.taskcluster.net/v1/task/FlIfbGpYSsGQN0TxwWzcLA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:46:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FlIfbGpYSsGQN0TxwWzcLA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 19:46:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FlIfbGpYSsGQN0TxwWzcLA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 19:46:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FlIfbGpYSsGQN0TxwWzcLA/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 19:46:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FlIfbGpYSsGQN0TxwWzcLA/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 19:46:45 INFO - Downloaded 58025612 bytes. 19:46:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FlIfbGpYSsGQN0TxwWzcLA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 19:46:45 INFO - mkdir: /builds/slave/test-pgo/properties 19:46:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:46:45 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:46:45 INFO - Contents: 19:46:45 INFO - build_url:https://queue.taskcluster.net/v1/task/FlIfbGpYSsGQN0TxwWzcLA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 19:46:45 INFO - Running post-action listener: _resource_record_post_action 19:46:45 INFO - Running post-action listener: set_extra_try_arguments 19:46:45 INFO - ##### 19:46:45 INFO - ##### Running populate-webroot step. 19:46:45 INFO - ##### 19:46:45 INFO - Running pre-action listener: _resource_record_pre_action 19:46:45 INFO - Running main action method: populate_webroot 19:46:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:46:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:46:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:46:45 INFO - '--tppagecycles', 19:46:45 INFO - '7'], 19:46:45 INFO - 'tests': ['tsvgm']}}, 19:46:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:46:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:46:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:46:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:46:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:46:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:46:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:46:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:45 INFO - 'talos_options': ['--e10s'], 19:46:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:46:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:45 INFO - 'tests': ['damp', 'tps']}, 19:46:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:45 INFO - 'talos_options': ['--e10s'], 19:46:45 INFO - 'tests': ['damp', 'tps']}, 19:46:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:46:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:46:45 INFO - 'other': {'tests': ['a11yr', 19:46:45 INFO - 'ts_paint', 19:46:45 INFO - 'tpaint', 19:46:45 INFO - 'sessionrestore', 19:46:45 INFO - 'sessionrestore_no_auto_restore']}, 19:46:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:46:45 INFO - 'tests': ['a11yr', 19:46:45 INFO - 'ts_paint', 19:46:45 INFO - 'tpaint', 19:46:45 INFO - 'sessionrestore', 19:46:45 INFO - 'sessionrestore_no_auto_restore']}, 19:46:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:46:45 INFO - 'tests': ['a11yr', 19:46:45 INFO - 'ts_paint', 19:46:45 INFO - 'tpaint', 19:46:45 INFO - 'sessionrestore', 19:46:45 INFO - 'sessionrestore_no_auto_restore']}, 19:46:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:46:45 INFO - 'tests': ['a11yr', 19:46:45 INFO - 'ts_paint', 19:46:45 INFO - 'tpaint', 19:46:45 INFO - 'sessionrestore', 19:46:45 INFO - 'sessionrestore_no_auto_restore']}, 19:46:45 INFO - 'other_l64': {'tests': ['a11yr', 19:46:45 INFO - 'ts_paint', 19:46:45 INFO - 'tpaint', 19:46:45 INFO - 'sessionrestore', 19:46:45 INFO - 'sessionrestore_no_auto_restore']}, 19:46:45 INFO - 'other_nol64': {'tests': ['a11yr', 19:46:45 INFO - 'ts_paint', 19:46:45 INFO - 'tpaint', 19:46:45 INFO - 'sessionrestore', 19:46:45 INFO - 'sessionrestore_no_auto_restore']}, 19:46:45 INFO - 'svgr': {'tests': ['tsvgx', 19:46:45 INFO - 'tsvgr_opacity', 19:46:45 INFO - 'tart', 19:46:45 INFO - 'tscrollx', 19:46:45 INFO - 'cart']}, 19:46:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:46:45 INFO - 'tests': ['tsvgx', 19:46:45 INFO - 'tsvgr_opacity', 19:46:45 INFO - 'tart', 19:46:45 INFO - 'tscrollx', 19:46:45 INFO - 'cart']}, 19:46:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:45 INFO - 'tests': ['tp5o']}, 19:46:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:45 INFO - 'talos_options': ['--e10s'], 19:46:45 INFO - 'tests': ['tp5o']}, 19:46:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:45 INFO - 'talos_options': ['--xperf_path', 19:46:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:46:45 INFO - 'tests': ['tp5n']}, 19:46:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:45 INFO - 'talos_options': ['--e10s', 19:46:45 INFO - '--xperf_path', 19:46:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:46:45 INFO - 'tests': ['tp5n']}}, 19:46:45 INFO - 'talos.zip': {'path': '', 19:46:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:46:45 INFO - Running post-action listener: _resource_record_post_action 19:46:45 INFO - ##### 19:46:45 INFO - ##### Running create-virtualenv step. 19:46:45 INFO - ##### 19:46:45 INFO - Running pre-action listener: _resource_record_pre_action 19:46:45 INFO - Running main action method: create_virtualenv 19:46:45 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:46:45 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 19:46:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:46:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:46:46 INFO - Using real prefix '/usr' 19:46:46 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:46:46 INFO - Installing distribute.............................................................................................................................................................................................done. 19:46:48 INFO - Installing pip.................done. 19:46:48 INFO - Return code: 0 19:46:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:46:48 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')]} 19:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:48 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')]} 19:46:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:48 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 0x7fcc2eed7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x191f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b1a50>, '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 0x191d550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x191d9e0>, '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': '0e2a256762fed810e2f0f810000001b3-1453607194.963659-698467002', '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 19:46:48 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 19:46:48 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 19:46:48 INFO - Using env: {'DISPLAY': ':0', 19:46:48 INFO - 'HOME': '/home/cltbld', 19:46:48 INFO - 'LANG': 'en_US.UTF-8', 19:46:48 INFO - 'LANGUAGE': 'en_US:en', 19:46:48 INFO - 'LOGNAME': 'cltbld', 19:46:48 INFO - 'MAIL': '/var/mail/cltbld', 19:46:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:48 INFO - 'MOZ_NO_REMOTE': '1', 19:46:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:46:48 INFO - 'NO_EM_RESTART': '1', 19:46:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:46:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:46:48 INFO - 'PWD': '/builds/slave/test-pgo', 19:46:48 INFO - 'SHELL': '/bin/bash', 19:46:48 INFO - 'SHLVL': '1', 19:46:48 INFO - 'TERM': 'linux', 19:46:48 INFO - 'TMOUT': '86400', 19:46:48 INFO - 'USER': 'cltbld', 19:46:48 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1453607194.963659-698467002', 19:46:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:48 INFO - '_': '/tools/buildbot/bin/python'} 19:46:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:48 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 19:46:48 INFO - Cleaning up... 19:46:48 INFO - Return code: 0 19:46:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:46:48 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')]} 19:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:48 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')]} 19:46:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:48 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 0x7fcc2eed7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x191f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b1a50>, '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 0x191d550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x191d9e0>, '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': '0e2a256762fed810e2f0f810000001b3-1453607194.963659-698467002', '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 19:46:48 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 19:46:48 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 19:46:48 INFO - Using env: {'DISPLAY': ':0', 19:46:48 INFO - 'HOME': '/home/cltbld', 19:46:48 INFO - 'LANG': 'en_US.UTF-8', 19:46:48 INFO - 'LANGUAGE': 'en_US:en', 19:46:48 INFO - 'LOGNAME': 'cltbld', 19:46:48 INFO - 'MAIL': '/var/mail/cltbld', 19:46:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:48 INFO - 'MOZ_NO_REMOTE': '1', 19:46:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:46:48 INFO - 'NO_EM_RESTART': '1', 19:46:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:46:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:46:48 INFO - 'PWD': '/builds/slave/test-pgo', 19:46:48 INFO - 'SHELL': '/bin/bash', 19:46:48 INFO - 'SHLVL': '1', 19:46:48 INFO - 'TERM': 'linux', 19:46:48 INFO - 'TMOUT': '86400', 19:46:48 INFO - 'USER': 'cltbld', 19:46:48 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1453607194.963659-698467002', 19:46:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:48 INFO - '_': '/tools/buildbot/bin/python'} 19:46:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:48 INFO - Downloading/unpacking psutil>=0.7.1 19:46:48 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 19:46:48 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 19:46:48 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 19:46:48 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 19:46:48 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 19:46:48 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 19:46:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:46:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:46:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:46:50 INFO - Installing collected packages: psutil 19:46:50 INFO - Running setup.py install for psutil 19:46:50 INFO - building 'psutil._psutil_linux' extension 19:46:50 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 19:46:51 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 19:46:51 INFO - building 'psutil._psutil_posix' extension 19:46:51 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 19:46:51 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 19:46:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:46:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:46:51 INFO - Successfully installed psutil 19:46:51 INFO - Cleaning up... 19:46:51 INFO - Return code: 0 19:46:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:51 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 0x7fcc2eed7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x191f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b1a50>, '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 0x191d550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x191d9e0>, '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': '0e2a256762fed810e2f0f810000001b3-1453607194.963659-698467002', '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 19:46:51 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 19:46:51 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 19:46:51 INFO - Using env: {'DISPLAY': ':0', 19:46:51 INFO - 'HOME': '/home/cltbld', 19:46:51 INFO - 'LANG': 'en_US.UTF-8', 19:46:51 INFO - 'LANGUAGE': 'en_US:en', 19:46:51 INFO - 'LOGNAME': 'cltbld', 19:46:51 INFO - 'MAIL': '/var/mail/cltbld', 19:46:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:51 INFO - 'MOZ_NO_REMOTE': '1', 19:46:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:46:51 INFO - 'NO_EM_RESTART': '1', 19:46:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:46:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:46:51 INFO - 'PWD': '/builds/slave/test-pgo', 19:46:51 INFO - 'SHELL': '/bin/bash', 19:46:51 INFO - 'SHLVL': '1', 19:46:51 INFO - 'TERM': 'linux', 19:46:51 INFO - 'TMOUT': '86400', 19:46:51 INFO - 'USER': 'cltbld', 19:46:51 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1453607194.963659-698467002', 19:46:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:51 INFO - '_': '/tools/buildbot/bin/python'} 19:46:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:46:51 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 19:46:51 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 19:46:51 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 19:46:51 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 19:46:51 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 19:46:51 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 19:46:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:46:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:46:53 INFO - Installing collected packages: mozsystemmonitor 19:46:53 INFO - Running setup.py install for mozsystemmonitor 19:46:53 INFO - Successfully installed mozsystemmonitor 19:46:53 INFO - Cleaning up... 19:46:53 INFO - Return code: 0 19:46:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:46:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:53 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 0x7fcc2eed7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x191f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b1a50>, '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 0x191d550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x191d9e0>, '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': '0e2a256762fed810e2f0f810000001b3-1453607194.963659-698467002', '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 19:46:53 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 19:46:53 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 19:46:53 INFO - Using env: {'DISPLAY': ':0', 19:46:53 INFO - 'HOME': '/home/cltbld', 19:46:53 INFO - 'LANG': 'en_US.UTF-8', 19:46:53 INFO - 'LANGUAGE': 'en_US:en', 19:46:53 INFO - 'LOGNAME': 'cltbld', 19:46:53 INFO - 'MAIL': '/var/mail/cltbld', 19:46:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:53 INFO - 'MOZ_NO_REMOTE': '1', 19:46:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:46:53 INFO - 'NO_EM_RESTART': '1', 19:46:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:46:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:46:53 INFO - 'PWD': '/builds/slave/test-pgo', 19:46:53 INFO - 'SHELL': '/bin/bash', 19:46:53 INFO - 'SHLVL': '1', 19:46:53 INFO - 'TERM': 'linux', 19:46:53 INFO - 'TMOUT': '86400', 19:46:53 INFO - 'USER': 'cltbld', 19:46:53 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1453607194.963659-698467002', 19:46:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:53 INFO - '_': '/tools/buildbot/bin/python'} 19:46:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:53 INFO - Downloading/unpacking blobuploader==1.2.4 19:46:53 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 19:46:53 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 19:46:53 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 19:46:53 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 19:46:53 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 19:46:53 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 19:46:55 INFO - Downloading blobuploader-1.2.4.tar.gz 19:46:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:46:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:46:55 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 19:46:55 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 19:46:55 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 19:46:55 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 19:46:55 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 19:46:55 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 19:46:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:46:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:46:55 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 19:46:55 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 19:46:55 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 19:46:55 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 19:46:55 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 19:46:55 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 19:46:56 INFO - Downloading docopt-0.6.1.tar.gz 19:46:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:46:56 INFO - Installing collected packages: blobuploader, requests, docopt 19:46:56 INFO - Running setup.py install for blobuploader 19:46:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:46:56 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:46:56 INFO - Running setup.py install for requests 19:46:56 INFO - Running setup.py install for docopt 19:46:56 INFO - Successfully installed blobuploader requests docopt 19:46:56 INFO - Cleaning up... 19:46:56 INFO - Return code: 0 19:46:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:56 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 0x7fcc2eed7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x191f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b1a50>, '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 0x191d550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x191d9e0>, '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': '0e2a256762fed810e2f0f810000001b3-1453607194.963659-698467002', '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 19:46:56 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 19:46:56 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 19:46:56 INFO - Using env: {'DISPLAY': ':0', 19:46:56 INFO - 'HOME': '/home/cltbld', 19:46:56 INFO - 'LANG': 'en_US.UTF-8', 19:46:56 INFO - 'LANGUAGE': 'en_US:en', 19:46:56 INFO - 'LOGNAME': 'cltbld', 19:46:56 INFO - 'MAIL': '/var/mail/cltbld', 19:46:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:56 INFO - 'MOZ_NO_REMOTE': '1', 19:46:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:46:56 INFO - 'NO_EM_RESTART': '1', 19:46:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:46:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:46:56 INFO - 'PWD': '/builds/slave/test-pgo', 19:46:56 INFO - 'SHELL': '/bin/bash', 19:46:56 INFO - 'SHLVL': '1', 19:46:56 INFO - 'TERM': 'linux', 19:46:56 INFO - 'TMOUT': '86400', 19:46:56 INFO - 'USER': 'cltbld', 19:46:56 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1453607194.963659-698467002', 19:46:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:56 INFO - '_': '/tools/buildbot/bin/python'} 19:46:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:46:57 INFO - Running setup.py (path:/tmp/pip-weQwlm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:46:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:46:57 INFO - Running setup.py (path:/tmp/pip-88IEJH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:46:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:46:57 INFO - Running setup.py (path:/tmp/pip-hUaIGp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:46:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:46:57 INFO - Running setup.py (path:/tmp/pip-5L2YPi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:46:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:46:57 INFO - Running setup.py (path:/tmp/pip-aF7E9P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:46:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:46:57 INFO - Running setup.py (path:/tmp/pip-9xWXfE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:46:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:46:57 INFO - Running setup.py (path:/tmp/pip-xqXq1N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:46:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:46:57 INFO - Running setup.py (path:/tmp/pip-InM7yo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:46:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:46:57 INFO - Running setup.py (path:/tmp/pip-0nJJaz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:46:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:46:57 INFO - Running setup.py (path:/tmp/pip-fDaN91-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:46:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:46:57 INFO - Running setup.py (path:/tmp/pip-QXs1cw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:46:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:46:57 INFO - Running setup.py (path:/tmp/pip-8vMM4Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:46:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:46:57 INFO - Running setup.py (path:/tmp/pip-BGnCwo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:46:58 INFO - Running setup.py (path:/tmp/pip-P08MZP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:46:58 INFO - Running setup.py (path:/tmp/pip-f8YJEB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:46:58 INFO - Running setup.py (path:/tmp/pip-J2XydK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:46:58 INFO - Running setup.py (path:/tmp/pip-wPFHOy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:46:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:46:58 INFO - Running setup.py install for manifestparser 19:46:58 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:46:58 INFO - Running setup.py install for mozcrash 19:46:58 INFO - Running setup.py install for mozdebug 19:46:58 INFO - Running setup.py install for mozdevice 19:46:58 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:46:58 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:46:58 INFO - Running setup.py install for mozfile 19:46:58 INFO - Running setup.py install for mozhttpd 19:46:58 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:46:58 INFO - Running setup.py install for mozinfo 19:46:58 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:46:59 INFO - Running setup.py install for mozInstall 19:46:59 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:46:59 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:46:59 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:46:59 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:46:59 INFO - Running setup.py install for mozleak 19:46:59 INFO - Running setup.py install for mozlog 19:46:59 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:46:59 INFO - Running setup.py install for moznetwork 19:46:59 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:46:59 INFO - Running setup.py install for mozprocess 19:46:59 INFO - Running setup.py install for mozprofile 19:46:59 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:46:59 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:46:59 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:46:59 INFO - Running setup.py install for mozrunner 19:46:59 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:46:59 INFO - Running setup.py install for mozscreenshot 19:46:59 INFO - Running setup.py install for moztest 19:46:59 INFO - Running setup.py install for mozversion 19:47:00 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:47:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:47:00 INFO - Cleaning up... 19:47:00 INFO - Return code: 0 19:47:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:47: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')]} 19:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47: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')]} 19:47:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:00 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 0x7fcc2eed7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x191f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b1a50>, '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 0x191d550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x191d9e0>, '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': '0e2a256762fed810e2f0f810000001b3-1453607194.963659-698467002', '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 19:47:00 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 19:47:00 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 19:47:00 INFO - Using env: {'DISPLAY': ':0', 19:47:00 INFO - 'HOME': '/home/cltbld', 19:47:00 INFO - 'LANG': 'en_US.UTF-8', 19:47:00 INFO - 'LANGUAGE': 'en_US:en', 19:47:00 INFO - 'LOGNAME': 'cltbld', 19:47:00 INFO - 'MAIL': '/var/mail/cltbld', 19:47:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:00 INFO - 'MOZ_NO_REMOTE': '1', 19:47:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:47:00 INFO - 'NO_EM_RESTART': '1', 19:47:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:47:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:47:00 INFO - 'PWD': '/builds/slave/test-pgo', 19:47:00 INFO - 'SHELL': '/bin/bash', 19:47:00 INFO - 'SHLVL': '1', 19:47:00 INFO - 'TERM': 'linux', 19:47:00 INFO - 'TMOUT': '86400', 19:47:00 INFO - 'USER': 'cltbld', 19:47:00 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1453607194.963659-698467002', 19:47:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:00 INFO - '_': '/tools/buildbot/bin/python'} 19:47:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:47:00 INFO - Running setup.py (path:/tmp/pip-ywomVq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:47:00 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)) 19:47:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:47:00 INFO - Running setup.py (path:/tmp/pip-KM9YaY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:47:00 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)) 19:47:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:47:00 INFO - Running setup.py (path:/tmp/pip-AGGCpK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:47:00 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)) 19:47:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:47:00 INFO - Running setup.py (path:/tmp/pip-WSNxnK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:47:00 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)) 19:47:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:47:00 INFO - Running setup.py (path:/tmp/pip-VW83O3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:47:00 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)) 19:47:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:47:00 INFO - Running setup.py (path:/tmp/pip-C5wjoo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:47:00 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)) 19:47:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:47:00 INFO - Running setup.py (path:/tmp/pip-bvaCVo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:47:00 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)) 19:47:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:47:00 INFO - Running setup.py (path:/tmp/pip-buK43Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:47:00 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)) 19:47:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:47:00 INFO - Running setup.py (path:/tmp/pip-XhTHCo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:47:00 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)) 19:47:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:47:00 INFO - Running setup.py (path:/tmp/pip-ZGF1Bi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:47:01 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)) 19:47:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:47:01 INFO - Running setup.py (path:/tmp/pip-eTh9hm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:47:01 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)) 19:47:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:47:01 INFO - Running setup.py (path:/tmp/pip-q3OzM1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:47:01 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)) 19:47:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:47:01 INFO - Running setup.py (path:/tmp/pip-CzYUvY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:47:01 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)) 19:47:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:47:01 INFO - Running setup.py (path:/tmp/pip-kEBbbJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:47:01 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)) 19:47:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:47:01 INFO - Running setup.py (path:/tmp/pip-0n6c2r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:47:01 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)) 19:47:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:47:01 INFO - Running setup.py (path:/tmp/pip-AL4r0t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:47:01 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)) 19:47:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:47:01 INFO - Running setup.py (path:/tmp/pip-NH6aH1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:47:01 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)) 19:47:01 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)) 19:47:01 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)) 19:47:01 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)) 19:47:01 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)) 19:47:01 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)) 19:47:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:47:01 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 19:47:01 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 19:47:01 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 19:47:01 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 19:47:01 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 19:47:01 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 19:47:03 INFO - Downloading blessings-1.6.tar.gz 19:47:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:47:03 INFO - Installing collected packages: blessings 19:47:03 INFO - Running setup.py install for blessings 19:47:03 INFO - Successfully installed blessings 19:47:03 INFO - Cleaning up... 19:47:03 INFO - Return code: 0 19:47:03 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:47:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:47:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:47:03 INFO - Reading from file tmpfile_stdout 19:47:03 INFO - Current package versions: 19:47:03 INFO - argparse == 1.2.1 19:47:03 INFO - blessings == 1.6 19:47:03 INFO - blobuploader == 1.2.4 19:47:03 INFO - docopt == 0.6.1 19:47:03 INFO - manifestparser == 1.1 19:47:03 INFO - mozInstall == 1.12 19:47:03 INFO - mozcrash == 0.16 19:47:03 INFO - mozdebug == 0.1 19:47:03 INFO - mozdevice == 0.47 19:47:03 INFO - mozfile == 1.2 19:47:03 INFO - mozhttpd == 0.7 19:47:03 INFO - mozinfo == 0.9 19:47:03 INFO - mozleak == 0.1 19:47:03 INFO - mozlog == 3.1 19:47:03 INFO - moznetwork == 0.27 19:47:03 INFO - mozprocess == 0.22 19:47:03 INFO - mozprofile == 0.27 19:47:03 INFO - mozrunner == 6.11 19:47:03 INFO - mozscreenshot == 0.1 19:47:03 INFO - mozsystemmonitor == 0.0 19:47:03 INFO - moztest == 0.7 19:47:03 INFO - mozversion == 1.4 19:47:03 INFO - psutil == 3.1.1 19:47:03 INFO - requests == 1.2.3 19:47:03 INFO - wsgiref == 0.1.2 19:47:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:47:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:03 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 0x7fcc2eed7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x191f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b1a50>, '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 0x191d550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x191d9e0>, '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': '0e2a256762fed810e2f0f810000001b3-1453607194.963659-698467002', '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 19:47:03 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 19:47:03 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 19:47:03 INFO - Using env: {'DISPLAY': ':0', 19:47:03 INFO - 'HOME': '/home/cltbld', 19:47:03 INFO - 'LANG': 'en_US.UTF-8', 19:47:03 INFO - 'LANGUAGE': 'en_US:en', 19:47:03 INFO - 'LOGNAME': 'cltbld', 19:47:03 INFO - 'MAIL': '/var/mail/cltbld', 19:47:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:03 INFO - 'MOZ_NO_REMOTE': '1', 19:47:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:47:03 INFO - 'NO_EM_RESTART': '1', 19:47:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:47:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:47:03 INFO - 'PWD': '/builds/slave/test-pgo', 19:47:03 INFO - 'SHELL': '/bin/bash', 19:47:03 INFO - 'SHLVL': '1', 19:47:03 INFO - 'TERM': 'linux', 19:47:03 INFO - 'TMOUT': '86400', 19:47:03 INFO - 'USER': 'cltbld', 19:47:03 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1453607194.963659-698467002', 19:47:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:03 INFO - '_': '/tools/buildbot/bin/python'} 19:47:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:03 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)) 19:47:03 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)) 19:47:03 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)) 19:47:03 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)) 19:47:03 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)) 19:47:03 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)) 19:47:03 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)) 19:47:03 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)) 19:47:03 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)) 19:47:03 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)) 19:47:03 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)) 19:47:03 INFO - Cleaning up... 19:47:03 INFO - Return code: 0 19:47:03 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:47:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:03 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 0x7fcc2eed7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x191f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b1a50>, '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 0x191d550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x191d9e0>, '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': '0e2a256762fed810e2f0f810000001b3-1453607194.963659-698467002', '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 19:47:03 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 19:47:03 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 19:47:03 INFO - Using env: {'DISPLAY': ':0', 19:47:03 INFO - 'HOME': '/home/cltbld', 19:47:03 INFO - 'LANG': 'en_US.UTF-8', 19:47:03 INFO - 'LANGUAGE': 'en_US:en', 19:47:03 INFO - 'LOGNAME': 'cltbld', 19:47:03 INFO - 'MAIL': '/var/mail/cltbld', 19:47:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:03 INFO - 'MOZ_NO_REMOTE': '1', 19:47:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:47:03 INFO - 'NO_EM_RESTART': '1', 19:47:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:47:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:47:03 INFO - 'PWD': '/builds/slave/test-pgo', 19:47:03 INFO - 'SHELL': '/bin/bash', 19:47:03 INFO - 'SHLVL': '1', 19:47:03 INFO - 'TERM': 'linux', 19:47:03 INFO - 'TMOUT': '86400', 19:47:03 INFO - 'USER': 'cltbld', 19:47:03 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1453607194.963659-698467002', 19:47:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:03 INFO - '_': '/tools/buildbot/bin/python'} 19:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:04 INFO - Downloading/unpacking jsonschema 19:47:04 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 19:47:04 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 19:47:04 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 19:47:04 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 19:47:04 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 19:47:04 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 19:47:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:47:05 INFO - Downloading/unpacking functools32 (from jsonschema) 19:47: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 19:47: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 19:47: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 19:47: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 19:47: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 19:47: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 19:47:06 INFO - Downloading functools32-3.2.3-2.tar.gz 19:47:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:47:06 INFO - warning: no files found matching '*.txt' 19:47:06 INFO - no previously-included directories found matching 'build' 19:47:06 INFO - no previously-included directories found matching 'dist' 19:47:06 INFO - no previously-included directories found matching '.git*' 19:47:06 INFO - Installing collected packages: jsonschema, functools32 19:47:06 INFO - Running setup.py install for functools32 19:47:06 INFO - warning: no files found matching '*.txt' 19:47:06 INFO - no previously-included directories found matching 'build' 19:47:06 INFO - no previously-included directories found matching 'dist' 19:47:06 INFO - no previously-included directories found matching '.git*' 19:47:06 INFO - Successfully installed jsonschema functools32 19:47:06 INFO - Cleaning up... 19:47:06 INFO - Return code: 0 19:47:06 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:47:06 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')]} 19:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:06 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')]} 19:47:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:06 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 0x7fcc2eed7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x191f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19b1a50>, '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 0x191d550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x191d9e0>, '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': '0e2a256762fed810e2f0f810000001b3-1453607194.963659-698467002', '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 19:47:06 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 19:47:06 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 19:47:06 INFO - Using env: {'DISPLAY': ':0', 19:47:06 INFO - 'HOME': '/home/cltbld', 19:47:06 INFO - 'LANG': 'en_US.UTF-8', 19:47:06 INFO - 'LANGUAGE': 'en_US:en', 19:47:06 INFO - 'LOGNAME': 'cltbld', 19:47:06 INFO - 'MAIL': '/var/mail/cltbld', 19:47:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:06 INFO - 'MOZ_NO_REMOTE': '1', 19:47:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:47:06 INFO - 'NO_EM_RESTART': '1', 19:47:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:47:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:47:06 INFO - 'PWD': '/builds/slave/test-pgo', 19:47:06 INFO - 'SHELL': '/bin/bash', 19:47:06 INFO - 'SHLVL': '1', 19:47:06 INFO - 'TERM': 'linux', 19:47:06 INFO - 'TMOUT': '86400', 19:47:06 INFO - 'USER': 'cltbld', 19:47:06 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1453607194.963659-698467002', 19:47:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:06 INFO - '_': '/tools/buildbot/bin/python'} 19:47:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:06 INFO - Downloading/unpacking flake8 19:47:06 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 19:47:06 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 19:47:06 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 19:47:06 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 19:47:06 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 19:47:06 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 19:47:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:47:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:47:08 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 19:47:08 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 19:47:08 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 19:47:08 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 19:47:08 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 19:47:08 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 19:47:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:47:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:47:08 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 19:47:08 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 19:47:08 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 19:47:08 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 19:47:08 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 19:47:08 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 19:47:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:47:08 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 19:47:08 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 19:47:08 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 19:47:08 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 19:47:08 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 19:47:08 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 19:47:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:47:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:47:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:47:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:47:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:47:08 INFO - no previously-included directories found matching 'docs/_build' 19:47:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:47:09 INFO - Running setup.py install for pep8 19:47:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:47:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:47:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:47:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:47:09 INFO - no previously-included directories found matching 'docs/_build' 19:47:09 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:47:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:47:09 INFO - Cleaning up... 19:47:09 INFO - Return code: 0 19:47:09 INFO - Running post-action listener: _resource_record_post_action 19:47:09 INFO - Running post-action listener: _start_resource_monitoring 19:47:09 INFO - Starting resource monitoring. 19:47:09 INFO - ##### 19:47:09 INFO - ##### Running install step. 19:47:09 INFO - ##### 19:47:09 INFO - Running pre-action listener: _resource_record_pre_action 19:47:09 INFO - Running main action method: install 19:47:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:47:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:47:09 INFO - Reading from file tmpfile_stdout 19:47:09 INFO - Detecting whether we're running mozinstall >=1.0... 19:47:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:47:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:47:09 INFO - Reading from file tmpfile_stdout 19:47:09 INFO - Output received: 19:47:09 INFO - Usage: mozinstall [options] installer 19:47:09 INFO - Options: 19:47:09 INFO - -h, --help show this help message and exit 19:47:09 INFO - -d DEST, --destination=DEST 19:47:09 INFO - Directory to install application into. [default: 19:47:09 INFO - "/builds/slave/test-pgo"] 19:47:09 INFO - --app=APP Application being installed. [default: firefox] 19:47:09 INFO - mkdir: /builds/slave/test-pgo/build/application 19:47:09 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'] 19:47:09 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 19:47:24 INFO - Reading from file tmpfile_stdout 19:47:24 INFO - Output received: 19:47:24 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:47:24 INFO - Running post-action listener: _resource_record_post_action 19:47:24 INFO - ##### 19:47:24 INFO - ##### Running run-tests step. 19:47:24 INFO - ##### 19:47:24 INFO - Running pre-action listener: _resource_record_pre_action 19:47:24 INFO - Running main action method: run_tests 19:47:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:47:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:47:24 INFO - Python 2.7.3 19:47:24 INFO - Return code: 0 19:47:24 INFO - grabbing minidump binary from tooltool 19:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:47:24 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 0x19b1a50>, '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 0x191d550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x191d9e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:47:24 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 19:47:24 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 19:47:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:47:24 INFO - Return code: 0 19:47:24 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:47:24 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:47:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:47:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:47:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:47:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:47:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:47:25 INFO - Return code: 0 19:47:25 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/FlIfbGpYSsGQN0TxwWzcLA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 19:47:25 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/FlIfbGpYSsGQN0TxwWzcLA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost 19:47:25 INFO - Using env: {'DISPLAY': ':0', 19:47:25 INFO - 'HOME': '/home/cltbld', 19:47:25 INFO - 'LANG': 'en_US.UTF-8', 19:47:25 INFO - 'LANGUAGE': 'en_US:en', 19:47:25 INFO - 'LOGNAME': 'cltbld', 19:47:25 INFO - 'MAIL': '/var/mail/cltbld', 19:47:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:47:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:47:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:25 INFO - 'MOZ_NO_REMOTE': '1', 19:47:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:47:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:47:25 INFO - 'NO_EM_RESTART': '1', 19:47:25 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:47:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:47:25 INFO - 'PWD': '/builds/slave/test-pgo', 19:47:25 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:47:25 INFO - 'SHELL': '/bin/bash', 19:47:25 INFO - 'SHLVL': '1', 19:47:25 INFO - 'TERM': 'linux', 19:47:25 INFO - 'TMOUT': '86400', 19:47:25 INFO - 'USER': 'cltbld', 19:47:25 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1453607194.963659-698467002', 19:47:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:25 INFO - '_': '/tools/buildbot/bin/python'} 19:47:25 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/FlIfbGpYSsGQN0TxwWzcLA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost'] with output_timeout 3600 19:47:25 INFO - mozversion INFO | application_buildid: 20160123171907 19:47:25 INFO - mozversion INFO | application_changeset: 7ede46ba62979809bafb3c1507745a4eeaec1c57 19:47:25 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 19:47:25 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:47:25 INFO - mozversion INFO | application_name: Firefox 19:47:25 INFO - mozversion INFO | application_remotingname: firefox-dev 19:47:25 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:47:25 INFO - mozversion INFO | application_vendor: Mozilla 19:47:25 INFO - mozversion INFO | application_version: 45.0a2 19:47:25 INFO - mozversion INFO | platform_buildid: 20160123171907 19:47:25 INFO - mozversion INFO | platform_changeset: 7ede46ba62979809bafb3c1507745a4eeaec1c57 19:47:25 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:47:25 INFO - mozversion INFO | platform_version: 45.0a2 19:47:25 INFO - 2016-01-23 19:47:25,449 DEBUG : using testdate: 1453607245 19:47:25 INFO - 2016-01-23 19:47:25,450 DEBUG : actual date: 1453607245 19:47:25 INFO - 2016-01-23 19:47:25,458 INFO : starting webserver on 'localhost:60432' 19:47:25 INFO - 2016-01-23 19:47:25,459 INFO : Starting test suite talos-linux64-ix-058.e 19:47:25 INFO - 2016-01-23 19:47:25,459 INFO : Starting test dromaeo_css 19:47:25 INFO - 2016-01-23 19:47:25,460 DEBUG : operating with platform_type : linux_ 19:47:25 INFO - 2016-01-23 19:47:25,460 INFO : Initialising browser for dromaeo_css test... 19:47:25 INFO - 2016-01-23 19:47:25,477 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptaXnxz/profile http://localhost:60432/getInfo.html 19:47:28 INFO - 2016-01-23 19:47:28,932 DEBUG : BROWSER_OUTPUT: 19:47:28 INFO - 2016-01-23 19:47:28,933 DEBUG : BROWSER_OUTPUT: (process:26511): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:47:29 INFO - 2016-01-23 19:47:29,760 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:47:29 INFO - 2016-01-23 19:47:29,760 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:47:29 INFO - 2016-01-23 19:47:29,760 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:47:29 INFO - 2016-01-23 19:47:29,760 DEBUG : BROWSER_OUTPUT: __metrics 19:47:30 INFO - 2016-01-23 19:47:30,718 INFO : Browser initialized. 19:47:30 INFO - 2016-01-23 19:47:30,718 INFO : Running cycle 1/1 for dromaeo_css test... 19:47:30 INFO - 2016-01-23 19:47:30,718 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptaXnxz/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:47:31 INFO - 2016-01-23 19:47:31,989 DEBUG : BROWSER_OUTPUT: 19:47:31 INFO - 2016-01-23 19:47:31,989 DEBUG : BROWSER_OUTPUT: (process:26626): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:47:42 INFO - 2016-01-23 19:47:42,491 DEBUG : BROWSER_OUTPUT: RSS: Main: 137572352 19:47:42 INFO - 2016-01-23 19:47:42,491 DEBUG : BROWSER_OUTPUT: 19:48:32 INFO - 2016-01-23 19:48:32,098 DEBUG : BROWSER_OUTPUT: 1453607312097 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] 19:50:39 INFO - 2016-01-23 19:50:39,959 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60432/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60432/tests/dromaeo/cssquery-ext.html) 19:50:40 INFO - 2016-01-23 19:50:40,970 DEBUG : BROWSER_OUTPUT: RSS: Main: 141803520 19:50:40 INFO - 2016-01-23 19:50:40,970 DEBUG : BROWSER_OUTPUT: 19:53:42 INFO - 2016-01-23 19:53:42,690 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60432/tests/dromaeo/cssquery-ext.html (next: http://localhost:60432/tests/dromaeo/cssquery-jquery.html) 19:53:43 INFO - 2016-01-23 19:53:43,277 DEBUG : BROWSER_OUTPUT: RSS: Main: 139415552 19:53:43 INFO - 2016-01-23 19:53:43,277 DEBUG : BROWSER_OUTPUT: 19:56:44 INFO - 2016-01-23 19:56:44,877 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60432/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60432/tests/dromaeo/cssquery-mootools.html) 19:56:45 INFO - 2016-01-23 19:56:45,458 DEBUG : BROWSER_OUTPUT: RSS: Main: 138555392 19:56:45 INFO - 2016-01-23 19:56:45,459 DEBUG : BROWSER_OUTPUT: 19:59:47 INFO - 2016-01-23 19:59:47,025 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60432/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60432/tests/dromaeo/cssquery-prototype.html) 19:59:47 INFO - 2016-01-23 19:59:47,626 DEBUG : BROWSER_OUTPUT: RSS: Main: 138829824 19:59:47 INFO - 2016-01-23 19:59:47,626 DEBUG : BROWSER_OUTPUT: 20:02:49 INFO - 2016-01-23 20:02:49,897 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60432/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60432/tests/dromaeo/cssquery-yui.html) 20:02:50 INFO - 2016-01-23 20:02:50,519 DEBUG : BROWSER_OUTPUT: RSS: Main: 139567104 20:02:50 INFO - 2016-01-23 20:02:50,519 DEBUG : BROWSER_OUTPUT: 20:05:52 INFO - 2016-01-23 20:05:52,466 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60432/tests/dromaeo/cssquery-yui.html (next: http://localhost:60432/tests/dromaeo/cssquery-dojo.html) 20:05:52 INFO - 2016-01-23 20:05:52,716 DEBUG : BROWSER_OUTPUT: RSS: Main: 141561856 20:05:52 INFO - 2016-01-23 20:05:52,716 DEBUG : BROWSER_OUTPUT: 20:05:52 INFO - 2016-01-23 20:05:52,716 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:05:52 INFO - 2016-01-23 20:05:52,716 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:05:52 INFO - 2016-01-23 20:05:52,717 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:05:52 INFO - 2016-01-23 20:05:52,717 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:05:52 INFO - 2016-01-23 20:05:52,717 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3298.1754561359658;3332.5334453176542;3344.866205351786;3365.915852103699;3372.409828280051;5491.807786727465;5507.586930980177;5520.365158006825;5531.225628412026;5546.278983732119;5506.421825708293;5533.418991005947;5576.525995290405;5580.748866301016;5608.383077861432;5098.617603679721;5120.283160357553;5199.324087868572;5206.479352064801;5238.3975842778;4981.1283025470575;5094.770735316901;5120.334356533645;5128.230765385185;5214.270002199695;5078.263651770491;5157.6647517911215;5173.637845350827;5184.740762961856;5205.947940520603;5235.476452354772;5257.526822585985;5265.394479634852;5270.578353731692;5296.841094767125;4946.480619534933;4979.029089327582;5036.118679231156;5157.4584668610005;5160.56135228506;5318.202269659582;5331.173668081454;5338.172583249564;5378.193271009341;5391.73041347931;6033.788817391414;6103.938960610381;6144.5698801083945;6151.538634602378;6157.261128664589;5942.940570594282;5945.464908158243;6070.908936365914;6184.474319682832;6188.257409110891;5692.117721753135;5732.369439361667;5732.627379220379;5736.3403208631125;5736.397678243766;6204.634980304326;6229.3770622937345;6231.40801623845;6234.906476402857;6235.407636274546;5704.372519022904;5847.298324201123;5851.268591426072;5953.107033944856;5958.553108516879;5945.019071853182;6132;6162.075688646649;6178.567500275028;6186.845328866814;6047.516198704093;6125.601835880742;6133.938660613426;6148.292946311142;6153.2000839891425;5840.912386314209;5844.444777746192;5941.70291485424;5967.8209653710455;5976.983912734846;4612.100640375162;4671.416072990876;4678.157931572349;4686.1799185143145;4727.409073865767;4081.142959978438;4188.706790524634;4192.979035104866;4193.224253513049;4213.031002869296;5711.228984087178;5734.569907256972;5758.510526605201;5857.531397488191;5867.3839246879315;6019.578629495981;6074.757009719562;6084.5436592255755;6086.513078953673;6091.451769340692;5740.368559458456;5772.220750198753;5799.797007104731;5806.44838740319;5832.8541786454825;5101.183810590362;5212.713300768418;5277.182036784305;5280.20796880471;5284.39229488606;6281;6299.842503937438;6301.842453938688;6310.9368906311265;6327.145835312266;6094.7257373417415;6111.57218994675;6132.908006379818;6146.969265153824;6157.938420615916;6042.335343112342;6054.243219597551;6164.229471316085;6281.842953926189;6298.67727777172;6005.009173486325;6037.698115094316;6042.939570604238;6087.086936959315;6099.841030204247;6064.06007068905;6074.848128796639;6075.574709770273;6083.722418292208;6086.939130608815;5677.545796336366;5764.538836892954;5789.363170051207;5844.298684157929;5879.617824841372;5855.795047173328;5863.618864773776;5902.144189092472;5967.836271926933;5969.582129251085;5704.743286552032;5835.912461312999;5893.793717219876;5905.704714764331;5909.320428150818;5786.768529258951;5839.211706419579;5859.531237500904;5887.911681324698;5898.380670029756;5816.534677225727;5830.125481177857;5841.415858414124;5854.765809367577;5869.970650146722 20:05:52 INFO - 2016-01-23 20:05:52,720 DEBUG : BROWSER_OUTPUT: |1;ext.html;596.3589141672702;599.8770252098319;604.8276241271236;605.3552966091113;672.8586996730686;39643.80178099109;40156.19687606246;40500.39249411257;40501.797491012505;40582.7970860146;42231.15537689244;42693.78653106738;42723.931901702475;42943;43038.78480607593;8856.202941735242;8928.508932008737;8952.641894324219;8991.280697544213;9032.232260257853;8693.000304964915;8810.07494213108;8840.911590884105;8848;8860.6012729427;8505.574721263944;8517.148285171495;8544.060153383123;8555.871661925044;8556.401051926368;8773.341999350043;8826.646934122627;8856.690015849446;8866.822663546693;8892.510911899843;8716.520591367473;8761.868571971425;8782.473051616924;8818.470891746452;8821.647134114628;38679.41980870261;39239.21521569581;39280.21439571221;39313;39326.80336598327;3354.7483938704695;3402.268512269849;3649.6532829381167;4046.898827529306;4235.4917409911;31379.84310078458;31973.52039719406;32119.51820722691;32122.518162227585;32488.350232995206;4231.344141658048;4262.7655478948645;4311.1808756336195;4390.4511936008;4396.450443694538;267068;267993;268261;268839;269698;43941.78029109834;44671.77664111659;44722.77638611851;59282.70358648179;59746;42082.579174207865;42458.57541424608;42675;42757.57242427536;42821.57178428176;15177;15193.544193674208;15210.08739475635;15357.692846143014;15408.922955385375;12745.681357966125;12892.419841107172;12936.353182340845;13160.14459060158;13189.802152967713;15033.849661503245;15096.39614415433;15112;15117.09297442157;15247.23763811805;6075.908861367083;6172.790149122431;6258.906116408258;6286;6289.937100629027;1053.5522402978704;1079.379356869803;1115.55935405516;1127.6391554702416;1138.7267055906523;30504.847475762923;30811.38377232443;31297;31745.305082552535;32193.195170120933;1083.247143235444;1084.6800193942806;1107.180686292138;1110.3837370259585;1130.9990658267493;15131.011082118903;15201.695966080617;15288.38846446152;15572.68854622924;15640.921795391178;450278;525551;528088;533250;804598;57049.429505705244;58248.417515825146;58403;58416;58435;1436.4254298280562;1467.1270593996555;1482.4514929476163;1519.058183925973;1531.5099168266047;28878.711212887603;29360.853195733886;29458.263543411587;29792.404151917275;30062.248443788205;47143.76428117975;47735;47786;47832;47852.28221576749;324502;330340;330386;330803;330936;32349;32387.352252954337;32775.18062048373;32884.177895552806;46880;44331.556684434036;44931;45110;45292.54707452883;45364;38346.616533834305;38817.6118238814;39279;39756.40365394464;40277.39583906185;38160;38631.80684096562;38644;38871.61128388793;39113.21773564456;37545.4368184472;37960.62039379571;38142.046448839;38182.61817381902;38213.617863821004;32128.839355803073;32807.83596082004;32833.01500954975;33260.66739332672;33390;25874.74125258723;26135;26277.605835912094;26594;26712.332191695365 20:05:52 INFO - 2016-01-23 20:05:52,722 DEBUG : BROWSER_OUTPUT: |2;jquery.html;380.73158423311565;385.5758665467986;385.9691224702023;386.40686546151665;387.1482737976452;14988;15006.474773382934;16869.49391518255;19098.71351929722;19911;11108.833367499494;14456.638584035405;15537.990030648;17842;17902.73145902809;5144.382674079106;5261.447548007462;5283.524482796547;5290.523852853243;5314.973425132869;5229.660072095302;5241.42344342122;5308;5316.867078323035;5317.973410132944;5353.518183363496;5355.892882142355;5364.222187782769;5425.593080518957;5589.804356847511;5523.143912693519;5542.75057622408;5544.91682624761;5554.1391084381585;5574.331080270374;5183.585313174937;5317.229001794757;5328.014317351263;5333.946660533384;5337.439568845293;12430.192037517532;14540.418383264763;16390.918045409697;20712.067956941974;21119.3664190073;2179.2263746370127;2212.281008672188;2242.6523888797265;2273.147569661377;2290.667853161299;10375.79248415035;10574.206934479946;13315.801577857943;13740.793888091686;14034.649133771636;1952.66804643211;2037.521182522106;2059.742532183477;2094.5706130243266;2121.734783152106;56503;57495.13757293644;57797.71101144509;59259.40740592582;59557.702211488664;10968.945155274172;11111.611093611686;11157.10743140563;11186.832197517044;11228.550857965753;14354.425822966965;14381.568552943429;14403.207823569805;14486.275686215648;14486.927565362106;7826.452148349561;7874.212578742195;7902.723404680809;8070.47541909774;8193.672253109928;7505.699772009168;7587.861820726936;7595;7615.619219039026;7688.269614386624;4753.073150735573;4776.904461910743;4780.976095119502;4814.061258054716;4819.204831202883;1898.1648074847024;1954.6481633305857;1969.3796454116907;1971.3790156100783;2000.739903812524;455.26020217147135;473.4247888815106;473.7820602522878;485.71342907684635;488.0824050784573;10849.45752712377;11288.379139147262;17562;18019.18913648889;18206.81793182051;1000.6890972825622;1042.2183362478142;1070.3203465799274;1097.4786976186247;1099.2085698297212;10061.849072263922;10327.122194613392;10338.172946164439;10401.219908506891;10445.477726113664;631499;637996;647492;669279;675723;87517.56241218753;91384;91691;92158;96173;1243.6517775023008;1245.9875401245872;1259.722860970585;1269.3526301586073;1270.149000169907;15810.446634367741;16358.427455039016;16392.918035410225;16976.915115424345;17109.657806843545;38892.80553597214;38965;39110.804445977585;39999.600003999585;40520;48987.75506122589;49003;51574.74212628913;52157.21764173464;54017.18974215311;10376.948115259376;10428.895711042793;10763.677089687322;10767.138628909825;10830.566777328819;18653.626927461104;18759.812401875806;19208.13563389623;19478.513037174183;19639.214431423155;13945.302734863419;14775;15175.544733658007;15341.309641066402;16085.517434476984;15033.173175475455;15474.458393956158;15733.842661573237;16199.190040497691;16362.427315043917;14922;15742.68514629678;15939.60150996188;16006.839931600534;16401.17994100314;9570.33007689455;9661;10010.199184065112;10059.798804024025;10318.896811031793;10720.624778132727;15306.923465383048;15531.06813591188;15537.145456999522;15815.367385304458 20:05:52 INFO - 2016-01-23 20:05:52,724 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1540.5301383078163;1603.486884197057;1658.2372108829938;1777.768890044294;1895.8672892897494;7862.25308595684;7992.080910695265;8105.1084380718075;8201.753947381589;8207.507549547032;7973.880391794113;7991.120976692574;8052.798680033002;8064.879026814588;8074.636641351139;2293.495431005176;2304.665823455598;2317.119494592061;2317.5017371265176;2317.629179331307;2359.587072262356;2363.9409014774683;2430.6961629796274;2430.9513809723794;2439.6828412306463;2314.895829687668;2339.4736184358467;2368.993177899386;2374.81001519878;2377.3462297868136;2302.804261637763;2334.2880421471446;2344.8241381896255;2359.1978727232736;2360.1857359211044;2302.6200676888293;2312.5259321838985;2333.241696448644;2333.346662934381;2334.556434277482;7858.1356050834365;7860.528368297921;7870;7877.4091943104495;7890.605469726491;4809.495003024667;4885.853424397274;4925.2858335541505;4935.851924442272;4938.777755001033;3088.243380371823;3092.366064956701;3123.9531407028912;3126.7498600111935;3143.842807859598;999.8850132234813;1012.2913960227796;1022.3150489172273;1028.8405297178874;1032.189731061121;10994.670159895137;11208.719782005515;11238.55045798159;11258.887411125866;11266.324020558794;4357.8256869724855;4417.624501917373;4466.932996005063;4510.21071312519;4516.119356725473;9729.075737804897;9782.315237933277;9804.019598040139;9813.656522021694;9825.508724563742;4994;4994.925076123861;5014.323066386064;5017.422996355393;5023.120953833138;4462.040661257845;4475.26158183896;4526.253168227271;4560.8175672973375;4570.3829982951875;3478.0956951192366;3511.157322242643;3554.7511674183074;3571.5357003589365;3577.2845430913403;1111.7109551516664;1148.4085695866636;1152.3201311226417;1152.815549512091;1167.6321958583019;1044.5299615173203;1046.602291129366;1115.3029356652091;1125.1055410948316;1177.9646610601696;7509.211532789088;7567.091948966159;7620.390368770485;7642.541447513056;7675.194104619046;1119.6025410979148;1162.5640384855678;1201.1351826684947;1211.0916812390708;1224.7489264700714;6074.787382441594;6112.51099912006;6150.477209437248;6154.876902461926;6171.321154672983;9379.343445958853;9738.269629777795;9853.753656158653;9860.753481163028;9868.259880508991;9540.761480962892;9609.087136722;9624.951875240578;9634.03659634031;9733.270004749531;7508.361789247975;7692.653830577638;7696.191899850547;7729.536227826348;7744.8451030980195;7069.399101076466;7134.250903655042;7141.857162856818;7159.284071592799;7170.462215333767;8481.745547633582;8627.43921645091;8634.09342019079;8737.91262087371;8764.1674040966;8613.48319100856;8755.562221888753;8772.649094036167;8824.338174637056;8888;6891.173059232924;6973.825654358681;6974.79075627732;6984.092068031124;6992.650367481504;7745.65144568507;7788.805279868048;7810.062792464941;7884.960575197317;7906.802329941797;7222.09723784527;7392.4825262231125;7404.444666649915;7511.3615342696485;7511.399088073051;7282.417406607565;7315.926840731525;7338.156112047183;7411.8147046324275;7449;7108.537945033556;7148.070750802362;7150.249223831631;7152.856942861218;7155.3202445767565;6664.133662623828;6776.728930842711;6803.11559497282;6807.251202367835;6823.078884350549;6709.36261055199;6733.528652994243;6787.185537735503;6800.795976120724;6813.4549236061985 20:05:52 INFO - 2016-01-23 20:05:52,727 DEBUG : BROWSER_OUTPUT: |4;prototype.html;363.9927201455971;364.56980762700005;368.3498624927004;374.59543692811764;375.99436008459867;6194.256689197291;6304.968475157618;6334;6362.872742545146;6372.490200783937;6009.759609615621;6186.536009799272;6187.35032821554;6194.814155575329;6220.751169953196;4857.247126695368;4891.608671306287;4905.3132561441425;4909.140900342426;4914.631402644816;4902.3872015998;4905.215165573509;4905.950940490603;4908.75456227189;4917.680350777206;4734.431868175824;4845.176320025586;4846.248831431134;4849.806007759703;4850.708957462563;4821.7830197641015;4825.276208568707;4847.684900481458;4853.126437241295;4856.514348565151;4286.635635970946;4289.914201715948;4295.548967358413;4300.505441874162;4301;5914.37899020601;5947.375525569796;5960.850978725523;5987.9401205987815;5995.550333724945;5390;5529.861753456155;5554;5554.056080371837;5554.527865131468;6690.498212634023;6695;6695.397414232742;6700.061991321219;6703.865922681519;4585.358049873021;4587.977060114711;4592.448906131252;4592.632589392874;4597.195490789099;6763.458923286125;6938.271481494421;6964.059851919977;7013.57918524885;7021.438284937244;4753.833615823499;4791.401074865642;4796.5203479652455;4801.087793319328;4815.253635686474;4862.343583616166;4863.5622793948005;4870.196417591058;4876.975615121902;4878.487758785347;5616.2698849150165;5630.211770352154;5635.690037048002;5636.267285252891;5642.915356269659;6632.2704502504685;6757.087793147961;6764.966175169191;6782.1861376635115;6797.762078327334;1689.6536210076904;1709.1795937949605;1724.4912750738563;1732.9133543322782;1737.878348515617;1131.7736452709491;1155.1625071822862;1167.101331974375;1168.6318809574957;1183.585744989247;6490.0589414534625;6508.446782023581;6518.869622607522;6522.532430203261;6528.869422611521;6828.6927088281145;6841.863162736718;6881.759138430131;6889.345512176335;6930.93069069313;6455.935440645628;6469.223693156757;6476.902846457307;6487.805365839033;6511.0558968949235;3810.0093975565997;3816.713746469026;3839.731218814712;3844.59631738669;3848.4419759134767;7291.30732580404;7315.48791584584;7335.119785625652;7339.266073392725;7339.559626422431;7156.177039640404;7290.198078211392;7292.3801476874;7297.452691048193;7297.963510182415;7215;7263.0921134858145;7267.818304542428;7310.049693539912;7319.890201646873;7040.190378106583;7070.787876363717;7080.964595176991;7081.327273908971;7092.290770922867;6811.727530898708;6975.825604359931;6987.196472405535;6990.300969902969;7004.579725216503;7274.636268186464;7298.635068246673;7332.45006624516;7338.412926965937;7345.669444874887;4673.6494762892235;4705.364775755229;4710.505396933273;4727.976360118178;4732.408448943882;6862.828429289308;6877.1747390313485;6934;7090.184628767758;7103.112110986127;6772;6816;6828.214755303005;6841.794746157623;6870.27862074475;6783.86432271342;6786.796396108125;6830.282820303995;6831.59010459374;6840.760573379908;6517.315681853337;6645.700943457653;6727.562708423937;6728.697208625722;6737.090492783412;6805.455563555002;6806.149231346082;6842.076319696777;6843.692033858588;6880.139982502187;6615.636140012345;6658.1344425224415;6671.933280667131;6672.899906501503;6693.665316734241 20:05:52 INFO - 2016-01-23 20:05:52,727 DEBUG : BROWSER_OUTPUT: |5;yui.html;782;802.6067227058741;806.5402720449346;876.7545087375534;932.920701740352;14564;14871.702565948675;14886.553403397902;14892.702145957075;14916.7016659667;14336.641583960407;14415.567532974028;14415.855841441582;14426.42294308229;14463.276836158202;800.0839039299998;802.6628815897308;818.5825229133155;820.122468958215;822.6174828704651;807.4872455990459;813.3940214540175;816.9468984516017;817.9631916563769;818.893543839303;851.055328585273;860.7848037990502;861.8233262181269;862.6764963138822;863.1627321498169;850.0521918061348;853.696937587157;854.179987212277;854.218390172991;856.3919617071887;631.2961048431013;631.6810010944489;632.6141053957083;633.6609913696151;636.045931103345;14956;15035.924820375829;15049.54851354461;15051.774223386657;15061.924690376478;13073.542426015043;13125.671858203526;13126.671833204151;13311.933440332736;13584.728305433935;11000.669979900616;11365.772684546346;11369.374684392355;11374.772504549945;11596.536138554447;3800.8669696560764;3803.2773772983046;3907.0623050467966;3915.001674572966;3924.843006279745;52105.2184217237;52525.7373713129;52540.47459525394;52548.737256313856;52679.73660131751;10298.47914440635;10677.305975111592;10739.731506712395;10877.803441621416;10995.175361847894;19215;19266.422007339803;19272.518187045156;19312.61374772497;19318.613627727365;7563.7352692655495;7739.922600774033;7790.7756501006115;7893.842123157505;7942.205779422012;4310.137972405531;4446.644268458515;4620.353150558924;4648.279516674853;4738.218193998021;3206.23050467886;3295.7857739246874;3310.66893310667;3315.751318651111;3327.7005069543375;596.7463827873223;598.1356939222868;598.2402349016725;599.2210126835097;602.3976023976024;629.5247088448192;647.8445173158502;694.90966174397;738.6196109003868;750.7334896111911;9172.6789562365;9607.759806004906;9645.517724113766;9694.75763105928;9742.707718768448;564.2213745031912;568.903286441306;578.3435800366614;610.9327973922865;643.0643413832862;4402.471703395613;4450.599446049806;4454.554544545585;4467.530909254481;4481.417415735934;59387;59719;60971.390286097456;61077.38922610717;63020.68489657522;48993;49931.99999999927;50299.74850125799;50855.23717144246;50879.23681144786;51247;52336.21495677568;52354.738226308626;52591.474085259426;53945;9073.591688373906;9137.451752894847;9316.627334906529;9542.761430964281;9570.760730981781;37172;37485;40314.395284070175;40532.1893562133;40738.59261407348;51416.22875656943;51697.48302516927;51737.741311293204;52017.47982520126;52109;11703.648890533297;11941;11958.940205298917;11998.220115692453;12393.256404615751;13540.661483462993;13733.244671543162;13786.931065344608;13877.514286999907;13914.234717090658;12711.491540338282;12871.678208044874;13208.603741887759;13288.468461261828;13329.533466328632;12526.749465010467;12661.74676506483;12709.237445753284;12733.681657958625;13188.868111319147;11987.34069626144;12176.147669663038;12187.18693896981;12628.684282892633;12649.747005060031;10996;11078.889211107786;11208.327500350006;11543.711407214887;11671.941640291745;10768.246222764332;10888.45557722095;10899.618513351994;10934.289271197666;11006.174536909604 20:05:52 INFO - 2016-01-23 20:05:52,727 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:05:52 INFO - 2016-01-23 20:05:52,727 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:05:52 INFO - 2016-01-23 20:05:52,728 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,305 20:05:52 INFO - 2016-01-23 20:05:52,728 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:05:52 INFO - 2016-01-23 20:05:52,728 DEBUG : BROWSER_OUTPUT: __startTimestamp1453608352715__endTimestamp 20:05:52 INFO - 2016-01-23 20:05:52,728 DEBUG : BROWSER_OUTPUT: 20:05:52 INFO - 2016-01-23 20:05:52,728 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:05:52 INFO - 2016-01-23 20:05:52,728 DEBUG : BROWSER_OUTPUT: Number of tests: 6 20:05:52 INFO - 2016-01-23 20:05:52,728 DEBUG : BROWSER_OUTPUT: 20:05:52 INFO - 2016-01-23 20:05:52,728 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5618.30 Median:5839.21 stddev:630.99 (10.8%) stddev-sans-first:606.10 20:05:52 INFO - 2016-01-23 20:05:52,729 DEBUG : BROWSER_OUTPUT: Values: 3298.2 3332.5 3344.9 3365.9 3372.4 5491.8 5507.6 5520.4 5531.2 5546.3 5506.4 5533.4 5576.5 5580.7 5608.4 5098.6 5120.3 5199.3 5206.5 5238.4 4981.1 5094.8 5120.3 5128.2 5214.3 5078.3 5157.7 5173.6 5184.7 5205.9 5235.5 5257.5 5265.4 5270.6 5296.8 4946.5 4979.0 5036.1 5157.5 5160.6 5318.2 5331.2 5338.2 5378.2 5391.7 6033.8 6103.9 6144.6 6151.5 6157.3 5942.9 5945.5 6070.9 6184.5 6188.3 5692.1 5732.4 5732.6 5736.3 5736.4 6204.6 6229.4 6231.4 6234.9 6235.4 5704.4 5847.3 5851.3 5953.1 5958.6 5945.0 6132.0 6162.1 6178.6 6186.8 6047.5 6125.6 6133.9 6148.3 6153.2 5840.9 5844.4 5941.7 5967.8 5977.0 4612.1 4671.4 4678.2 4686.2 4727.4 4081.1 4188.7 4193.0 4193.2 4213.0 5711.2 5734.6 5758.5 5857.5 5867.4 6019.6 6074.8 6084.5 6086.5 6091.5 5740.4 5772.2 5799.8 5806.4 5832.9 5101.2 5212.7 5277.2 5280.2 5284.4 6281.0 6299.8 6301.8 6310.9 6327.1 6094.7 6111.6 6132.9 6147.0 6157.9 6042.3 6054.2 6164.2 6281.8 6298.7 6005.0 6037.7 6042.9 6087.1 6099.8 6064.1 6074.8 6075.6 6083.7 6086.9 5677.5 5764.5 5789.4 5844.3 5879.6 5855.8 5863.6 5902.1 5967.8 5969.6 5704.7 5835.9 5893.8 5905.7 5909.3 5786.8 5839.2 5859.5 5887.9 5898.4 5816.5 5830.1 5841.4 5854.8 5870.0 20:05:52 INFO - 2016-01-23 20:05:52,729 DEBUG : BROWSER_OUTPUT: 20:05:52 INFO - 2016-01-23 20:05:52,729 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:54356.61 Median:39259.11 stddev:110976.22 (282.7%) stddev-sans-first:111214.13 20:05:52 INFO - 2016-01-23 20:05:52,729 DEBUG : BROWSER_OUTPUT: Values: 596.4 599.9 604.8 605.4 672.9 39643.8 40156.2 40500.4 40501.8 40582.8 42231.2 42693.8 42723.9 42943.0 43038.8 8856.2 8928.5 8952.6 8991.3 9032.2 8693.0 8810.1 8840.9 8848.0 8860.6 8505.6 8517.1 8544.1 8555.9 8556.4 8773.3 8826.6 8856.7 8866.8 8892.5 8716.5 8761.9 8782.5 8818.5 8821.6 38679.4 39239.2 39280.2 39313.0 39326.8 3354.7 3402.3 3649.7 4046.9 4235.5 31379.8 31973.5 32119.5 32122.5 32488.4 4231.3 4262.8 4311.2 4390.5 4396.5 267068.0 267993.0 268261.0 268839.0 269698.0 43941.8 44671.8 44722.8 59282.7 59746.0 42082.6 42458.6 42675.0 42757.6 42821.6 15177.0 15193.5 15210.1 15357.7 15408.9 12745.7 12892.4 12936.4 13160.1 13189.8 15033.8 15096.4 15112.0 15117.1 15247.2 6075.9 6172.8 6258.9 6286.0 6289.9 1053.6 1079.4 1115.6 1127.6 1138.7 30504.8 30811.4 31297.0 31745.3 32193.2 1083.2 1084.7 1107.2 1110.4 1131.0 15131.0 15201.7 15288.4 15572.7 15640.9 450278.0 525551.0 528088.0 533250.0 804598.0 57049.4 58248.4 58403.0 58416.0 58435.0 1436.4 1467.1 1482.5 1519.1 1531.5 28878.7 29360.9 29458.3 29792.4 30062.2 47143.8 47735.0 47786.0 47832.0 47852.3 324502.0 330340.0 330386.0 330803.0 330936.0 32349.0 32387.4 32775.2 32884.2 46880.0 44331.6 44931.0 45110.0 45292.5 45364.0 38346.6 38817.6 39279.0 39756.4 40277.4 38160.0 38631.8 38644.0 38871.6 39113.2 37545.4 37960.6 38142.0 38182.6 38213.6 32128.8 32807.8 32833.0 33260.7 33390.0 25874.7 26135.0 26277.6 26594.0 26712.3 20:05:52 INFO - 2016-01-23 20:05:52,729 DEBUG : BROWSER_OUTPUT: 20:05:52 INFO - 2016-01-23 20:05:52,729 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32778.89 Median:10955.87 stddev:106625.84 (973.2%) stddev-sans-first:106897.20 20:05:52 INFO - 2016-01-23 20:05:52,729 DEBUG : BROWSER_OUTPUT: Values: 380.7 385.6 386.0 386.4 387.1 14988.0 15006.5 16869.5 19098.7 19911.0 11108.8 14456.6 15538.0 17842.0 17902.7 5144.4 5261.4 5283.5 5290.5 5315.0 5229.7 5241.4 5308.0 5316.9 5318.0 5353.5 5355.9 5364.2 5425.6 5589.8 5523.1 5542.8 5544.9 5554.1 5574.3 5183.6 5317.2 5328.0 5333.9 5337.4 12430.2 14540.4 16390.9 20712.1 21119.4 2179.2 2212.3 2242.7 2273.1 2290.7 10375.8 10574.2 13315.8 13740.8 14034.6 1952.7 2037.5 2059.7 2094.6 2121.7 56503.0 57495.1 57797.7 59259.4 59557.7 10968.9 11111.6 11157.1 11186.8 11228.6 14354.4 14381.6 14403.2 14486.3 14486.9 7826.5 7874.2 7902.7 8070.5 8193.7 7505.7 7587.9 7595.0 7615.6 7688.3 4753.1 4776.9 4781.0 4814.1 4819.2 1898.2 1954.6 1969.4 1971.4 2000.7 455.3 473.4 473.8 485.7 488.1 10849.5 11288.4 17562.0 18019.2 18206.8 1000.7 1042.2 1070.3 1097.5 1099.2 10061.8 10327.1 10338.2 10401.2 10445.5 631499.0 637996.0 647492.0 669279.0 675723.0 87517.6 91384.0 91691.0 92158.0 96173.0 1243.7 1246.0 1259.7 1269.4 1270.1 15810.4 16358.4 16392.9 16976.9 17109.7 38892.8 38965.0 39110.8 39999.6 40520.0 48987.8 49003.0 51574.7 52157.2 54017.2 10376.9 10428.9 10763.7 10767.1 10830.6 18653.6 18759.8 19208.1 19478.5 19639.2 13945.3 14775.0 15175.5 15341.3 16085.5 15033.2 15474.5 15733.8 16199.2 16362.4 14922.0 15742.7 15939.6 16006.8 16401.2 9570.3 9661.0 10010.2 10059.8 10318.9 10720.6 15306.9 15531.1 15537.1 15815.4 20:05:52 INFO - 2016-01-23 20:05:52,729 DEBUG : BROWSER_OUTPUT: 20:05:52 INFO - 2016-01-23 20:05:52,730 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5665.38 Median:6721.45 stddev:2945.05 (43.8%) stddev-sans-first:2936.99 20:05:52 INFO - 2016-01-23 20:05:52,730 DEBUG : BROWSER_OUTPUT: Values: 1540.5 1603.5 1658.2 1777.8 1895.9 7862.3 7992.1 8105.1 8201.8 8207.5 7973.9 7991.1 8052.8 8064.9 8074.6 2293.5 2304.7 2317.1 2317.5 2317.6 2359.6 2363.9 2430.7 2431.0 2439.7 2314.9 2339.5 2369.0 2374.8 2377.3 2302.8 2334.3 2344.8 2359.2 2360.2 2302.6 2312.5 2333.2 2333.3 2334.6 7858.1 7860.5 7870.0 7877.4 7890.6 4809.5 4885.9 4925.3 4935.9 4938.8 3088.2 3092.4 3124.0 3126.7 3143.8 999.9 1012.3 1022.3 1028.8 1032.2 10994.7 11208.7 11238.6 11258.9 11266.3 4357.8 4417.6 4466.9 4510.2 4516.1 9729.1 9782.3 9804.0 9813.7 9825.5 4994.0 4994.9 5014.3 5017.4 5023.1 4462.0 4475.3 4526.3 4560.8 4570.4 3478.1 3511.2 3554.8 3571.5 3577.3 1111.7 1148.4 1152.3 1152.8 1167.6 1044.5 1046.6 1115.3 1125.1 1178.0 7509.2 7567.1 7620.4 7642.5 7675.2 1119.6 1162.6 1201.1 1211.1 1224.7 6074.8 6112.5 6150.5 6154.9 6171.3 9379.3 9738.3 9853.8 9860.8 9868.3 9540.8 9609.1 9625.0 9634.0 9733.3 7508.4 7692.7 7696.2 7729.5 7744.8 7069.4 7134.3 7141.9 7159.3 7170.5 8481.7 8627.4 8634.1 8737.9 8764.2 8613.5 8755.6 8772.6 8824.3 8888.0 6891.2 6973.8 6974.8 6984.1 6992.7 7745.7 7788.8 7810.1 7885.0 7906.8 7222.1 7392.5 7404.4 7511.4 7511.4 7282.4 7315.9 7338.2 7411.8 7449.0 7108.5 7148.1 7150.2 7152.9 7155.3 6664.1 6776.7 6803.1 6807.3 6823.1 6709.4 6733.5 6787.2 6800.8 6813.5 20:05:52 INFO - 2016-01-23 20:05:52,730 DEBUG : BROWSER_OUTPUT: 20:05:52 INFO - 2016-01-23 20:05:52,730 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5656.64 Median:6462.58 stddev:1710.47 (26.5%) stddev-sans-first:1668.50 20:05:52 INFO - 2016-01-23 20:05:52,731 DEBUG : BROWSER_OUTPUT: Values: 364.0 364.6 368.3 374.6 376.0 6194.3 6305.0 6334.0 6362.9 6372.5 6009.8 6186.5 6187.4 6194.8 6220.8 4857.2 4891.6 4905.3 4909.1 4914.6 4902.4 4905.2 4906.0 4908.8 4917.7 4734.4 4845.2 4846.2 4849.8 4850.7 4821.8 4825.3 4847.7 4853.1 4856.5 4286.6 4289.9 4295.5 4300.5 4301.0 5914.4 5947.4 5960.9 5987.9 5995.6 5390.0 5529.9 5554.0 5554.1 5554.5 6690.5 6695.0 6695.4 6700.1 6703.9 4585.4 4588.0 4592.4 4592.6 4597.2 6763.5 6938.3 6964.1 7013.6 7021.4 4753.8 4791.4 4796.5 4801.1 4815.3 4862.3 4863.6 4870.2 4877.0 4878.5 5616.3 5630.2 5635.7 5636.3 5642.9 6632.3 6757.1 6765.0 6782.2 6797.8 1689.7 1709.2 1724.5 1732.9 1737.9 1131.8 1155.2 1167.1 1168.6 1183.6 6490.1 6508.4 6518.9 6522.5 6528.9 6828.7 6841.9 6881.8 6889.3 6930.9 6455.9 6469.2 6476.9 6487.8 6511.1 3810.0 3816.7 3839.7 3844.6 3848.4 7291.3 7315.5 7335.1 7339.3 7339.6 7156.2 7290.2 7292.4 7297.5 7298.0 7215.0 7263.1 7267.8 7310.0 7319.9 7040.2 7070.8 7081.0 7081.3 7092.3 6811.7 6975.8 6987.2 6990.3 7004.6 7274.6 7298.6 7332.5 7338.4 7345.7 4673.6 4705.4 4710.5 4728.0 4732.4 6862.8 6877.2 6934.0 7090.2 7103.1 6772.0 6816.0 6828.2 6841.8 6870.3 6783.9 6786.8 6830.3 6831.6 6840.8 6517.3 6645.7 6727.6 6728.7 6737.1 6805.5 6806.1 6842.1 6843.7 6880.1 6615.6 6658.1 6671.9 6672.9 6693.7 20:05:52 INFO - 2016-01-23 20:05:52,731 DEBUG : BROWSER_OUTPUT: 20:05:52 INFO - 2016-01-23 20:05:52,731 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:15044.09 Median:4474.47 stddev:17233.47 (385.2%) stddev-sans-first:17248.54 20:05:52 INFO - 2016-01-23 20:05:52,732 DEBUG : BROWSER_OUTPUT: Values: 782.0 802.6 806.5 876.8 932.9 14564.0 14871.7 14886.6 14892.7 14916.7 14336.6 14415.6 14415.9 14426.4 14463.3 800.1 802.7 818.6 820.1 822.6 807.5 813.4 816.9 818.0 818.9 851.1 860.8 861.8 862.7 863.2 850.1 853.7 854.2 854.2 856.4 631.3 631.7 632.6 633.7 636.0 14956.0 15035.9 15049.5 15051.8 15061.9 13073.5 13125.7 13126.7 13311.9 13584.7 11000.7 11365.8 11369.4 11374.8 11596.5 3800.9 3803.3 3907.1 3915.0 3924.8 52105.2 52525.7 52540.5 52548.7 52679.7 10298.5 10677.3 10739.7 10877.8 10995.2 19215.0 19266.4 19272.5 19312.6 19318.6 7563.7 7739.9 7790.8 7893.8 7942.2 4310.1 4446.6 4620.4 4648.3 4738.2 3206.2 3295.8 3310.7 3315.8 3327.7 596.7 598.1 598.2 599.2 602.4 629.5 647.8 694.9 738.6 750.7 9172.7 9607.8 9645.5 9694.8 9742.7 564.2 568.9 578.3 610.9 643.1 4402.5 4450.6 4454.6 4467.5 4481.4 59387.0 59719.0 60971.4 61077.4 63020.7 48993.0 49932.0 50299.7 50855.2 50879.2 51247.0 52336.2 52354.7 52591.5 53945.0 9073.6 9137.5 9316.6 9542.8 9570.8 37172.0 37485.0 40314.4 40532.2 40738.6 51416.2 51697.5 51737.7 52017.5 52109.0 11703.6 11941.0 11958.9 11998.2 12393.3 13540.7 13733.2 13786.9 13877.5 13914.2 12711.5 12871.7 13208.6 13288.5 13329.5 12526.7 12661.7 12709.2 12733.7 13188.9 11987.3 12176.1 12187.2 12628.7 12649.7 10996.0 11078.9 11208.3 11543.7 11671.9 10768.2 10888.5 10899.6 10934.3 11006.2 20:05:52 INFO - 2016-01-23 20:05:52,732 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:05:52 INFO - 2016-01-23 20:05:52,732 DEBUG : BROWSER_OUTPUT: 20:05:53 INFO - 2016-01-23 20:05:53,342 INFO : Browser exited with error code: 0 20:05:53 INFO - 2016-01-23 20:05:53,358 INFO : Completed test dromaeo_css (00:18:27) 20:05:53 INFO - 2016-01-23 20:05:53,358 INFO : Starting test kraken 20:05:53 INFO - 2016-01-23 20:05:53,358 DEBUG : operating with platform_type : linux_ 20:05:53 INFO - 2016-01-23 20:05:53,358 INFO : Initialising browser for kraken test... 20:05:53 INFO - 2016-01-23 20:05:53,364 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprwYKdL/profile http://localhost:60432/getInfo.html 20:05:56 INFO - 2016-01-23 20:05:56,714 DEBUG : BROWSER_OUTPUT: 20:05:56 INFO - 2016-01-23 20:05:56,714 DEBUG : BROWSER_OUTPUT: (process:26891): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:05:57 INFO - 2016-01-23 20:05:57,516 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:05:57 INFO - 2016-01-23 20:05:57,516 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:05:57 INFO - 2016-01-23 20:05:57,517 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:05:57 INFO - 2016-01-23 20:05:57,517 DEBUG : BROWSER_OUTPUT: __metrics 20:05:58 INFO - 2016-01-23 20:05:58,481 INFO : Browser initialized. 20:05:58 INFO - 2016-01-23 20:05:58,482 INFO : Running cycle 1/1 for kraken test... 20:05:58 INFO - 2016-01-23 20:05:58,482 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprwYKdL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:05:59 INFO - 2016-01-23 20:05:59,744 DEBUG : BROWSER_OUTPUT: 20:05:59 INFO - 2016-01-23 20:05:59,745 DEBUG : BROWSER_OUTPUT: (process:27011): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:06:10 INFO - 2016-01-23 20:06:10,251 DEBUG : BROWSER_OUTPUT: RSS: Main: 136409088 20:06:10 INFO - 2016-01-23 20:06:10,251 DEBUG : BROWSER_OUTPUT: 20:06:12 INFO - 2016-01-23 20:06:12,711 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60432/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60432/tests/kraken/driver.html?testName=audio-beat-detection) 20:06:13 INFO - 2016-01-23 20:06:13,312 DEBUG : BROWSER_OUTPUT: RSS: Main: 138952704 20:06:13 INFO - 2016-01-23 20:06:13,312 DEBUG : BROWSER_OUTPUT: 20:06:15 INFO - 2016-01-23 20:06:15,875 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60432/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60432/tests/kraken/driver.html?testName=audio-dft) 20:06:16 INFO - 2016-01-23 20:06:16,468 DEBUG : BROWSER_OUTPUT: RSS: Main: 139452416 20:06:16 INFO - 2016-01-23 20:06:16,468 DEBUG : BROWSER_OUTPUT: 20:06:19 INFO - 2016-01-23 20:06:19,293 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60432/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60432/tests/kraken/driver.html?testName=audio-fft) 20:06:19 INFO - 2016-01-23 20:06:19,874 DEBUG : BROWSER_OUTPUT: RSS: Main: 138174464 20:06:19 INFO - 2016-01-23 20:06:19,874 DEBUG : BROWSER_OUTPUT: 20:06:21 INFO - 2016-01-23 20:06:21,888 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60432/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60432/tests/kraken/driver.html?testName=audio-oscillator) 20:06:22 INFO - 2016-01-23 20:06:22,474 DEBUG : BROWSER_OUTPUT: RSS: Main: 138321920 20:06:22 INFO - 2016-01-23 20:06:22,474 DEBUG : BROWSER_OUTPUT: 20:06:24 INFO - 2016-01-23 20:06:24,673 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60432/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60432/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:06:25 INFO - 2016-01-23 20:06:25,255 DEBUG : BROWSER_OUTPUT: RSS: Main: 137871360 20:06:25 INFO - 2016-01-23 20:06:25,255 DEBUG : BROWSER_OUTPUT: 20:06:28 INFO - 2016-01-23 20:06:28,228 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60432/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60432/tests/kraken/driver.html?testName=imaging-darkroom) 20:06:28 INFO - 2016-01-23 20:06:28,810 DEBUG : BROWSER_OUTPUT: RSS: Main: 139259904 20:06:28 INFO - 2016-01-23 20:06:28,810 DEBUG : BROWSER_OUTPUT: 20:06:32 INFO - 2016-01-23 20:06:32,173 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60432/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60432/tests/kraken/driver.html?testName=imaging-desaturate) 20:06:32 INFO - 2016-01-23 20:06:32,759 DEBUG : BROWSER_OUTPUT: RSS: Main: 137973760 20:06:32 INFO - 2016-01-23 20:06:32,759 DEBUG : BROWSER_OUTPUT: 20:06:35 INFO - 2016-01-23 20:06:35,541 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60432/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60432/tests/kraken/driver.html?testName=json-parse-financial) 20:06:36 INFO - 2016-01-23 20:06:36,127 DEBUG : BROWSER_OUTPUT: RSS: Main: 138129408 20:06:36 INFO - 2016-01-23 20:06:36,127 DEBUG : BROWSER_OUTPUT: 20:06:37 INFO - 2016-01-23 20:06:37,696 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60432/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60432/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:06:38 INFO - 2016-01-23 20:06:38,264 DEBUG : BROWSER_OUTPUT: RSS: Main: 138309632 20:06:38 INFO - 2016-01-23 20:06:38,264 DEBUG : BROWSER_OUTPUT: 20:06:40 INFO - 2016-01-23 20:06:40,002 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60432/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60432/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:06:40 INFO - 2016-01-23 20:06:40,610 DEBUG : BROWSER_OUTPUT: RSS: Main: 138215424 20:06:40 INFO - 2016-01-23 20:06:40,610 DEBUG : BROWSER_OUTPUT: 20:06:42 INFO - 2016-01-23 20:06:42,683 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60432/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60432/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:06:43 INFO - 2016-01-23 20:06:43,277 DEBUG : BROWSER_OUTPUT: RSS: Main: 138985472 20:06:43 INFO - 2016-01-23 20:06:43,277 DEBUG : BROWSER_OUTPUT: 20:06:45 INFO - 2016-01-23 20:06:45,704 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60432/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60432/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:06:46 INFO - 2016-01-23 20:06:46,293 DEBUG : BROWSER_OUTPUT: RSS: Main: 139067392 20:06:46 INFO - 2016-01-23 20:06:46,293 DEBUG : BROWSER_OUTPUT: 20:06:48 INFO - 2016-01-23 20:06:48,814 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60432/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60432/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:06:49 INFO - 2016-01-23 20:06:49,399 DEBUG : BROWSER_OUTPUT: RSS: Main: 138444800 20:06:49 INFO - 2016-01-23 20:06:49,400 DEBUG : BROWSER_OUTPUT: 20:06:51 INFO - 2016-01-23 20:06:51,057 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60432/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60432/tests/kraken/driver.html?testName=ai-astar) 20:06:51 INFO - 2016-01-23 20:06:51,315 DEBUG : BROWSER_OUTPUT: RSS: Main: 139755520 20:06:51 INFO - 2016-01-23 20:06:51,316 DEBUG : BROWSER_OUTPUT: 20:06:51 INFO - 2016-01-23 20:06:51,316 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:06:51 INFO - 2016-01-23 20:06:51,316 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:06:51 INFO - 2016-01-23 20:06:51,316 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:06:51 INFO - 2016-01-23 20:06:51,316 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:06:51 INFO - 2016-01-23 20:06:51,316 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;104;112;114;113;122;112;111;112;111 20:06:51 INFO - 2016-01-23 20:06:51,317 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;143;130;147;162;125;151;143;124;159;124 20:06:51 INFO - 2016-01-23 20:06:51,317 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;163;163;161;162;164;160;160;162;162 20:06:51 INFO - 2016-01-23 20:06:51,317 DEBUG : BROWSER_OUTPUT: |3;audio-fft;78;71;73;153;72;72;73;73;166;71 20:06:51 INFO - 2016-01-23 20:06:51,317 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;94;133;93;93;94;130;92;93;141 20:06:51 INFO - 2016-01-23 20:06:51,317 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;110;110;109;110;110;109;110;110;110 20:06:51 INFO - 2016-01-23 20:06:51,317 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;147;145;147;146;146;149;147;146;146 20:06:51 INFO - 2016-01-23 20:06:51,317 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;96;95;97;96;96;98;95;97;97 20:06:51 INFO - 2016-01-23 20:06:51,317 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;62;59;60;59;61;62;61;62;65;60 20:06:51 INFO - 2016-01-23 20:06:51,318 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;66;63;64;64;63;64;64;63 20:06:51 INFO - 2016-01-23 20:06:51,318 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;80;89;83;84;88;89;83;87;83 20:06:51 INFO - 2016-01-23 20:06:51,318 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;111;115;116;126;122;121;114;123;128;121 20:06:51 INFO - 2016-01-23 20:06:51,318 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;155;148;144;145;142;142;144;144;143;134 20:06:51 INFO - 2016-01-23 20:06:51,318 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;66;65;67;65;72;65;64;67;68 20:06:51 INFO - 2016-01-23 20:06:51,319 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:06:51 INFO - 2016-01-23 20:06:51,319 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:06:51 INFO - 2016-01-23 20:06:51,319 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,702 20:06:51 INFO - 2016-01-23 20:06:51,319 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:06:51 INFO - 2016-01-23 20:06:51,320 DEBUG : BROWSER_OUTPUT: __startTimestamp1453608411310__endTimestamp 20:06:51 INFO - 2016-01-23 20:06:51,320 DEBUG : BROWSER_OUTPUT: 20:06:51 INFO - 2016-01-23 20:06:51,320 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:06:51 INFO - 2016-01-23 20:06:51,320 DEBUG : BROWSER_OUTPUT: Number of tests: 14 20:06:51 INFO - 2016-01-23 20:06:51,320 DEBUG : BROWSER_OUTPUT: 20:06:51 INFO - 2016-01-23 20:06:51,320 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.60 Median:112.50 stddev:4.43 (3.9%) stddev-sans-first:4.61 20:06:51 INFO - 2016-01-23 20:06:51,321 DEBUG : BROWSER_OUTPUT: Values: 115.0 104.0 112.0 114.0 113.0 122.0 112.0 111.0 112.0 111.0 20:06:51 INFO - 2016-01-23 20:06:51,321 DEBUG : BROWSER_OUTPUT: 20:06:51 INFO - 2016-01-23 20:06:51,321 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.80 Median:145.00 stddev:14.39 (9.9%) stddev-sans-first:15.24 20:06:51 INFO - 2016-01-23 20:06:51,321 DEBUG : BROWSER_OUTPUT: Values: 143.0 130.0 147.0 162.0 125.0 151.0 143.0 124.0 159.0 124.0 20:06:51 INFO - 2016-01-23 20:06:51,321 DEBUG : BROWSER_OUTPUT: 20:06:51 INFO - 2016-01-23 20:06:51,321 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.10 Median:162.50 stddev:1.45 (0.9%) stddev-sans-first:1.36 20:06:51 INFO - 2016-01-23 20:06:51,321 DEBUG : BROWSER_OUTPUT: Values: 164.0 163.0 163.0 161.0 162.0 164.0 160.0 160.0 162.0 162.0 20:06:51 INFO - 2016-01-23 20:06:51,322 DEBUG : BROWSER_OUTPUT: 20:06:51 INFO - 2016-01-23 20:06:51,322 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:90.20 Median:72.50 stddev:36.71 (50.6%) stddev-sans-first:38.67 20:06:51 INFO - 2016-01-23 20:06:51,323 DEBUG : BROWSER_OUTPUT: Values: 78.0 71.0 73.0 153.0 72.0 72.0 73.0 73.0 166.0 71.0 20:06:51 INFO - 2016-01-23 20:06:51,323 DEBUG : BROWSER_OUTPUT: 20:06:51 INFO - 2016-01-23 20:06:51,323 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.50 Median:93.00 stddev:20.32 (21.8%) stddev-sans-first:20.95 20:06:51 INFO - 2016-01-23 20:06:51,323 DEBUG : BROWSER_OUTPUT: Values: 92.0 94.0 133.0 93.0 93.0 94.0 130.0 92.0 93.0 141.0 20:06:51 INFO - 2016-01-23 20:06:51,323 DEBUG : BROWSER_OUTPUT: 20:06:51 INFO - 2016-01-23 20:06:51,323 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 20:06:51 INFO - 2016-01-23 20:06:51,323 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 110.0 109.0 110.0 110.0 109.0 110.0 110.0 110.0 20:06:51 INFO - 2016-01-23 20:06:51,323 DEBUG : BROWSER_OUTPUT: 20:06:51 INFO - 2016-01-23 20:06:51,323 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:1.32 (0.9%) stddev-sans-first:1.13 20:06:51 INFO - 2016-01-23 20:06:51,323 DEBUG : BROWSER_OUTPUT: Values: 149.0 147.0 145.0 147.0 146.0 146.0 149.0 147.0 146.0 146.0 20:06:51 INFO - 2016-01-23 20:06:51,323 DEBUG : BROWSER_OUTPUT: 20:06:51 INFO - 2016-01-23 20:06:51,324 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.40 Median:97.00 stddev:0.97 (1.0%) stddev-sans-first:1.00 20:06:51 INFO - 2016-01-23 20:06:51,324 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 95.0 97.0 96.0 96.0 98.0 95.0 97.0 97.0 20:06:51 INFO - 2016-01-23 20:06:51,324 DEBUG : BROWSER_OUTPUT: 20:06:51 INFO - 2016-01-23 20:06:51,324 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.10 Median:61.50 stddev:1.79 (2.9%) stddev-sans-first:1.87 20:06:51 INFO - 2016-01-23 20:06:51,324 DEBUG : BROWSER_OUTPUT: Values: 62.0 59.0 60.0 59.0 61.0 62.0 61.0 62.0 65.0 60.0 20:06:51 INFO - 2016-01-23 20:06:51,324 DEBUG : BROWSER_OUTPUT: 20:06:51 INFO - 2016-01-23 20:06:51,324 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.80 Median:64.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 20:06:51 INFO - 2016-01-23 20:06:51,324 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 66.0 63.0 64.0 64.0 63.0 64.0 64.0 63.0 20:06:51 INFO - 2016-01-23 20:06:51,324 DEBUG : BROWSER_OUTPUT: 20:06:51 INFO - 2016-01-23 20:06:51,324 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:85.50 stddev:3.30 (3.9%) stddev-sans-first:3.22 20:06:51 INFO - 2016-01-23 20:06:51,324 DEBUG : BROWSER_OUTPUT: Values: 81.0 80.0 89.0 83.0 84.0 88.0 89.0 83.0 87.0 83.0 20:06:51 INFO - 2016-01-23 20:06:51,324 DEBUG : BROWSER_OUTPUT: 20:06:51 INFO - 2016-01-23 20:06:51,324 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.70 Median:121.50 stddev:5.50 (4.5%) stddev-sans-first:4.85 20:06:51 INFO - 2016-01-23 20:06:51,324 DEBUG : BROWSER_OUTPUT: Values: 111.0 115.0 116.0 126.0 122.0 121.0 114.0 123.0 128.0 121.0 20:06:51 INFO - 2016-01-23 20:06:51,325 DEBUG : BROWSER_OUTPUT: 20:06:51 INFO - 2016-01-23 20:06:51,325 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.10 Median:144.00 stddev:5.24 (3.6%) stddev-sans-first:3.79 20:06:51 INFO - 2016-01-23 20:06:51,325 DEBUG : BROWSER_OUTPUT: Values: 155.0 148.0 144.0 145.0 142.0 142.0 144.0 144.0 143.0 134.0 20:06:51 INFO - 2016-01-23 20:06:51,325 DEBUG : BROWSER_OUTPUT: 20:06:51 INFO - 2016-01-23 20:06:51,325 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:2.27 (3.4%) stddev-sans-first:2.40 20:06:51 INFO - 2016-01-23 20:06:51,325 DEBUG : BROWSER_OUTPUT: Values: 67.0 66.0 65.0 67.0 65.0 72.0 65.0 64.0 67.0 68.0 20:06:51 INFO - 2016-01-23 20:06:51,325 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:06:51 INFO - 2016-01-23 20:06:51,325 DEBUG : BROWSER_OUTPUT: 20:06:52 INFO - 2016-01-23 20:06:52,090 INFO : Browser exited with error code: 0 20:06:52 INFO - 2016-01-23 20:06:52,140 INFO : Completed test kraken (00:00:58) 20:06:52 INFO - 2016-01-23 20:06:52,140 INFO : Starting test v8_7 20:06:52 INFO - 2016-01-23 20:06:52,140 DEBUG : operating with platform_type : linux_ 20:06:52 INFO - 2016-01-23 20:06:52,140 INFO : Initialising browser for v8_7 test... 20:06:52 INFO - 2016-01-23 20:06:52,146 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphaVnQk/profile http://localhost:60432/getInfo.html 20:06:55 INFO - 2016-01-23 20:06:55,517 DEBUG : BROWSER_OUTPUT: 20:06:55 INFO - 2016-01-23 20:06:55,517 DEBUG : BROWSER_OUTPUT: (process:27317): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:06:56 INFO - 2016-01-23 20:06:56,319 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:06:56 INFO - 2016-01-23 20:06:56,319 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:06:56 INFO - 2016-01-23 20:06:56,320 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:06:56 INFO - 2016-01-23 20:06:56,320 DEBUG : BROWSER_OUTPUT: __metrics 20:06:57 INFO - 2016-01-23 20:06:57,202 INFO : Browser initialized. 20:06:57 INFO - 2016-01-23 20:06:57,202 INFO : Running cycle 1/1 for v8_7 test... 20:06:57 INFO - 2016-01-23 20:06:57,202 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphaVnQk/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:06:58 INFO - 2016-01-23 20:06:58,499 DEBUG : BROWSER_OUTPUT: 20:06:58 INFO - 2016-01-23 20:06:58,500 DEBUG : BROWSER_OUTPUT: (process:27432): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:07:09 INFO - 2016-01-23 20:07:09,006 DEBUG : BROWSER_OUTPUT: RSS: Main: 136089600 20:07:09 INFO - 2016-01-23 20:07:09,006 DEBUG : BROWSER_OUTPUT: 20:07:30 INFO - 2016-01-23 20:07:30,339 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60432/tests/v8_7/run.html (next: http://localhost:60432/tests/v8_7/run.html) 20:07:30 INFO - 2016-01-23 20:07:30,589 DEBUG : BROWSER_OUTPUT: RSS: Main: 136253440 20:07:30 INFO - 2016-01-23 20:07:30,589 DEBUG : BROWSER_OUTPUT: 20:07:30 INFO - 2016-01-23 20:07:30,589 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:07:30 INFO - 2016-01-23 20:07:30,590 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:07:30 INFO - 2016-01-23 20:07:30,590 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:07:30 INFO - 2016-01-23 20:07:30,590 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:07:30 INFO - 2016-01-23 20:07:30,590 DEBUG : BROWSER_OUTPUT: |0;Richards;164.446637066272 20:07:30 INFO - 2016-01-23 20:07:30,590 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;167.22408026755852 20:07:30 INFO - 2016-01-23 20:07:30,590 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.214848143982 20:07:30 INFO - 2016-01-23 20:07:30,591 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5159.79381443299 20:07:30 INFO - 2016-01-23 20:07:30,591 DEBUG : BROWSER_OUTPUT: |4;RayTrace;926.7840593141798 20:07:30 INFO - 2016-01-23 20:07:30,591 DEBUG : BROWSER_OUTPUT: |5;Earley;551.2679162072767 20:07:30 INFO - 2016-01-23 20:07:30,591 DEBUG : BROWSER_OUTPUT: |6;Boyer;11021.739130434782 20:07:30 INFO - 2016-01-23 20:07:30,591 DEBUG : BROWSER_OUTPUT: |7;RegExp;24512.19512195122 20:07:30 INFO - 2016-01-23 20:07:30,592 DEBUG : BROWSER_OUTPUT: |8;Splay;521.1047420531527 20:07:30 INFO - 2016-01-23 20:07:30,592 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 20:07:30 INFO - 2016-01-23 20:07:30,592 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:07:30 INFO - 2016-01-23 20:07:30,592 DEBUG : BROWSER_OUTPUT: __startTimestamp1453608450588__endTimestamp 20:07:30 INFO - 2016-01-23 20:07:30,592 DEBUG : BROWSER_OUTPUT: 20:07:30 INFO - 2016-01-23 20:07:30,592 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:07:30 INFO - 2016-01-23 20:07:30,593 DEBUG : BROWSER_OUTPUT: Number of tests: 10 20:07:30 INFO - 2016-01-23 20:07:30,593 DEBUG : BROWSER_OUTPUT: 20:07:30 INFO - 2016-01-23 20:07:30,593 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.45 Median:164.45 stddev:0.00 (0.0%) 20:07:30 INFO - 2016-01-23 20:07:30,593 DEBUG : BROWSER_OUTPUT: Values: 164.4 20:07:30 INFO - 2016-01-23 20:07:30,594 DEBUG : BROWSER_OUTPUT: 20:07:30 INFO - 2016-01-23 20:07:30,594 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:167.22 Median:167.22 stddev:0.00 (0.0%) 20:07:30 INFO - 2016-01-23 20:07:30,594 DEBUG : BROWSER_OUTPUT: Values: 167.2 20:07:30 INFO - 2016-01-23 20:07:30,594 DEBUG : BROWSER_OUTPUT: 20:07:30 INFO - 2016-01-23 20:07:30,594 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.21 Median:281.21 stddev:0.00 (0.0%) 20:07:30 INFO - 2016-01-23 20:07:30,595 DEBUG : BROWSER_OUTPUT: Values: 281.2 20:07:30 INFO - 2016-01-23 20:07:30,595 DEBUG : BROWSER_OUTPUT: 20:07:30 INFO - 2016-01-23 20:07:30,595 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5159.79 Median:5159.79 stddev:0.00 (0.0%) 20:07:30 INFO - 2016-01-23 20:07:30,595 DEBUG : BROWSER_OUTPUT: Values: 5159.8 20:07:30 INFO - 2016-01-23 20:07:30,595 DEBUG : BROWSER_OUTPUT: 20:07:30 INFO - 2016-01-23 20:07:30,596 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:926.78 Median:926.78 stddev:0.00 (0.0%) 20:07:30 INFO - 2016-01-23 20:07:30,596 DEBUG : BROWSER_OUTPUT: Values: 926.8 20:07:30 INFO - 2016-01-23 20:07:30,596 DEBUG : BROWSER_OUTPUT: 20:07:30 INFO - 2016-01-23 20:07:30,597 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:551.27 Median:551.27 stddev:0.00 (0.0%) 20:07:30 INFO - 2016-01-23 20:07:30,597 DEBUG : BROWSER_OUTPUT: Values: 551.3 20:07:30 INFO - 2016-01-23 20:07:30,597 DEBUG : BROWSER_OUTPUT: 20:07:30 INFO - 2016-01-23 20:07:30,597 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11021.74 Median:11021.74 stddev:0.00 (0.0%) 20:07:30 INFO - 2016-01-23 20:07:30,597 DEBUG : BROWSER_OUTPUT: Values: 11021.7 20:07:30 INFO - 2016-01-23 20:07:30,598 DEBUG : BROWSER_OUTPUT: 20:07:30 INFO - 2016-01-23 20:07:30,598 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24512.20 Median:24512.20 stddev:0.00 (0.0%) 20:07:30 INFO - 2016-01-23 20:07:30,598 DEBUG : BROWSER_OUTPUT: Values: 24512.2 20:07:30 INFO - 2016-01-23 20:07:30,598 DEBUG : BROWSER_OUTPUT: 20:07:30 INFO - 2016-01-23 20:07:30,598 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:521.10 Median:521.10 stddev:0.00 (0.0%) 20:07:30 INFO - 2016-01-23 20:07:30,598 DEBUG : BROWSER_OUTPUT: Values: 521.1 20:07:30 INFO - 2016-01-23 20:07:30,598 DEBUG : BROWSER_OUTPUT: 20:07:30 INFO - 2016-01-23 20:07:30,598 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 20:07:30 INFO - 2016-01-23 20:07:30,598 DEBUG : BROWSER_OUTPUT: Values: 4835.7 20:07:30 INFO - 2016-01-23 20:07:30,598 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:07:30 INFO - 2016-01-23 20:07:30,598 DEBUG : BROWSER_OUTPUT: 20:07:31 INFO - 2016-01-23 20:07:31,410 INFO : Browser exited with error code: 0 20:07:31 INFO - 2016-01-23 20:07:31,427 INFO : Completed test v8_7 (00:00:39) 20:07:31 INFO - 2016-01-23 20:07:31,655 INFO : Completed test suite (00:20:06) 20:07:31 INFO - 2016-01-23 20:07:31,656 DEBUG : Working with test: dromaeo_css 20:07:31 INFO - 2016-01-23 20:07:31,656 DEBUG : Generating results file: dromaeo_css 20:07:31 INFO - 2016-01-23 20:07:31,657 DEBUG : Working with test: kraken 20:07:31 INFO - 2016-01-23 20:07:31,657 DEBUG : Generating results file: kraken 20:07:31 INFO - 2016-01-23 20:07:31,657 INFO : javascript benchmark 20:07:31 INFO - 2016-01-23 20:07:31,657 DEBUG : Working with test: v8_7 20:07:31 INFO - 2016-01-23 20:07:31,657 DEBUG : Generating results file: v8_7 20:07:31 INFO - 2016-01-23 20:07:31,658 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:07:31 INFO - 2016-01-23 20:07:31,716 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 20:07:31 INFO - 2016-01-23 20:07:31,717 DEBUG : process_Request line: dromaeo_css 7348.17 graph.html#tests=[[72,52,43]] 20:07:31 INFO - 2016-01-23 20:07:31,717 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:07:31 INFO - 2016-01-23 20:07:31,750 DEBUG : process_Request line: kraken 1504.30 graph.html#tests=[[232,52,43]] 20:07:31 INFO - 2016-01-23 20:07:31,750 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:07:31 INFO - 2016-01-23 20:07:31,781 DEBUG : process_Request line: v8_7 23184.12 graph.html#tests=[[230,52,43]] 20:07:31 INFO - 2016-01-23 20:07:31,782 INFO : javascript benchmark 20:07:31 INFO - 2016-01-23 20:07:31,786 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3298.1754561359658, 3332.5334453176542, 3344.866205351786, 3365.915852103699, 3372.409828280051, 5491.807786727465, 5507.586930980177, 5520.365158006825, 5531.225628412026, 5546.278983732119, 5506.421825708293, 5533.418991005947, 5576.525995290405, 5580.748866301016, 5608.383077861432, 5098.617603679721, 5120.283160357553, 5199.324087868572, 5206.479352064801, 5238.3975842778, 4981.1283025470575, 5094.770735316901, 5120.334356533645, 5128.230765385185, 5214.270002199695, 5078.263651770491, 5157.6647517911215, 5173.637845350827, 5184.740762961856, 5205.947940520603, 5235.476452354772, 5257.526822585985, 5265.394479634852, 5270.578353731692, 5296.841094767125, 4946.480619534933, 4979.029089327582, 5036.118679231156, 5157.4584668610005, 5160.56135228506, 5318.202269659582, 5331.173668081454, 5338.172583249564, 5378.193271009341, 5391.73041347931, 6033.788817391414, 6103.938960610381, 6144.5698801083945, 6151.538634602378, 6157.261128664589, 5942.940570594282, 5945.464908158243, 6070.908936365914, 6184.474319682832, 6188.257409110891, 5692.117721753135, 5732.369439361667, 5732.627379220379, 5736.3403208631125, 5736.397678243766, 6204.634980304326, 6229.3770622937345, 6231.40801623845, 6234.906476402857, 6235.407636274546, 5704.372519022904, 5847.298324201123, 5851.268591426072, 5953.107033944856, 5958.553108516879, 5945.019071853182, 6132.0, 6162.075688646649, 6178.567500275028, 6186.845328866814, 6047.516198704093, 6125.601835880742, 6133.938660613426, 6148.292946311142, 6153.2000839891425, 5840.912386314209, 5844.444777746192, 5941.70291485424, 5967.8209653710455, 5976.983912734846, 4612.100640375162, 4671.416072990876, 4678.157931572349, 4686.1799185143145, 4727.409073865767, 4081.142959978438, 4188.706790524634, 4192.979035104866, 4193.224253513049, 4213.031002869296, 5711.228984087178, 5734.569907256972, 5758.510526605201, 5857.531397488191, 5867.3839246879315, 6019.578629495981, 6074.757009719562, 6084.5436592255755, 6086.513078953673, 6091.451769340692, 5740.368559458456, 5772.220750198753, 5799.797007104731, 5806.44838740319, 5832.8541786454825, 5101.183810590362, 5212.713300768418, 5277.182036784305, 5280.20796880471, 5284.39229488606, 6281.0, 6299.842503937438, 6301.842453938688, 6310.9368906311265, 6327.145835312266, 6094.7257373417415, 6111.57218994675, 6132.908006379818, 6146.969265153824, 6157.938420615916, 6042.335343112342, 6054.243219597551, 6164.229471316085, 6281.842953926189, 6298.67727777172, 6005.009173486325, 6037.698115094316, 6042.939570604238, 6087.086936959315, 6099.841030204247, 6064.06007068905, 6074.848128796639, 6075.574709770273, 6083.722418292208, 6086.939130608815, 5677.545796336366, 5764.538836892954, 5789.363170051207, 5844.298684157929, 5879.617824841372, 5855.795047173328, 5863.618864773776, 5902.144189092472, 5967.836271926933, 5969.582129251085, 5704.743286552032, 5835.912461312999, 5893.793717219876, 5905.704714764331, 5909.320428150818, 5786.768529258951, 5839.211706419579, 5859.531237500904, 5887.911681324698, 5898.380670029756, 5816.534677225727, 5830.125481177857, 5841.415858414124, 5854.765809367577, 5869.970650146722], "unit": "ms", "name": "dojo.html", "value": 5576.834337713569}, {"lowerIsBetter": false, "replicates": [596.3589141672702, 599.8770252098319, 604.8276241271236, 605.3552966091113, 672.8586996730686, 39643.80178099109, 40156.19687606246, 40500.39249411257, 40501.797491012505, 40582.7970860146, 42231.15537689244, 42693.78653106738, 42723.931901702475, 42943.0, 43038.78480607593, 8856.202941735242, 8928.508932008737, 8952.641894324219, 8991.280697544213, 9032.232260257853, 8693.000304964915, 8810.07494213108, 8840.911590884105, 8848.0, 8860.6012729427, 8505.574721263944, 8517.148285171495, 8544.060153383123, 8555.871661925044, 8556.401051926368, 8773.341999350043, 8826.646934122627, 8856.690015849446, 8866.822663546693, 8892.510911899843, 8716.520591367473, 8761.868571971425, 8782.473051616924, 8818.470891746452, 8821.647134114628, 38679.41980870261, 39239.21521569581, 39280.21439571221, 39313.0, 39326.80336598327, 3354.7483938704695, 3402.268512269849, 3649.6532829381167, 4046.898827529306, 4235.4917409911, 31379.84310078458, 31973.52039719406, 32119.51820722691, 32122.518162227585, 32488.350232995206, 4231.344141658048, 4262.7655478948645, 4311.1808756336195, 4390.4511936008, 4396.450443694538, 267068.0, 267993.0, 268261.0, 268839.0, 269698.0, 43941.78029109834, 44671.77664111659, 44722.77638611851, 59282.70358648179, 59746.0, 42082.579174207865, 42458.57541424608, 42675.0, 42757.57242427536, 42821.57178428176, 15177.0, 15193.544193674208, 15210.08739475635, 15357.692846143014, 15408.922955385375, 12745.681357966125, 12892.419841107172, 12936.353182340845, 13160.14459060158, 13189.802152967713, 15033.849661503245, 15096.39614415433, 15112.0, 15117.09297442157, 15247.23763811805, 6075.908861367083, 6172.790149122431, 6258.906116408258, 6286.0, 6289.937100629027, 1053.5522402978704, 1079.379356869803, 1115.55935405516, 1127.6391554702416, 1138.7267055906523, 30504.847475762923, 30811.38377232443, 31297.0, 31745.305082552535, 32193.195170120933, 1083.247143235444, 1084.6800193942806, 1107.180686292138, 1110.3837370259585, 1130.9990658267493, 15131.011082118903, 15201.695966080617, 15288.38846446152, 15572.68854622924, 15640.921795391178, 450278.0, 525551.0, 528088.0, 533250.0, 804598.0, 57049.429505705244, 58248.417515825146, 58403.0, 58416.0, 58435.0, 1436.4254298280562, 1467.1270593996555, 1482.4514929476163, 1519.058183925973, 1531.5099168266047, 28878.711212887603, 29360.853195733886, 29458.263543411587, 29792.404151917275, 30062.248443788205, 47143.76428117975, 47735.0, 47786.0, 47832.0, 47852.28221576749, 324502.0, 330340.0, 330386.0, 330803.0, 330936.0, 32349.0, 32387.352252954337, 32775.18062048373, 32884.177895552806, 46880.0, 44331.556684434036, 44931.0, 45110.0, 45292.54707452883, 45364.0, 38346.616533834305, 38817.6118238814, 39279.0, 39756.40365394464, 40277.39583906185, 38160.0, 38631.80684096562, 38644.0, 38871.61128388793, 39113.21773564456, 37545.4368184472, 37960.62039379571, 38142.046448839, 38182.61817381902, 38213.617863821004, 32128.839355803073, 32807.83596082004, 32833.01500954975, 33260.66739332672, 33390.0, 25874.74125258723, 26135.0, 26277.605835912094, 26594.0, 26712.332191695365], "unit": "ms", "name": "ext.html", "value": 19090.573439829142}, {"lowerIsBetter": false, "replicates": [380.73158423311565, 385.5758665467986, 385.9691224702023, 386.40686546151665, 387.1482737976452, 14988.0, 15006.474773382934, 16869.49391518255, 19098.71351929722, 19911.0, 11108.833367499494, 14456.638584035405, 15537.990030648, 17842.0, 17902.73145902809, 5144.382674079106, 5261.447548007462, 5283.524482796547, 5290.523852853243, 5314.973425132869, 5229.660072095302, 5241.42344342122, 5308.0, 5316.867078323035, 5317.973410132944, 5353.518183363496, 5355.892882142355, 5364.222187782769, 5425.593080518957, 5589.804356847511, 5523.143912693519, 5542.75057622408, 5544.91682624761, 5554.1391084381585, 5574.331080270374, 5183.585313174937, 5317.229001794757, 5328.014317351263, 5333.946660533384, 5337.439568845293, 12430.192037517532, 14540.418383264763, 16390.918045409697, 20712.067956941974, 21119.3664190073, 2179.2263746370127, 2212.281008672188, 2242.6523888797265, 2273.147569661377, 2290.667853161299, 10375.79248415035, 10574.206934479946, 13315.801577857943, 13740.793888091686, 14034.649133771636, 1952.66804643211, 2037.521182522106, 2059.742532183477, 2094.5706130243266, 2121.734783152106, 56503.0, 57495.13757293644, 57797.71101144509, 59259.40740592582, 59557.702211488664, 10968.945155274172, 11111.611093611686, 11157.10743140563, 11186.832197517044, 11228.550857965753, 14354.425822966965, 14381.568552943429, 14403.207823569805, 14486.275686215648, 14486.927565362106, 7826.452148349561, 7874.212578742195, 7902.723404680809, 8070.47541909774, 8193.672253109928, 7505.699772009168, 7587.861820726936, 7595.0, 7615.619219039026, 7688.269614386624, 4753.073150735573, 4776.904461910743, 4780.976095119502, 4814.061258054716, 4819.204831202883, 1898.1648074847024, 1954.6481633305857, 1969.3796454116907, 1971.3790156100783, 2000.739903812524, 455.26020217147135, 473.4247888815106, 473.7820602522878, 485.71342907684635, 488.0824050784573, 10849.45752712377, 11288.379139147262, 17562.0, 18019.18913648889, 18206.81793182051, 1000.6890972825622, 1042.2183362478142, 1070.3203465799274, 1097.4786976186247, 1099.2085698297212, 10061.849072263922, 10327.122194613392, 10338.172946164439, 10401.219908506891, 10445.477726113664, 631499.0, 637996.0, 647492.0, 669279.0, 675723.0, 87517.56241218753, 91384.0, 91691.0, 92158.0, 96173.0, 1243.6517775023008, 1245.9875401245872, 1259.722860970585, 1269.3526301586073, 1270.149000169907, 15810.446634367741, 16358.427455039016, 16392.918035410225, 16976.915115424345, 17109.657806843545, 38892.80553597214, 38965.0, 39110.804445977585, 39999.600003999585, 40520.0, 48987.75506122589, 49003.0, 51574.74212628913, 52157.21764173464, 54017.18974215311, 10376.948115259376, 10428.895711042793, 10763.677089687322, 10767.138628909825, 10830.566777328819, 18653.626927461104, 18759.812401875806, 19208.13563389623, 19478.513037174183, 19639.214431423155, 13945.302734863419, 14775.0, 15175.544733658007, 15341.309641066402, 16085.517434476984, 15033.173175475455, 15474.458393956158, 15733.842661573237, 16199.190040497691, 16362.427315043917, 14922.0, 15742.68514629678, 15939.60150996188, 16006.839931600534, 16401.17994100314, 9570.33007689455, 9661.0, 10010.199184065112, 10059.798804024025, 10318.896811031793, 10720.624778132727, 15306.923465383048, 15531.06813591188, 15537.145456999522, 15815.367385304458], "unit": "ms", "name": "jquery.html", "value": 9208.239270292293}, {"lowerIsBetter": false, "replicates": [1540.5301383078163, 1603.486884197057, 1658.2372108829938, 1777.768890044294, 1895.8672892897494, 7862.25308595684, 7992.080910695265, 8105.1084380718075, 8201.753947381589, 8207.507549547032, 7973.880391794113, 7991.120976692574, 8052.798680033002, 8064.879026814588, 8074.636641351139, 2293.495431005176, 2304.665823455598, 2317.119494592061, 2317.5017371265176, 2317.629179331307, 2359.587072262356, 2363.9409014774683, 2430.6961629796274, 2430.9513809723794, 2439.6828412306463, 2314.895829687668, 2339.4736184358467, 2368.993177899386, 2374.81001519878, 2377.3462297868136, 2302.804261637763, 2334.2880421471446, 2344.8241381896255, 2359.1978727232736, 2360.1857359211044, 2302.6200676888293, 2312.5259321838985, 2333.241696448644, 2333.346662934381, 2334.556434277482, 7858.1356050834365, 7860.528368297921, 7870.0, 7877.4091943104495, 7890.605469726491, 4809.495003024667, 4885.853424397274, 4925.2858335541505, 4935.851924442272, 4938.777755001033, 3088.243380371823, 3092.366064956701, 3123.9531407028912, 3126.7498600111935, 3143.842807859598, 999.8850132234813, 1012.2913960227796, 1022.3150489172273, 1028.8405297178874, 1032.189731061121, 10994.670159895137, 11208.719782005515, 11238.55045798159, 11258.887411125866, 11266.324020558794, 4357.8256869724855, 4417.624501917373, 4466.932996005063, 4510.21071312519, 4516.119356725473, 9729.075737804897, 9782.315237933277, 9804.019598040139, 9813.656522021694, 9825.508724563742, 4994.0, 4994.925076123861, 5014.323066386064, 5017.422996355393, 5023.120953833138, 4462.040661257845, 4475.26158183896, 4526.253168227271, 4560.8175672973375, 4570.3829982951875, 3478.0956951192366, 3511.157322242643, 3554.7511674183074, 3571.5357003589365, 3577.2845430913403, 1111.7109551516664, 1148.4085695866636, 1152.3201311226417, 1152.815549512091, 1167.6321958583019, 1044.5299615173203, 1046.602291129366, 1115.3029356652091, 1125.1055410948316, 1177.9646610601696, 7509.211532789088, 7567.091948966159, 7620.390368770485, 7642.541447513056, 7675.194104619046, 1119.6025410979148, 1162.5640384855678, 1201.1351826684947, 1211.0916812390708, 1224.7489264700714, 6074.787382441594, 6112.51099912006, 6150.477209437248, 6154.876902461926, 6171.321154672983, 9379.343445958853, 9738.269629777795, 9853.753656158653, 9860.753481163028, 9868.259880508991, 9540.761480962892, 9609.087136722, 9624.951875240578, 9634.03659634031, 9733.270004749531, 7508.361789247975, 7692.653830577638, 7696.191899850547, 7729.536227826348, 7744.8451030980195, 7069.399101076466, 7134.250903655042, 7141.857162856818, 7159.284071592799, 7170.462215333767, 8481.745547633582, 8627.43921645091, 8634.09342019079, 8737.91262087371, 8764.1674040966, 8613.48319100856, 8755.562221888753, 8772.649094036167, 8824.338174637056, 8888.0, 6891.173059232924, 6973.825654358681, 6974.79075627732, 6984.092068031124, 6992.650367481504, 7745.65144568507, 7788.805279868048, 7810.062792464941, 7884.960575197317, 7906.802329941797, 7222.09723784527, 7392.4825262231125, 7404.444666649915, 7511.3615342696485, 7511.399088073051, 7282.417406607565, 7315.926840731525, 7338.156112047183, 7411.8147046324275, 7449.0, 7108.537945033556, 7148.070750802362, 7150.249223831631, 7152.856942861218, 7155.3202445767565, 6664.133662623828, 6776.728930842711, 6803.11559497282, 6807.251202367835, 6823.078884350549, 6709.36261055199, 6733.528652994243, 6787.185537735503, 6800.795976120724, 6813.4549236061985], "unit": "ms", "name": "mootools.html", "value": 4640.574171557001}, {"lowerIsBetter": false, "replicates": [363.9927201455971, 364.56980762700005, 368.3498624927004, 374.59543692811764, 375.99436008459867, 6194.256689197291, 6304.968475157618, 6334.0, 6362.872742545146, 6372.490200783937, 6009.759609615621, 6186.536009799272, 6187.35032821554, 6194.814155575329, 6220.751169953196, 4857.247126695368, 4891.608671306287, 4905.3132561441425, 4909.140900342426, 4914.631402644816, 4902.3872015998, 4905.215165573509, 4905.950940490603, 4908.75456227189, 4917.680350777206, 4734.431868175824, 4845.176320025586, 4846.248831431134, 4849.806007759703, 4850.708957462563, 4821.7830197641015, 4825.276208568707, 4847.684900481458, 4853.126437241295, 4856.514348565151, 4286.635635970946, 4289.914201715948, 4295.548967358413, 4300.505441874162, 4301.0, 5914.37899020601, 5947.375525569796, 5960.850978725523, 5987.9401205987815, 5995.550333724945, 5390.0, 5529.861753456155, 5554.0, 5554.056080371837, 5554.527865131468, 6690.498212634023, 6695.0, 6695.397414232742, 6700.061991321219, 6703.865922681519, 4585.358049873021, 4587.977060114711, 4592.448906131252, 4592.632589392874, 4597.195490789099, 6763.458923286125, 6938.271481494421, 6964.059851919977, 7013.57918524885, 7021.438284937244, 4753.833615823499, 4791.401074865642, 4796.5203479652455, 4801.087793319328, 4815.253635686474, 4862.343583616166, 4863.5622793948005, 4870.196417591058, 4876.975615121902, 4878.487758785347, 5616.2698849150165, 5630.211770352154, 5635.690037048002, 5636.267285252891, 5642.915356269659, 6632.2704502504685, 6757.087793147961, 6764.966175169191, 6782.1861376635115, 6797.762078327334, 1689.6536210076904, 1709.1795937949605, 1724.4912750738563, 1732.9133543322782, 1737.878348515617, 1131.7736452709491, 1155.1625071822862, 1167.101331974375, 1168.6318809574957, 1183.585744989247, 6490.0589414534625, 6508.446782023581, 6518.869622607522, 6522.532430203261, 6528.869422611521, 6828.6927088281145, 6841.863162736718, 6881.759138430131, 6889.345512176335, 6930.93069069313, 6455.935440645628, 6469.223693156757, 6476.902846457307, 6487.805365839033, 6511.0558968949235, 3810.0093975565997, 3816.713746469026, 3839.731218814712, 3844.59631738669, 3848.4419759134767, 7291.30732580404, 7315.48791584584, 7335.119785625652, 7339.266073392725, 7339.559626422431, 7156.177039640404, 7290.198078211392, 7292.3801476874, 7297.452691048193, 7297.963510182415, 7215.0, 7263.0921134858145, 7267.818304542428, 7310.049693539912, 7319.890201646873, 7040.190378106583, 7070.787876363717, 7080.964595176991, 7081.327273908971, 7092.290770922867, 6811.727530898708, 6975.825604359931, 6987.196472405535, 6990.300969902969, 7004.579725216503, 7274.636268186464, 7298.635068246673, 7332.45006624516, 7338.412926965937, 7345.669444874887, 4673.6494762892235, 4705.364775755229, 4710.505396933273, 4727.976360118178, 4732.408448943882, 6862.828429289308, 6877.1747390313485, 6934.0, 7090.184628767758, 7103.112110986127, 6772.0, 6816.0, 6828.214755303005, 6841.794746157623, 6870.27862074475, 6783.86432271342, 6786.796396108125, 6830.282820303995, 6831.59010459374, 6840.760573379908, 6517.315681853337, 6645.700943457653, 6727.562708423937, 6728.697208625722, 6737.090492783412, 6805.455563555002, 6806.149231346082, 6842.076319696777, 6843.692033858588, 6880.139982502187, 6615.636140012345, 6658.1344425224415, 6671.933280667131, 6672.899906501503, 6693.665316734241], "unit": "ms", "name": "prototype.html", "value": 5106.292547643674}, {"lowerIsBetter": false, "replicates": [782.0, 802.6067227058741, 806.5402720449346, 876.7545087375534, 932.920701740352, 14564.0, 14871.702565948675, 14886.553403397902, 14892.702145957075, 14916.7016659667, 14336.641583960407, 14415.567532974028, 14415.855841441582, 14426.42294308229, 14463.276836158202, 800.0839039299998, 802.6628815897308, 818.5825229133155, 820.122468958215, 822.6174828704651, 807.4872455990459, 813.3940214540175, 816.9468984516017, 817.9631916563769, 818.893543839303, 851.055328585273, 860.7848037990502, 861.8233262181269, 862.6764963138822, 863.1627321498169, 850.0521918061348, 853.696937587157, 854.179987212277, 854.218390172991, 856.3919617071887, 631.2961048431013, 631.6810010944489, 632.6141053957083, 633.6609913696151, 636.045931103345, 14956.0, 15035.924820375829, 15049.54851354461, 15051.774223386657, 15061.924690376478, 13073.542426015043, 13125.671858203526, 13126.671833204151, 13311.933440332736, 13584.728305433935, 11000.669979900616, 11365.772684546346, 11369.374684392355, 11374.772504549945, 11596.536138554447, 3800.8669696560764, 3803.2773772983046, 3907.0623050467966, 3915.001674572966, 3924.843006279745, 52105.2184217237, 52525.7373713129, 52540.47459525394, 52548.737256313856, 52679.73660131751, 10298.47914440635, 10677.305975111592, 10739.731506712395, 10877.803441621416, 10995.175361847894, 19215.0, 19266.422007339803, 19272.518187045156, 19312.61374772497, 19318.613627727365, 7563.7352692655495, 7739.922600774033, 7790.7756501006115, 7893.842123157505, 7942.205779422012, 4310.137972405531, 4446.644268458515, 4620.353150558924, 4648.279516674853, 4738.218193998021, 3206.23050467886, 3295.7857739246874, 3310.66893310667, 3315.751318651111, 3327.7005069543375, 596.7463827873223, 598.1356939222868, 598.2402349016725, 599.2210126835097, 602.3976023976024, 629.5247088448192, 647.8445173158502, 694.90966174397, 738.6196109003868, 750.7334896111911, 9172.6789562365, 9607.759806004906, 9645.517724113766, 9694.75763105928, 9742.707718768448, 564.2213745031912, 568.903286441306, 578.3435800366614, 610.9327973922865, 643.0643413832862, 4402.471703395613, 4450.599446049806, 4454.554544545585, 4467.530909254481, 4481.417415735934, 59387.0, 59719.0, 60971.390286097456, 61077.38922610717, 63020.68489657522, 48993.0, 49931.99999999927, 50299.74850125799, 50855.23717144246, 50879.23681144786, 51247.0, 52336.21495677568, 52354.738226308626, 52591.474085259426, 53945.0, 9073.591688373906, 9137.451752894847, 9316.627334906529, 9542.761430964281, 9570.760730981781, 37172.0, 37485.0, 40314.395284070175, 40532.1893562133, 40738.59261407348, 51416.22875656943, 51697.48302516927, 51737.741311293204, 52017.47982520126, 52109.0, 11703.648890533297, 11941.0, 11958.940205298917, 11998.220115692453, 12393.256404615751, 13540.661483462993, 13733.244671543162, 13786.931065344608, 13877.514286999907, 13914.234717090658, 12711.491540338282, 12871.678208044874, 13208.603741887759, 13288.468461261828, 13329.533466328632, 12526.749465010467, 12661.74676506483, 12709.237445753284, 12733.681657958625, 13188.868111319147, 11987.34069626144, 12176.147669663038, 12187.18693896981, 12628.684282892633, 12649.747005060031, 10996.0, 11078.889211107786, 11208.327500350006, 11543.711407214887, 11671.941640291745, 10768.246222764332, 10888.45557722095, 10899.618513351994, 10934.289271197666, 11006.174536909604], "unit": "ms", "name": "yui.html", "value": 6776.116268260689}], "name": "dromaeo_css", "value": 7348.176475163233}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 104.0, 112.0, 114.0, 113.0, 122.0, 112.0, 111.0, 112.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 112.6}, {"lowerIsBetter": true, "replicates": [143.0, 130.0, 147.0, 162.0, 125.0, 151.0, 143.0, 124.0, 159.0, 124.0], "unit": "ms", "name": "audio-beat-detection", "value": 140.8}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 163.0, 161.0, 162.0, 164.0, 160.0, 160.0, 162.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 162.1}, {"lowerIsBetter": true, "replicates": [78.0, 71.0, 73.0, 153.0, 72.0, 72.0, 73.0, 73.0, 166.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 90.2}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 133.0, 93.0, 93.0, 94.0, 130.0, 92.0, 93.0, 141.0], "unit": "ms", "name": "audio-oscillator", "value": 105.5}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [149.0, 147.0, 145.0, 147.0, 146.0, 146.0, 149.0, 147.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 95.0, 97.0, 96.0, 96.0, 98.0, 95.0, 97.0, 97.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [62.0, 59.0, 60.0, 59.0, 61.0, 62.0, 61.0, 62.0, 65.0, 60.0], "unit": "ms", "name": "json-parse-financial", "value": 61.1}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 66.0, 63.0, 64.0, 64.0, 63.0, 64.0, 64.0, 63.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.8}, {"lowerIsBetter": true, "replicates": [81.0, 80.0, 89.0, 83.0, 84.0, 88.0, 89.0, 83.0, 87.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.7}, {"lowerIsBetter": true, "replicates": [111.0, 115.0, 116.0, 126.0, 122.0, 121.0, 114.0, 123.0, 128.0, 121.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 119.7}, {"lowerIsBetter": true, "replicates": [155.0, 148.0, 144.0, 145.0, 142.0, 142.0, 144.0, 144.0, 143.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.1}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 65.0, 67.0, 65.0, 72.0, 65.0, 64.0, 67.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1504.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.446637066272], "unit": "score", "name": "Richards", "value": 214.67146200000008}, {"lowerIsBetter": false, "replicates": [167.22408026755852], "unit": "score", "name": "DeltaBlue", "value": 395.38564}, {"lowerIsBetter": false, "replicates": [281.214848143982], "unit": "score", "name": "Encrypt", "value": 946.5396360000002}, {"lowerIsBetter": false, "replicates": [5159.79381443299], "unit": "score", "name": "Decrypt", "value": 51.587526473526495}, {"lowerIsBetter": false, "replicates": [926.7840593141798], "unit": "score", "name": "RayTrace", "value": 798.4481309999998}, {"lowerIsBetter": false, "replicates": [551.2679162072767], "unit": "score", "name": "Earley", "value": 1208.9638819999998}, {"lowerIsBetter": false, "replicates": [11021.739130434782], "unit": "score", "name": "Boyer", "value": 60.468043392504924}, {"lowerIsBetter": false, "replicates": [24512.19512195122], "unit": "score", "name": "RegExp", "value": 37.1645621890547}, {"lowerIsBetter": false, "replicates": [521.1047420531527], "unit": "score", "name": "Splay", "value": 156.38122899999993}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 23184.1242707038}]} 20:07:31 INFO - RETURN: dromaeo_css: 7348.17 20:07:31 INFO - RETURN: kraken: 1504.30 20:07:31 INFO - RETURN: v8_7: 23184.12 20:07:31 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23184.12"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1504.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7348.17"}}} 20:07:31 INFO - Return code: 0 20:07:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:07:31 INFO - # TBPL SUCCESS # 20:07:31 INFO - Running post-action listener: _resource_record_post_action 20:07:31 INFO - Running post-run listener: _resource_record_post_run 20:07:32 INFO - Total resource usage - Wall time: 1222s; CPU: 13.0%; Read bytes: 24576; Write bytes: 503156736; Read time: 232; Write time: 390092 20:07:32 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 237228032; Read time: 0; Write time: 221364 20:07:33 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 24576; Write bytes: 265572352; Read time: 232; Write time: 168708 20:07:33 INFO - Running post-run listener: _upload_blobber_files 20:07:33 INFO - Blob upload gear active. 20:07:33 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 20:07:33 INFO - Copying logs to upload dir... 20:07:33 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1256.062619 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-01-23 20:07:32.468321) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-23 20:07:32.472193) ========= 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=0e2a256762fed810e2f0f810000001b3-1453607194.963659-698467002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/FlIfbGpYSsGQN0TxwWzcLA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010039 build_url: 'https://queue.taskcluster.net/v1/task/FlIfbGpYSsGQN0TxwWzcLA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-23 20:07:32.527731) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 20:07:32.528090) ========= 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=0e2a256762fed810e2f0f810000001b3-1453607194.963659-698467002 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 -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 20:07:32.578745) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-23 20:07:32.579147) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-23 20:07:32.579477) ========= ========= Total master_lag: 0.25 =========