builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-064 starttime: 1454421367.54 results: success (0) buildid: 20160202030232 builduid: 7e5c6b6d188641acb9c3e5be1d487d64 revision: 5f9ba76eb3b1fd9377bbdb4cc2f98a7e75eabdfb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-02 05:56:07.544541) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-02 05:56:07.544999) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-02 05:56:07.545313) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1454420239.319311-1558869167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006331 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-02 05:56:07.568100) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-02 05:56:07.568572) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-02 05:56:07.595791) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 05:56:07.596054) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1454420239.319311-1558869167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004613 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 05:56:07.647976) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-02 05:56:07.648281) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-02 05:56:07.648677) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 05:56:07.648948) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1454420239.319311-1558869167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-02 05:56:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 26.6M=0s 2016-02-02 05:56:08 (26.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.154160 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 05:56:07.816007) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 05:56:07.816339) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1454420239.319311-1558869167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016953 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 05:56:07.865568) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 05:56:07.865894) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5f9ba76eb3b1fd9377bbdb4cc2f98a7e75eabdfb --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 5f9ba76eb3b1fd9377bbdb4cc2f98a7e75eabdfb --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=a12cd81e0ef515edd9e0d800000001bb-1454420239.319311-1558869167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-02 05:56:08,216 truncating revision to first 12 chars 2016-02-02 05:56:08,216 Setting DEBUG logging. 2016-02-02 05:56:08,216 attempt 1/10 2016-02-02 05:56:08,216 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5f9ba76eb3b1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-02 05:56:08,673 unpacking tar archive at: mozilla-central-5f9ba76eb3b1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.738725 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 05:56:08.617282) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-02 05:56:08.617615) ========= echo 5f9ba76eb3b1fd9377bbdb4cc2f98a7e75eabdfb in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5f9ba76eb3b1fd9377bbdb4cc2f98a7e75eabdfb'] 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=a12cd81e0ef515edd9e0d800000001bb-1454420239.319311-1558869167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 5f9ba76eb3b1fd9377bbdb4cc2f98a7e75eabdfb program finished with exit code 0 elapsedTime=0.003665 script_repo_revision: '5f9ba76eb3b1fd9377bbdb4cc2f98a7e75eabdfb' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-02 05:56:08.664591) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-02 05:56:08.664885) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-02 05:56:08.674842) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-02-02 05:56:08.675120) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=a12cd81e0ef515edd9e0d800000001bb-1454420239.319311-1558869167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:56:09 INFO - MultiFileLogger online at 20160202 05:56:09 in /builds/slave/test-pgo 05:56:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:56:09 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:56:09 INFO - {'append_to_log': False, 05:56:09 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:56:09 INFO - 'blob_upload_branch': 'Firefox', 05:56:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:56:09 INFO - 'branch': 'Firefox', 05:56:09 INFO - 'buildbot_json_path': 'buildprops.json', 05:56:09 INFO - 'config_files': ('talos/linux_config.py',), 05:56:09 INFO - 'default_actions': ('clobber', 05:56:09 INFO - 'read-buildbot-config', 05:56:09 INFO - 'download-and-extract', 05:56:09 INFO - 'populate-webroot', 05:56:09 INFO - 'create-virtualenv', 05:56:09 INFO - 'install', 05:56:09 INFO - 'run-tests'), 05:56:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:56:09 INFO - 'download_minidump_stackwalk': True, 05:56:09 INFO - 'download_symbols': 'ondemand', 05:56:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:56:09 INFO - 'tooltool.py': '/tools/tooltool.py', 05:56:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:56:09 INFO - '/tools/misc-python/virtualenv.py')}, 05:56:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:56:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:56:09 INFO - 'installer_path': 'installer.exe', 05:56:09 INFO - 'log_level': 'info', 05:56:09 INFO - 'log_name': 'talos', 05:56:09 INFO - 'log_to_console': True, 05:56:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:56:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:56:09 INFO - 'opt_config_files': (), 05:56:09 INFO - 'pip_index': False, 05:56:09 INFO - 'sps_profile': False, 05:56:09 INFO - 'sps_profile_interval': 0, 05:56:09 INFO - 'suite': 'dromaeojs', 05:56:09 INFO - 'system_bits': '32', 05:56:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:56:09 INFO - 'title': 'talos-linux64-ix-064', 05:56:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:56:09 INFO - 'use_talos_json': True, 05:56:09 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:56:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:56:09 INFO - 'work_dir': 'build'} 05:56:09 INFO - ##### 05:56:09 INFO - ##### Running clobber step. 05:56:09 INFO - ##### 05:56:09 INFO - Running pre-action listener: _resource_record_pre_action 05:56:09 INFO - Running main action method: clobber 05:56:09 INFO - rmtree: /builds/slave/test-pgo/build 05:56:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:56:10 INFO - Running post-action listener: _resource_record_post_action 05:56:10 INFO - ##### 05:56:10 INFO - ##### Running read-buildbot-config step. 05:56:10 INFO - ##### 05:56:10 INFO - Running pre-action listener: _resource_record_pre_action 05:56:10 INFO - Running main action method: read_buildbot_config 05:56:10 INFO - Using buildbot properties: 05:56:10 INFO - { 05:56:10 INFO - "project": "", 05:56:10 INFO - "product": "firefox", 05:56:10 INFO - "script_repo_revision": "production", 05:56:10 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:56:10 INFO - "repository": "", 05:56:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:56:10 INFO - "buildid": "20160202030232", 05:56:10 INFO - "stage_platform": "linux64-pgo", 05:56:10 INFO - "basedir": "/builds/slave/test-pgo", 05:56:10 INFO - "nightly_build": "True", 05:56:10 INFO - "buildnumber": 179, 05:56:10 INFO - "slavename": "talos-linux64-ix-064", 05:56:10 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:56:10 INFO - "platform": "ubuntu64_hw", 05:56:10 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:56:10 INFO - "branch": "mozilla-central", 05:56:10 INFO - "repo_path": "mozilla-central", 05:56:10 INFO - "revision": "5f9ba76eb3b1fd9377bbdb4cc2f98a7e75eabdfb", 05:56:10 INFO - "pgo_build": "True", 05:56:10 INFO - "builduid": "7e5c6b6d188641acb9c3e5be1d487d64", 05:56:10 INFO - "slavebuilddir": "test" 05:56:10 INFO - } 05:56:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/TJRgG50jSA-1gvmJdFd-1g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 05:56:10 INFO - Running post-action listener: _resource_record_post_action 05:56:10 INFO - ##### 05:56:10 INFO - ##### Running download-and-extract step. 05:56:10 INFO - ##### 05:56:10 INFO - Running pre-action listener: _resource_record_pre_action 05:56:10 INFO - Running main action method: download_and_extract 05:56:10 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:56:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:10 INFO - https://queue.taskcluster.net/v1/task/TJRgG50jSA-1gvmJdFd-1g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:56:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJRgG50jSA-1gvmJdFd-1g/artifacts/public/build/test_packages.json 05:56:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJRgG50jSA-1gvmJdFd-1g/artifacts/public/build/test_packages.json 05:56:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJRgG50jSA-1gvmJdFd-1g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:56:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJRgG50jSA-1gvmJdFd-1g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:56:11 INFO - Downloaded 1448 bytes. 05:56:11 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:56:11 INFO - Using the following test package requirements: 05:56:11 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:56:11 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:11 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:56:11 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:11 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:56:11 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:11 INFO - u'jsshell-linux-x86_64.zip'], 05:56:11 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:11 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:56:11 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:56:11 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:11 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:56:11 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:11 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:56:11 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:11 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:56:11 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:56:11 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:11 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:56:11 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:11 INFO - https://queue.taskcluster.net/v1/task/TJRgG50jSA-1gvmJdFd-1g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:56:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJRgG50jSA-1gvmJdFd-1g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:56:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJRgG50jSA-1gvmJdFd-1g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:56:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJRgG50jSA-1gvmJdFd-1g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:56:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJRgG50jSA-1gvmJdFd-1g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:56:12 INFO - Downloaded 22935811 bytes. 05:56:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:56:12 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:56:14 INFO - Return code: 0 05:56:14 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:56:14 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')]} 05:56:14 INFO - https://queue.taskcluster.net/v1/task/TJRgG50jSA-1gvmJdFd-1g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:56:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJRgG50jSA-1gvmJdFd-1g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:56:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJRgG50jSA-1gvmJdFd-1g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:56:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJRgG50jSA-1gvmJdFd-1g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:56:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJRgG50jSA-1gvmJdFd-1g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:56:15 INFO - Downloaded 22935811 bytes. 05:56:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:56:15 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:56:17 INFO - Return code: 0 05:56:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:17 INFO - https://queue.taskcluster.net/v1/task/TJRgG50jSA-1gvmJdFd-1g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:56:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJRgG50jSA-1gvmJdFd-1g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:56:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJRgG50jSA-1gvmJdFd-1g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:56:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJRgG50jSA-1gvmJdFd-1g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:56:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJRgG50jSA-1gvmJdFd-1g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:56:17 INFO - Downloaded 10706582 bytes. 05:56:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:56:17 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 05:56:18 INFO - Return code: 0 05:56:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:18 INFO - https://queue.taskcluster.net/v1/task/TJRgG50jSA-1gvmJdFd-1g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:56:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJRgG50jSA-1gvmJdFd-1g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:56:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJRgG50jSA-1gvmJdFd-1g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:56:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJRgG50jSA-1gvmJdFd-1g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:56:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJRgG50jSA-1gvmJdFd-1g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:56:19 INFO - Downloaded 56069399 bytes. 05:56:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TJRgG50jSA-1gvmJdFd-1g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:56:19 INFO - mkdir: /builds/slave/test-pgo/properties 05:56:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:56:19 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:56:19 INFO - Contents: 05:56:19 INFO - build_url:https://queue.taskcluster.net/v1/task/TJRgG50jSA-1gvmJdFd-1g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:56:19 INFO - Running post-action listener: _resource_record_post_action 05:56:19 INFO - Running post-action listener: set_extra_try_arguments 05:56:19 INFO - ##### 05:56:19 INFO - ##### Running populate-webroot step. 05:56:19 INFO - ##### 05:56:19 INFO - Running pre-action listener: _resource_record_pre_action 05:56:19 INFO - Running main action method: populate_webroot 05:56:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:56:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:56:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:56:19 INFO - '--tppagecycles', 05:56:19 INFO - '7'], 05:56:19 INFO - 'tests': ['tsvgm']}}, 05:56:19 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:56:19 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:56:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:56:19 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:56:19 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:56:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:56:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:56:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:19 INFO - 'talos_options': ['--e10s'], 05:56:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:56:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:19 INFO - 'tests': ['damp', 'tps']}, 05:56:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:19 INFO - 'talos_options': ['--e10s'], 05:56:19 INFO - 'tests': ['damp', 'tps']}, 05:56:19 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:56:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:56:19 INFO - 'other': {'tests': ['a11yr', 05:56:19 INFO - 'ts_paint', 05:56:19 INFO - 'tpaint', 05:56:19 INFO - 'sessionrestore', 05:56:19 INFO - 'sessionrestore_no_auto_restore']}, 05:56:19 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:56:19 INFO - 'tests': ['a11yr', 05:56:19 INFO - 'ts_paint', 05:56:19 INFO - 'tpaint', 05:56:19 INFO - 'sessionrestore', 05:56:19 INFO - 'sessionrestore_no_auto_restore']}, 05:56:19 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:56:19 INFO - 'tests': ['a11yr', 05:56:19 INFO - 'ts_paint', 05:56:19 INFO - 'tpaint', 05:56:19 INFO - 'sessionrestore', 05:56:19 INFO - 'sessionrestore_no_auto_restore']}, 05:56:19 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:56:19 INFO - 'tests': ['a11yr', 05:56:19 INFO - 'ts_paint', 05:56:19 INFO - 'tpaint', 05:56:19 INFO - 'sessionrestore', 05:56:19 INFO - 'sessionrestore_no_auto_restore']}, 05:56:19 INFO - 'other_l64': {'tests': ['a11yr', 05:56:19 INFO - 'ts_paint', 05:56:19 INFO - 'tpaint', 05:56:19 INFO - 'sessionrestore', 05:56:19 INFO - 'sessionrestore_no_auto_restore']}, 05:56:19 INFO - 'other_nol64': {'tests': ['a11yr', 05:56:19 INFO - 'ts_paint', 05:56:19 INFO - 'tpaint', 05:56:19 INFO - 'sessionrestore', 05:56:19 INFO - 'sessionrestore_no_auto_restore']}, 05:56:19 INFO - 'svgr': {'tests': ['tsvgx', 05:56:19 INFO - 'tsvgr_opacity', 05:56:19 INFO - 'tart', 05:56:19 INFO - 'tscrollx', 05:56:19 INFO - 'cart']}, 05:56:19 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:56:19 INFO - 'tests': ['tsvgx', 05:56:19 INFO - 'tsvgr_opacity', 05:56:19 INFO - 'tart', 05:56:19 INFO - 'tscrollx', 05:56:19 INFO - 'cart']}, 05:56:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:19 INFO - 'tests': ['tp5o']}, 05:56:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:19 INFO - 'talos_options': ['--e10s'], 05:56:19 INFO - 'tests': ['tp5o']}, 05:56:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:19 INFO - 'talos_options': ['--xperf_path', 05:56:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:56:19 INFO - 'tests': ['tp5n']}, 05:56:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:19 INFO - 'talos_options': ['--e10s', 05:56:19 INFO - '--xperf_path', 05:56:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:56:19 INFO - 'tests': ['tp5n']}}, 05:56:19 INFO - 'talos.zip': {'path': '', 05:56:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:56:19 INFO - Running post-action listener: _resource_record_post_action 05:56:19 INFO - ##### 05:56:19 INFO - ##### Running create-virtualenv step. 05:56:19 INFO - ##### 05:56:19 INFO - Running pre-action listener: _resource_record_pre_action 05:56:19 INFO - Running main action method: create_virtualenv 05:56:19 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:56:19 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 05:56:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:56:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:56:19 INFO - Using real prefix '/usr' 05:56:19 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:56:20 INFO - Installing distribute.............................................................................................................................................................................................done. 05:56:22 INFO - Installing pip.................done. 05:56:22 INFO - Return code: 0 05:56:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:22 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f25f0bb1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10da480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1169660>, '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 0x116a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116aa10>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1454420239.319311-1558869167', '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 05:56:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:56:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:56:22 INFO - Using env: {'DISPLAY': ':0', 05:56:22 INFO - 'HOME': '/home/cltbld', 05:56:22 INFO - 'LANG': 'en_US.UTF-8', 05:56:22 INFO - 'LANGUAGE': 'en_US:en', 05:56:22 INFO - 'LOGNAME': 'cltbld', 05:56:22 INFO - 'MAIL': '/var/mail/cltbld', 05:56:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:22 INFO - 'MOZ_NO_REMOTE': '1', 05:56:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:22 INFO - 'NO_EM_RESTART': '1', 05:56:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:56:22 INFO - 'PWD': '/builds/slave/test-pgo', 05:56:22 INFO - 'SHELL': '/bin/bash', 05:56:22 INFO - 'SHLVL': '1', 05:56:22 INFO - 'TERM': 'linux', 05:56:22 INFO - 'TMOUT': '86400', 05:56:22 INFO - 'USER': 'cltbld', 05:56:22 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1454420239.319311-1558869167', 05:56:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:22 INFO - '_': '/tools/buildbot/bin/python'} 05:56:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:22 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 05:56:22 INFO - Cleaning up... 05:56:22 INFO - Return code: 0 05:56:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:22 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f25f0bb1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10da480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1169660>, '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 0x116a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116aa10>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1454420239.319311-1558869167', '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 05:56:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:56:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:56:22 INFO - Using env: {'DISPLAY': ':0', 05:56:22 INFO - 'HOME': '/home/cltbld', 05:56:22 INFO - 'LANG': 'en_US.UTF-8', 05:56:22 INFO - 'LANGUAGE': 'en_US:en', 05:56:22 INFO - 'LOGNAME': 'cltbld', 05:56:22 INFO - 'MAIL': '/var/mail/cltbld', 05:56:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:22 INFO - 'MOZ_NO_REMOTE': '1', 05:56:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:22 INFO - 'NO_EM_RESTART': '1', 05:56:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:56:22 INFO - 'PWD': '/builds/slave/test-pgo', 05:56:22 INFO - 'SHELL': '/bin/bash', 05:56:22 INFO - 'SHLVL': '1', 05:56:22 INFO - 'TERM': 'linux', 05:56:22 INFO - 'TMOUT': '86400', 05:56:22 INFO - 'USER': 'cltbld', 05:56:22 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1454420239.319311-1558869167', 05:56:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:22 INFO - '_': '/tools/buildbot/bin/python'} 05:56:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:22 INFO - Downloading/unpacking psutil>=0.7.1 05:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:56:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:56:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:56:24 INFO - Installing collected packages: psutil 05:56:24 INFO - Running setup.py install for psutil 05:56:24 INFO - building 'psutil._psutil_linux' extension 05:56:24 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 05:56:24 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 05:56:25 INFO - building 'psutil._psutil_posix' extension 05:56:25 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 05:56:25 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 05:56:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:56:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:56:25 INFO - Successfully installed psutil 05:56:25 INFO - Cleaning up... 05:56:25 INFO - Return code: 0 05:56:25 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:56:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f25f0bb1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10da480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1169660>, '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 0x116a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116aa10>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1454420239.319311-1558869167', '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 05:56:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:56:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:56:25 INFO - Using env: {'DISPLAY': ':0', 05:56:25 INFO - 'HOME': '/home/cltbld', 05:56:25 INFO - 'LANG': 'en_US.UTF-8', 05:56:25 INFO - 'LANGUAGE': 'en_US:en', 05:56:25 INFO - 'LOGNAME': 'cltbld', 05:56:25 INFO - 'MAIL': '/var/mail/cltbld', 05:56:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:25 INFO - 'MOZ_NO_REMOTE': '1', 05:56:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:25 INFO - 'NO_EM_RESTART': '1', 05:56:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:56:25 INFO - 'PWD': '/builds/slave/test-pgo', 05:56:25 INFO - 'SHELL': '/bin/bash', 05:56:25 INFO - 'SHLVL': '1', 05:56:25 INFO - 'TERM': 'linux', 05:56:25 INFO - 'TMOUT': '86400', 05:56:25 INFO - 'USER': 'cltbld', 05:56:25 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1454420239.319311-1558869167', 05:56:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:25 INFO - '_': '/tools/buildbot/bin/python'} 05:56:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:25 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:56:25 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 05:56:25 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 05:56:25 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 05:56:25 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 05:56:25 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 05:56:25 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 05:56:27 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:56:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:56:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:56:27 INFO - Installing collected packages: mozsystemmonitor 05:56:27 INFO - Running setup.py install for mozsystemmonitor 05:56:27 INFO - Successfully installed mozsystemmonitor 05:56:27 INFO - Cleaning up... 05:56:27 INFO - Return code: 0 05:56:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:27 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 0x7f25f0bb1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10da480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1169660>, '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 0x116a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116aa10>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1454420239.319311-1558869167', '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 05:56:27 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 05:56:27 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 05:56:27 INFO - Using env: {'DISPLAY': ':0', 05:56:27 INFO - 'HOME': '/home/cltbld', 05:56:27 INFO - 'LANG': 'en_US.UTF-8', 05:56:27 INFO - 'LANGUAGE': 'en_US:en', 05:56:27 INFO - 'LOGNAME': 'cltbld', 05:56:27 INFO - 'MAIL': '/var/mail/cltbld', 05:56:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:27 INFO - 'MOZ_NO_REMOTE': '1', 05:56:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:27 INFO - 'NO_EM_RESTART': '1', 05:56:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:56:27 INFO - 'PWD': '/builds/slave/test-pgo', 05:56:27 INFO - 'SHELL': '/bin/bash', 05:56:27 INFO - 'SHLVL': '1', 05:56:27 INFO - 'TERM': 'linux', 05:56:27 INFO - 'TMOUT': '86400', 05:56:27 INFO - 'USER': 'cltbld', 05:56:27 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1454420239.319311-1558869167', 05:56:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:27 INFO - '_': '/tools/buildbot/bin/python'} 05:56:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:27 INFO - Downloading/unpacking blobuploader==1.2.4 05:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:29 INFO - Downloading blobuploader-1.2.4.tar.gz 05:56:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:56:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:56:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:30 INFO - Downloading docopt-0.6.1.tar.gz 05:56:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:56:30 INFO - Installing collected packages: blobuploader, requests, docopt 05:56:30 INFO - Running setup.py install for blobuploader 05:56:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:56:30 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:56:30 INFO - Running setup.py install for requests 05:56:30 INFO - Running setup.py install for docopt 05:56:30 INFO - Successfully installed blobuploader requests docopt 05:56:30 INFO - Cleaning up... 05:56:30 INFO - Return code: 0 05:56:30 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:56:30 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')]} 05:56:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:30 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')]} 05:56:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:30 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 0x7f25f0bb1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10da480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1169660>, '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 0x116a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116aa10>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1454420239.319311-1558869167', '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 05:56:30 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 05:56:30 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 05:56:30 INFO - Using env: {'DISPLAY': ':0', 05:56:30 INFO - 'HOME': '/home/cltbld', 05:56:30 INFO - 'LANG': 'en_US.UTF-8', 05:56:30 INFO - 'LANGUAGE': 'en_US:en', 05:56:30 INFO - 'LOGNAME': 'cltbld', 05:56:30 INFO - 'MAIL': '/var/mail/cltbld', 05:56:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:30 INFO - 'MOZ_NO_REMOTE': '1', 05:56:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:30 INFO - 'NO_EM_RESTART': '1', 05:56:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:56:30 INFO - 'PWD': '/builds/slave/test-pgo', 05:56:30 INFO - 'SHELL': '/bin/bash', 05:56:30 INFO - 'SHLVL': '1', 05:56:30 INFO - 'TERM': 'linux', 05:56:30 INFO - 'TMOUT': '86400', 05:56:30 INFO - 'USER': 'cltbld', 05:56:30 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1454420239.319311-1558869167', 05:56:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:30 INFO - '_': '/tools/buildbot/bin/python'} 05:56:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:56:31 INFO - Running setup.py (path:/tmp/pip-Lylisr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:56:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:56:31 INFO - Running setup.py (path:/tmp/pip-BfQcyW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:56:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:56:31 INFO - Running setup.py (path:/tmp/pip-t7qi2Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:56:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:56:31 INFO - Running setup.py (path:/tmp/pip-GWPPdB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:56:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:56:31 INFO - Running setup.py (path:/tmp/pip-ezUBfr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:56:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:56:31 INFO - Running setup.py (path:/tmp/pip-zhbtW9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:56:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:56:31 INFO - Running setup.py (path:/tmp/pip-eexDnE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:56:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:56:31 INFO - Running setup.py (path:/tmp/pip-bhsygh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:56:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:56:31 INFO - Running setup.py (path:/tmp/pip-02G_Fr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:56:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:56:31 INFO - Running setup.py (path:/tmp/pip-8cMXIz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:56:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:56:31 INFO - Running setup.py (path:/tmp/pip-aIYrHS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:56:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:56:31 INFO - Running setup.py (path:/tmp/pip-FLp73M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:56:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:56:31 INFO - Running setup.py (path:/tmp/pip-KqYw1o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:56:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:56:31 INFO - Running setup.py (path:/tmp/pip-Uf4Lf3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:56:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:56:32 INFO - Running setup.py (path:/tmp/pip-BrbuQH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:56:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:56:32 INFO - Running setup.py (path:/tmp/pip-ob190i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:56:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:56:32 INFO - Running setup.py (path:/tmp/pip-UwLnLJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:56:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:56:32 INFO - Running setup.py install for manifestparser 05:56:32 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:56:32 INFO - Running setup.py install for mozcrash 05:56:32 INFO - Running setup.py install for mozdebug 05:56:32 INFO - Running setup.py install for mozdevice 05:56:32 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:56:32 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:56:32 INFO - Running setup.py install for mozfile 05:56:32 INFO - Running setup.py install for mozhttpd 05:56:32 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:56:32 INFO - Running setup.py install for mozinfo 05:56:32 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:56:32 INFO - Running setup.py install for mozInstall 05:56:33 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:56:33 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:56:33 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:56:33 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:56:33 INFO - Running setup.py install for mozleak 05:56:33 INFO - Running setup.py install for mozlog 05:56:33 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:56:33 INFO - Running setup.py install for moznetwork 05:56:33 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:56:33 INFO - Running setup.py install for mozprocess 05:56:33 INFO - Running setup.py install for mozprofile 05:56:33 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:56:33 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:56:33 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:56:33 INFO - Running setup.py install for mozrunner 05:56:33 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:56:33 INFO - Running setup.py install for mozscreenshot 05:56:33 INFO - Running setup.py install for moztest 05:56:33 INFO - Running setup.py install for mozversion 05:56:34 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:56:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:56:34 INFO - Cleaning up... 05:56:34 INFO - Return code: 0 05:56:34 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:56:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:34 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 0x7f25f0bb1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10da480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1169660>, '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 0x116a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116aa10>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1454420239.319311-1558869167', '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 05:56:34 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 05:56:34 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 05:56:34 INFO - Using env: {'DISPLAY': ':0', 05:56:34 INFO - 'HOME': '/home/cltbld', 05:56:34 INFO - 'LANG': 'en_US.UTF-8', 05:56:34 INFO - 'LANGUAGE': 'en_US:en', 05:56:34 INFO - 'LOGNAME': 'cltbld', 05:56:34 INFO - 'MAIL': '/var/mail/cltbld', 05:56:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:34 INFO - 'MOZ_NO_REMOTE': '1', 05:56:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:34 INFO - 'NO_EM_RESTART': '1', 05:56:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:56:34 INFO - 'PWD': '/builds/slave/test-pgo', 05:56:34 INFO - 'SHELL': '/bin/bash', 05:56:34 INFO - 'SHLVL': '1', 05:56:34 INFO - 'TERM': 'linux', 05:56:34 INFO - 'TMOUT': '86400', 05:56:34 INFO - 'USER': 'cltbld', 05:56:34 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1454420239.319311-1558869167', 05:56:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:34 INFO - '_': '/tools/buildbot/bin/python'} 05:56:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:56:34 INFO - Running setup.py (path:/tmp/pip-faz20H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:56:34 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)) 05:56:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:56:34 INFO - Running setup.py (path:/tmp/pip-HUWmSx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:56:34 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)) 05:56:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:56:34 INFO - Running setup.py (path:/tmp/pip-qu4qIQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:56:34 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)) 05:56:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:56:34 INFO - Running setup.py (path:/tmp/pip-q6qmJB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:56:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 05:56:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:56:34 INFO - Running setup.py (path:/tmp/pip-DYb5Sm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:56:34 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)) 05:56:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:56:34 INFO - Running setup.py (path:/tmp/pip-4wRzbR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:56:34 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)) 05:56:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:56:34 INFO - Running setup.py (path:/tmp/pip-6ZCKfG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:56:34 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)) 05:56:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:56:34 INFO - Running setup.py (path:/tmp/pip-3bP67K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:56:34 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)) 05:56:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:56:34 INFO - Running setup.py (path:/tmp/pip-osxhfj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:56:34 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)) 05:56:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:56:34 INFO - Running setup.py (path:/tmp/pip-a_nk2Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:56:34 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)) 05:56:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:56:34 INFO - Running setup.py (path:/tmp/pip-sOMWab-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:56:35 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)) 05:56:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:56:35 INFO - Running setup.py (path:/tmp/pip-udi9Nw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:56:35 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)) 05:56:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:56:35 INFO - Running setup.py (path:/tmp/pip-8RwWsb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:56:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 05:56:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:56:35 INFO - Running setup.py (path:/tmp/pip-OfBlVg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:56:35 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)) 05:56:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:56:35 INFO - Running setup.py (path:/tmp/pip-OIxeUq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:56:35 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)) 05:56:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:56:35 INFO - Running setup.py (path:/tmp/pip-oDv9H0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:56:35 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)) 05:56:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:56:35 INFO - Running setup.py (path:/tmp/pip-DJfF3q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:56:35 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)) 05:56:35 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)) 05:56:35 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)) 05:56:35 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)) 05:56:35 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:56:35 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:56:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:37 INFO - Downloading blessings-1.6.tar.gz 05:56:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:56:37 INFO - Installing collected packages: blessings 05:56:37 INFO - Running setup.py install for blessings 05:56:37 INFO - Successfully installed blessings 05:56:37 INFO - Cleaning up... 05:56:37 INFO - Return code: 0 05:56:37 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:56:37 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:56:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:56:37 INFO - Reading from file tmpfile_stdout 05:56:37 INFO - Current package versions: 05:56:37 INFO - argparse == 1.2.1 05:56:37 INFO - blessings == 1.6 05:56:37 INFO - blobuploader == 1.2.4 05:56:37 INFO - docopt == 0.6.1 05:56:37 INFO - manifestparser == 1.1 05:56:37 INFO - mozInstall == 1.12 05:56:37 INFO - mozcrash == 0.16 05:56:37 INFO - mozdebug == 0.1 05:56:37 INFO - mozdevice == 0.48 05:56:37 INFO - mozfile == 1.2 05:56:37 INFO - mozhttpd == 0.7 05:56:37 INFO - mozinfo == 0.9 05:56:37 INFO - mozleak == 0.1 05:56:37 INFO - mozlog == 3.1 05:56:37 INFO - moznetwork == 0.27 05:56:37 INFO - mozprocess == 0.22 05:56:37 INFO - mozprofile == 0.28 05:56:37 INFO - mozrunner == 6.11 05:56:37 INFO - mozscreenshot == 0.1 05:56:37 INFO - mozsystemmonitor == 0.0 05:56:37 INFO - moztest == 0.7 05:56:37 INFO - mozversion == 1.4 05:56:37 INFO - psutil == 3.1.1 05:56:37 INFO - requests == 1.2.3 05:56:37 INFO - wsgiref == 0.1.2 05:56:37 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:56:37 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')]} 05:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:37 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')]} 05:56:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:37 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 0x7f25f0bb1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10da480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1169660>, '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 0x116a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116aa10>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1454420239.319311-1558869167', '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 05:56:37 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 05:56:37 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 05:56:37 INFO - Using env: {'DISPLAY': ':0', 05:56:37 INFO - 'HOME': '/home/cltbld', 05:56:37 INFO - 'LANG': 'en_US.UTF-8', 05:56:37 INFO - 'LANGUAGE': 'en_US:en', 05:56:37 INFO - 'LOGNAME': 'cltbld', 05:56:37 INFO - 'MAIL': '/var/mail/cltbld', 05:56:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:37 INFO - 'MOZ_NO_REMOTE': '1', 05:56:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:37 INFO - 'NO_EM_RESTART': '1', 05:56:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:56:37 INFO - 'PWD': '/builds/slave/test-pgo', 05:56:37 INFO - 'SHELL': '/bin/bash', 05:56:37 INFO - 'SHLVL': '1', 05:56:37 INFO - 'TERM': 'linux', 05:56:37 INFO - 'TMOUT': '86400', 05:56:37 INFO - 'USER': 'cltbld', 05:56:37 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1454420239.319311-1558869167', 05:56:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:37 INFO - '_': '/tools/buildbot/bin/python'} 05:56:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.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 1)) 05:56:37 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 2)) 05:56:37 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 3)) 05:56:37 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 4)) 05:56:37 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 5)) 05:56:37 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 6)) 05:56:37 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 7)) 05:56:37 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 8)) 05:56:37 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 9)) 05:56:37 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.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:56:37 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 4)) 05:56:37 INFO - Cleaning up... 05:56:37 INFO - Return code: 0 05:56:37 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:56:37 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')]} 05:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:37 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')]} 05:56:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:37 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 0x7f25f0bb1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10da480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1169660>, '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 0x116a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116aa10>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1454420239.319311-1558869167', '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 05:56:37 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 05:56:37 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 05:56:37 INFO - Using env: {'DISPLAY': ':0', 05:56:37 INFO - 'HOME': '/home/cltbld', 05:56:37 INFO - 'LANG': 'en_US.UTF-8', 05:56:37 INFO - 'LANGUAGE': 'en_US:en', 05:56:37 INFO - 'LOGNAME': 'cltbld', 05:56:37 INFO - 'MAIL': '/var/mail/cltbld', 05:56:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:37 INFO - 'MOZ_NO_REMOTE': '1', 05:56:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:37 INFO - 'NO_EM_RESTART': '1', 05:56:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:56:37 INFO - 'PWD': '/builds/slave/test-pgo', 05:56:37 INFO - 'SHELL': '/bin/bash', 05:56:37 INFO - 'SHLVL': '1', 05:56:37 INFO - 'TERM': 'linux', 05:56:37 INFO - 'TMOUT': '86400', 05:56:37 INFO - 'USER': 'cltbld', 05:56:37 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1454420239.319311-1558869167', 05:56:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:37 INFO - '_': '/tools/buildbot/bin/python'} 05:56:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:38 INFO - Downloading/unpacking jsonschema 05:56:38 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 05:56:38 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 05:56:38 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 05:56:38 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 05:56:38 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 05:56:38 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 05:56:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:56:39 INFO - Downloading/unpacking functools32 (from jsonschema) 05:56:39 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 05:56:39 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 05:56:39 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 05:56:39 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 05:56:39 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 05:56:39 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 05:56:40 INFO - Downloading functools32-3.2.3-2.tar.gz 05:56:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:56:40 INFO - warning: no files found matching '*.txt' 05:56:40 INFO - no previously-included directories found matching 'build' 05:56:40 INFO - no previously-included directories found matching 'dist' 05:56:40 INFO - no previously-included directories found matching '.git*' 05:56:40 INFO - Installing collected packages: jsonschema, functools32 05:56:40 INFO - Running setup.py install for functools32 05:56:40 INFO - warning: no files found matching '*.txt' 05:56:40 INFO - no previously-included directories found matching 'build' 05:56:40 INFO - no previously-included directories found matching 'dist' 05:56:40 INFO - no previously-included directories found matching '.git*' 05:56:40 INFO - Successfully installed jsonschema functools32 05:56:40 INFO - Cleaning up... 05:56:40 INFO - Return code: 0 05:56:40 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:56:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:40 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 0x7f25f0bb1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10da480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1169660>, '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 0x116a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116aa10>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1454420239.319311-1558869167', '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 05:56:40 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 05:56:40 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 05:56:40 INFO - Using env: {'DISPLAY': ':0', 05:56:40 INFO - 'HOME': '/home/cltbld', 05:56:40 INFO - 'LANG': 'en_US.UTF-8', 05:56:40 INFO - 'LANGUAGE': 'en_US:en', 05:56:40 INFO - 'LOGNAME': 'cltbld', 05:56:40 INFO - 'MAIL': '/var/mail/cltbld', 05:56:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:40 INFO - 'MOZ_NO_REMOTE': '1', 05:56:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:40 INFO - 'NO_EM_RESTART': '1', 05:56:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:56:40 INFO - 'PWD': '/builds/slave/test-pgo', 05:56:40 INFO - 'SHELL': '/bin/bash', 05:56:40 INFO - 'SHLVL': '1', 05:56:40 INFO - 'TERM': 'linux', 05:56:40 INFO - 'TMOUT': '86400', 05:56:40 INFO - 'USER': 'cltbld', 05:56:40 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1454420239.319311-1558869167', 05:56:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:40 INFO - '_': '/tools/buildbot/bin/python'} 05:56:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:40 INFO - Downloading/unpacking flake8 05:56:40 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 05:56:40 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 05:56:40 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 05:56:40 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 05:56:40 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 05:56:40 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 05:56:42 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:56:42 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:56:42 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 05:56:42 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 05:56:42 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 05:56:42 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 05:56:42 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 05:56:42 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 05:56:42 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:56:42 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:56:42 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 05:56:42 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 05:56:42 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 05:56:42 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 05:56:42 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 05:56:42 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 05:56:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:56:42 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 05:56:42 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 05:56:42 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 05:56:42 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 05:56:42 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 05:56:42 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 05:56:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:56:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:56:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:56:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:56:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:56:43 INFO - no previously-included directories found matching 'docs/_build' 05:56:43 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:56:43 INFO - Running setup.py install for pep8 05:56:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:56:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:56:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:56:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:56:43 INFO - no previously-included directories found matching 'docs/_build' 05:56:43 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:56:43 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:56:43 INFO - Cleaning up... 05:56:43 INFO - Return code: 0 05:56:43 INFO - Running post-action listener: _resource_record_post_action 05:56:43 INFO - Running post-action listener: _start_resource_monitoring 05:56:43 INFO - Starting resource monitoring. 05:56:43 INFO - ##### 05:56:43 INFO - ##### Running install step. 05:56:43 INFO - ##### 05:56:43 INFO - Running pre-action listener: _resource_record_pre_action 05:56:43 INFO - Running main action method: install 05:56:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:56:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:56:43 INFO - Reading from file tmpfile_stdout 05:56:43 INFO - Detecting whether we're running mozinstall >=1.0... 05:56:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:56:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:56:43 INFO - Reading from file tmpfile_stdout 05:56:43 INFO - Output received: 05:56:43 INFO - Usage: mozinstall [options] installer 05:56:43 INFO - Options: 05:56:43 INFO - -h, --help show this help message and exit 05:56:43 INFO - -d DEST, --destination=DEST 05:56:43 INFO - Directory to install application into. [default: 05:56:43 INFO - "/builds/slave/test-pgo"] 05:56:43 INFO - --app=APP Application being installed. [default: firefox] 05:56:43 INFO - mkdir: /builds/slave/test-pgo/build/application 05:56:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:56:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:56:59 INFO - Reading from file tmpfile_stdout 05:56:59 INFO - Output received: 05:56:59 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:56:59 INFO - Running post-action listener: _resource_record_post_action 05:56:59 INFO - ##### 05:56:59 INFO - ##### Running run-tests step. 05:56:59 INFO - ##### 05:56:59 INFO - Running pre-action listener: _resource_record_pre_action 05:56:59 INFO - Running main action method: run_tests 05:56:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:56:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:56:59 INFO - Python 2.7.3 05:56:59 INFO - Return code: 0 05:56:59 INFO - grabbing minidump binary from tooltool 05:56:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:59 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 0x1169660>, '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 0x116a560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x116aa10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:56:59 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 05:56:59 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 05:56:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:56:59 INFO - Return code: 0 05:56:59 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:56:59 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:56:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:56:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:56:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:56:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:56:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:57:00 INFO - Return code: 0 05:57:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TJRgG50jSA-1gvmJdFd-1g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 05:57:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TJRgG50jSA-1gvmJdFd-1g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 05:57:00 INFO - Using env: {'DISPLAY': ':0', 05:57:00 INFO - 'HOME': '/home/cltbld', 05:57:00 INFO - 'LANG': 'en_US.UTF-8', 05:57:00 INFO - 'LANGUAGE': 'en_US:en', 05:57:00 INFO - 'LOGNAME': 'cltbld', 05:57:00 INFO - 'MAIL': '/var/mail/cltbld', 05:57:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:57:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:00 INFO - 'MOZ_NO_REMOTE': '1', 05:57:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:57:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:00 INFO - 'NO_EM_RESTART': '1', 05:57:00 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:57:00 INFO - 'PWD': '/builds/slave/test-pgo', 05:57:00 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:57:00 INFO - 'SHELL': '/bin/bash', 05:57:00 INFO - 'SHLVL': '1', 05:57:00 INFO - 'TERM': 'linux', 05:57:00 INFO - 'TMOUT': '86400', 05:57:00 INFO - 'USER': 'cltbld', 05:57:00 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1454420239.319311-1558869167', 05:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:00 INFO - '_': '/tools/buildbot/bin/python'} 05:57:00 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TJRgG50jSA-1gvmJdFd-1g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:57:01 INFO - mozversion application_buildid: 20160202030232 05:57:01 INFO - mozversion application_changeset: 5f9ba76eb3b1fd9377bbdb4cc2f98a7e75eabdfb 05:57:01 INFO - mozversion application_display_name: Nightly 05:57:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:57:01 INFO - mozversion application_name: Firefox 05:57:01 INFO - mozversion application_remotingname: firefox 05:57:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:57:01 INFO - mozversion application_vendor: Mozilla 05:57:01 INFO - mozversion application_version: 47.0a1 05:57:01 INFO - mozversion platform_buildid: 20160202030232 05:57:01 INFO - mozversion platform_changeset: 5f9ba76eb3b1fd9377bbdb4cc2f98a7e75eabdfb 05:57:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:57:01 INFO - mozversion platform_version: 47.0a1 05:57:01 INFO - using testdate: 1454421421 05:57:01 INFO - actual date: 1454421421 05:57:01 INFO - starting webserver on 'localhost:42278' 05:57:01 INFO - SUITE-START | Running 2 tests 05:57:01 INFO - TEST-START | dromaeo_css 05:57:01 INFO - operating with platform_type : linux_ 05:57:01 INFO - Initialising browser for dromaeo_css test... 05:57:01 INFO - TEST-INFO | started process 7153 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpY9rbCH/profile http://localhost:42278/getInfo.html) 05:57:01 INFO - PROCESS | 7153 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 05:57:05 INFO - PROCESS | 7153 | __metrics Screen width/height:1600/1200 05:57:05 INFO - PROCESS | 7153 | colorDepth:24 05:57:05 INFO - PROCESS | 7153 | Browser inner width/height: 1024/697 05:57:05 INFO - PROCESS | 7153 | __metrics 05:57:05 INFO - PROCESS | 7153 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:57:05 INFO - PROCESS | 7153 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:57:06 INFO - TEST-INFO | 7153: exit 0 05:57:06 INFO - Browser initialized. 05:57:06 INFO - Running cycle 1/1 for dromaeo_css test... 05:57:06 INFO - TEST-INFO | started process 7250 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpY9rbCH/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:57:18 INFO - PROCESS | 7250 | RSS: Main: 148992000 05:57:18 INFO - PROCESS | 7250 | 05:58:10 INFO - PROCESS | 7250 | 1454421490137 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] 06:00:18 INFO - PROCESS | 7250 | Cycle 1(1): loaded http://localhost:42278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42278/tests/dromaeo/cssquery-ext.html) 06:00:19 INFO - PROCESS | 7250 | RSS: Main: 264978432 06:00:19 INFO - PROCESS | 7250 | 06:03:21 INFO - PROCESS | 7250 | Cycle 1(1): loaded http://localhost:42278/tests/dromaeo/cssquery-ext.html (next: http://localhost:42278/tests/dromaeo/cssquery-jquery.html) 06:03:22 INFO - PROCESS | 7250 | RSS: Main: 234369024 06:03:22 INFO - PROCESS | 7250 | 06:06:24 INFO - PROCESS | 7250 | Cycle 1(1): loaded http://localhost:42278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42278/tests/dromaeo/cssquery-mootools.html) 06:06:24 INFO - PROCESS | 7250 | RSS: Main: 236466176 06:06:24 INFO - PROCESS | 7250 | 06:09:26 INFO - PROCESS | 7250 | Cycle 1(1): loaded http://localhost:42278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42278/tests/dromaeo/cssquery-prototype.html) 06:09:27 INFO - PROCESS | 7250 | RSS: Main: 215511040 06:09:27 INFO - PROCESS | 7250 | 06:12:29 INFO - PROCESS | 7250 | Cycle 1(1): loaded http://localhost:42278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42278/tests/dromaeo/cssquery-yui.html) 06:12:30 INFO - PROCESS | 7250 | RSS: Main: 220483584 06:12:30 INFO - PROCESS | 7250 | 06:15:33 INFO - PROCESS | 7250 | Cycle 1(1): loaded http://localhost:42278/tests/dromaeo/cssquery-yui.html (next: http://localhost:42278/tests/dromaeo/cssquery-dojo.html) 06:15:33 INFO - PROCESS | 7250 | RSS: Main: 285261824 06:15:33 INFO - PROCESS | 7250 | 06:15:33 INFO - PROCESS | 7250 | __start_tp_report 06:15:33 INFO - PROCESS | 7250 | _x_x_mozilla_page_load 06:15:33 INFO - PROCESS | 7250 | _x_x_mozilla_page_load_details 06:15:33 INFO - PROCESS | 7250 | |i|pagename|runs| 06:15:33 INFO - PROCESS | 7250 | |0;dojo.html;3094.9071527854167;3154.747620190385;3206.262559611288;3206.599175103112;3229.3541291741644;5077.771500282487;5134.8973020539615;5135.281060651507;5176.45647207043;5178.042062218492;5157.123289040863;5203.115470370037;5204.089284375229;5207.947920520794;5215.713135777531;4675.88310292242;4698.365720627723;4728.078024785168;4750.619950403977;4770.117528257283;4808;4823.445303790074;4843.07981483517;4864.464908860023;4872.196087645534;4657.4411070671395;4684.063187362507;4737.099951009314;4744.4069491313585;4764.761761911891;4704.411948506437;4721.173794585968;4723.126221648971;4767.070421267854;4771;4688.085823264465;4693.647976401783;4697.201475749131;4703.294505824154;4712.387389639359;4866.31871537985;4910.680805747615;4987.451380348195;4997.750112494361;5043.899122017539;5567.164925261202;5574.275344205227;5576.024195765765;5580.944190558083;5582.7766889324375;5591.077472217079;5595.580331475156;5601.131824567198;5604.355499117612;5608.551315894719;5103.336566246401;5182;5184.377874655028;5229.058769421503;5271.499207575274;5673.801416950387;5676;5678.602497825195;5713.05734553794;5723;5474.124140137559;5482;5487.75305111271;5487.917681234785;5492.093804522209;5494.5054945055135;5571.387147413781;5588.413216612278;5612.298462692163;5664.150377443417;5427.810026649048;5459.863503412446;5461.42655021225;5462.863428414242;5466.945330546723;5435.945640543623;5459.972700136474;5461.371942226615;5477.315335583052;5487.1494918286935;4246.787660616957;4341.066670665822;4358.411614432011;4364.54172311909;4375.978120109443;3871.825767840454;3880.9223815524097;3884.0872394987155;3907.8632247871187;3918.4122381642983;5101.362329708786;5180.378354597472;5191.532762051434;5196.064708352533;5235.240890070994;5416.945830541644;5425.484578964992;5532.363778165482;5538.252335934678;5609.411011843779;5160.50975157367;5163.328767260307;5168.53483186515;5171.793128274827;5176.50823171798;4705.788239529229;4774.641901857374;4783.306420568998;4786.545278198566;4819.204831202883;5721.113227449669;5750.453706897838;5811.593188476851;5811.651300921873;5813.331466881278;5493.09363954943;5494.835154945358;5498;5503.174523821459;5509.779608815603;5724.8282551523525;5728.598998070262;5730.512906402836;5731.856703582277;5733.5126514245085;5277.736113194402;5408.080626293461;5490.670559766427;5514.476124768141;5581.218629391808;5505.559555235652;5515.779368825202;5532.197831314517;5555;5568.972155139199;5330.227117067926;5420.864478388072;5430.972845135749;5431.701256430934;5473.343198816167;5316.8139115132335;5429.728513574227;5473.096939005179;5486.1222204447095;5527.419620939743;5365.704886231295;5378.220158077135;5384.7576859040655;5386.380566234933;5386.784528618811;5362.973185134206;5392.029434701792;5472.26124473207;5472.972635136799;5517.613767036269;5295.311609490742;5328.440513746156;5342.305500284938;5346.331708536433;5383.219433182245 06:15:33 INFO - PROCESS | 7250 | |1;ext.html;528.0521463972169;529.3066083430705;534.8636097795062;552.6628756458559;557.6960556496709;28464.14607561774;28970.275743106435;28978.85510572447;37625.62374376255;38168.236635267276;40421.595784042154;40623.328317243526;40915.79542102293;40975.38536921948;40993.180136397255;8536.402451828359;8769.824603507926;8773.341999350043;8774.64901403943;8778.473291602493;8818.338624603148;8967.41711788735;8976.551172441385;8981.685641002567;8986.505742184178;8926.86609700855;8988.505632190227;9003;9014.54927253638;9017.053209413016;8810.515421651806;8871.157240062184;8882.733517994471;8887.066857979884;8893.244074253631;8827.426217295919;8891.466512009236;8947.150020748019;8962.73111806647;8963.775905602346;38951.805240973896;39341.213175736324;39362.80318598417;39437.21125577501;39447.60552394468;3404.608470025954;3475.131217195701;3575.2670702506184;3938.72428929975;4126.051008268115;27973.720262797317;28105.437891242265;28248.858755706297;28291;29242.561361579592;3912.7456715313697;3973.4635824163656;3992.500937382827;4014.437978682987;4057.736247143926;218631;219552;220400;220554;221268;54138.18792718113;55201.72399137979;62875.91306565059;63670.68164659147;64922.67538662277;57707.71146144242;57821;58215.417845821845;58223.70888145532;58239.12641310384;14428.711425771426;14592.124472531683;14595.197264150362;14622.26888655563;14623.341949612293;10049.145822605014;10395.84406233907;10818.29681070728;10911.454427278604;11231.38227397501;20057.097430615657;20398.592028159354;20448.284310049374;20453.897730511253;20529.612613918835;7862.606869656494;7930.246626570467;7947.721829736047;8082.049437483759;8120.187981201951;924.496149598457;981.1316984468654;988.8714467119229;1063.1601035182275;1090.4275255490932;29195.85402072976;29571.704282956896;29630.703692963227;29998.85000574983;30144.24639384033;1057.4184198690689;1138.3909608359488;1147.936863472517;1179.097990037622;1192.2548407245472;15224.619384515476;15779.816513761514;16772.412965546147;17034.31862725502;17083.829161708472;180227;180775;180842;181286;181885;55472.445275547536;55509.44490555124;55786;55845;56093.15860262099;1376.4287820554557;1393.4565519447424;1399.5241617849777;1403.880670143029;1499.2878382768097;29807.70192298136;30577.847110764305;30613;31259.53110703296;31592.684073158973;46825.297620535035;47442.52557474381;47483;47487.287690685356;47489;284278;288303;394986;397677;407118;32253;32533.349333012735;32538.837305814268;32560.674393255766;32677.18307042343;42566.65250743384;43165.568344316154;43215.78392108019;43433.78283108564;43904.56095439132;36360.63639363572;37100;37178.44232336463;39497.80251098726;40780;30092.69907300899;39182.2163556733;39979.2004159921;40720.1855962885;42328.15343693047;34160.26717862515;34314.313713726086;35056.47415288824;35068.64931350654;35183.64816351804;31207;33781.324373512885;34214.657853421144;34369.82815085909;34415.483767743004;25565.3608659785;25851.22446326613;25982.480350392507;26189;26579.468410631292 06:15:33 INFO - PROCESS | 7250 | |2;jquery.html;365.19474558598284;367.11158995231546;368.7861040596454;369.5417682074229;373.015239767015;16643.25105370258;16983;17272.56818579536;17622.11889405531;17658.20538075788;12806.61580152597;13911.513097041605;16921.038818206827;17328.740068898976;17440.47678569645;5783.392743761908;5882.411758824105;5929.495992840613;5969.283685957669;5979.103134529833;5782.826515204551;6020.969895150518;6025.728842202089;6030.547708921848;6032.487238584726;4337.761423121727;4441.911161776762;6430.7106180222;6670.566413183127;6676.732930682791;6410.230772307353;6604.3725846044545;6618.4705223582;6630.7679231226675;6648.900266496006;6236.345183755686;6254.874902501924;6335.778247761306;6340.587861788969;6343.555951083426;20472.590548189102;20839.270625528185;21293.14827406902;21443.249486267905;21627.35117946464;2337.39227800773;2385.0817435287368;2403.399150212447;2669.42607339421;2897.768178545711;12948.352582370939;13087.738245235041;13213.73572528544;13350.599482015556;13976.930115349358;1921.5868588253452;2014.4661664658877;2033.918643254268;2063.0406860809644;2103.0220947259445;52192;57917.420825791625;62906.370936290965;63357.30433524098;65539;9740.707778766648;10134.23993200513;10472.842907356397;10481.423521706227;10541.736456588647;13637.454501819817;13760.380782864795;13763.31183440824;13792.103513271606;13801.861981380258;7355.521891077063;7381.852362952711;7406.14829294638;7406.777796666109;7413.592252426169;7081.114860642419;7084.256153103953;7106.395956343666;7115;7156.964215178891;4488.618467430305;4528.184926713223;4541.250693635579;4545.0909818036525;4583.518730533313;1587.952361429159;1669.7495375693743;1800.5948661551047;1871.2036445012668;2789.511835428792;438.14780252409395;889.0886840988039;921.3872774604947;940.7648087978006;1003.4781913404988;10074.74813129663;10389.804798211715;10500.369977801356;10642.840357394645;11012.284201526874;884.5577211394303;901.7204666553389;922.3359181389388;942.7548837302213;986.9358491698017;8749.56252187388;9005.14451127142;9017.594208260643;9161.816763664823;9184.173424391704;558058;558774;560159;571967;575578;47578.76210618925;72527.27472725311;72939.27060729325;74250.62874685592;74750;1156.8264760286024;1167.8890505401973;1175.3476820364608;1192.1893112683458;1197;15320;15346.23268836576;15524.456644017406;15667.336552785826;15716.528504144893;34802.477962831086;34822;34969;35421;35824.82087589546;47575.52424475711;47796.761016194694;48078;48433;48614.27078593753;7315.63421828917;7323.816904577428;7472.103347598323;7540.8491830164185;7565.167831538636;9441.386309889835;11493.655190344303;11635.825462617899;12024.699382515157;12029.278243305429;7699.6535155917;9350.083232937368;9594;10365.06714395708;10420.374777513374;10034.849477257701;10115.342502737298;10132.696019119438;10222.1822254218;10424.374537527772;8040.67837286502;9985.252580798477;10040.096391324816;10114.443705595968;10494.632687855888;7378.114626244885;7428.892122632876;7814.726484573012;7816.648250828613;7870.898074269492;7871.409644276588;9702.951485242529;9861.211103111591;10410.635627752992;10454.32046916948 06:15:33 INFO - PROCESS | 7250 | |3;mootools.html;1202.3327053485311;1492.3284521965115;1506.3522685245343;1696.4825728152916;1853.4995551201175;7030.929690703091;7739.806504837382;7895.013123359573;7897.92102078979;7905.209479052106;7319.963400182992;7437.25627437256;7459.627018649073;7472.17806041335;7489.737859174917;2008.337248707923;2053.260826102602;2278.100150440579;2289.8969546370454;2307.3424074138875;2324.6280595104786;2333.4866329407587;2335.8948847301913;2336.836421450499;2340.391498210469;2261.807746341563;2312.5490529346785;2315.340128063502;2322.581935251654;2327.464683122883;2241.742199647037;2279.464325883416;2355.9057637694473;2361.3506285771464;2363.291012696184;2305.7117860267467;2323.779240972105;2339.2865176121277;2342.8711420871846;2347.319277409549;7907.169747176521;8023.879641805319;8027.15714849944;8027.478213916135;8032.678692852279;4784.880377990578;4888.144574699413;4888.315635810989;4901.338319326881;4929.309896614477;3093.056617731591;3152.274976755336;3171.1913462067255;3219.4687876500348;3234.433974054531;985;1009.0766948242349;1019.1235537437798;1054.1408751867205;1061.8329495084595;10877.619283325046;10877.891221087846;10889.83665245022;10890;10912.181586381133;4386.627136693353;4454.064646424223;4502.594766471033;4506.526814684476;4526;9381.249500040118;9421.811563768822;9423.481708506099;9424.151826335663;9437;4920.630952678492;4924.8768780780765;4929.75351232437;4930.359053323045;4930.482299358588;4460.598546130864;4469.374287599739;4482.5069242383315;4488.955110448919;4499.617532509707;3435.553378060836;3476.982615086959;3728.4593733908973;3767.3030489359558;3810.8285127169343;1228;1231.6982339326921;1233.0690328801877;1248.887600115994;1258.314218750783;1289.4262053386153;1304.693397051692;1310.7902735562454;1341.2354957674227;1343.6775173958374;7326.047613810277;7395.408367330709;7397.075365579302;7404.2595740426605;7434.702611895572;1129.5030186717818;1135.625243669587;1142.4002398740727;1142.6343570057502;1170.744344308428;5799.391063938226;5823.2429784128635;5869.64782113066;5872.647641141545;5885.676287804212;9069.274458043341;9330.580123894306;9332.440053596805;9399.342046056847;9411;9201.769955751026;9231.399959002778;9328.860067098998;9330.626774928927;9336.673216437392;7404.592747398945;7465.738699145504;7498.400127989857;7547.207543207994;7591.62041897914;7162.856742865218;7246.239144889711;7248.492605517563;7256.4194864411775;7313.414926805949;8174.918250817415;8409.915900841159;8552.273056789994;8700.651973920973;8713.956430218062;8660.78348041304;8727.083656216006;8741.08218637034;8866.379353445196;8876.423032502867;6559.212894452697;7515.736949206752;7681.347085497795;7699.114601820862;7708.075030996092;6939.236683964659;7377.151627562899;7524.736634217995;7527.962360188164;7548.4716069874585;7000.299970002959;7099.82250443743;7154.177269613853;7192.100987376578;7304.269573042653;6925.3074692530345;6962.443004559522;6985.9301406987315;7121.287871212838;7159.8926016110845;6881.690323935335;7044.682989265393;7058.082449281561;7121.252268511939;7122.109736282965;6491.221053473425;6514.902276465762;6541.967290163519;6548.508861835287;6563.245226798979;6536.542442029012;6572.901406478811;6640.767573134917;6645.269020407848;6645.734170633121 06:15:33 INFO - PROCESS | 7250 | |4;prototype.html;342.2726705750281;345.4076259215445;347.6558207374698;353.3657085531472;354.07409623833684;5647;5737.971310143454;5772.971135144324;5781.82654520365;5853.414658534155;5560.165975103737;5615.606907516475;5670.177824215486;5709.400512946143;5726.141078838176;4448.799804008811;4458.3535387368975;4460.50934397216;4462.3752674625575;4475.597196252336;4315.913681726363;4399.780010999453;4412.889677758049;4482.753448560328;4496.078303947683;4421.734695918239;4437.64498840092;4445.066536027438;4464.709793863405;4479.552044795527;4467.687261891669;4471.418715566955;4472.440944881906;4485.820567177309;4487.057717879249;3940.2119576084897;3968.980155099206;3971.7616942983514;3974.7813870237123;3981.442598036277;5380.166074258496;5540.529055030327;5552.444755524456;5556.249906262643;5560.582956278255;5154.30416893722;5159.380874295071;5170.353705786777;5170.689758614458;5185.766640501149;5863.355030946593;6202.782902598433;6206.410391012847;6212.596181248205;6215.502759779252;4161.791910404498;4196.769177695225;4302.505211900609;4303.376010478463;4330.112326972963;6358.904616430757;6420.93579064208;6430.421262086435;6481.967590162019;6498.967505162491;4346.087321662486;4365.345198220292;4370.431843860341;4372.191144638252;4372.781360931941;4323.0705398339505;4419.558044195554;4429.313456414261;4436.755978421218;4492.303692927601;5143.742812859342;5143.8456846294675;5144.819931302462;5146.022255771391;5148.2277658350795;6200.038993955944;6202.100695399232;6204.038374052029;6211.0372892201785;6211.3167551569295;1547.922603869802;1580.399448209673;1580.5100418870188;1580.8814338924626;1581.1382796376004;1057.8466122412208;1059.9788004239872;1071.223363061774;1078.5092782783815;1089.2974031749636;5874.471297583153;5907.793227237026;5911.408859114054;5911.822645320647;5924.7926322578505;6362.1093046973465;6410.102585638015;6413.422791948747;6421.678916054178;6431.356864313531;5919.112133180058;5919.1713160157615;5921.348651648315;5921.496672782861;5923.970380148072;3369.25876307212;3468.3756923753967;3472.5138480612736;3481.7736847104857;3482.0598438421484;6648.634325112165;6678.432333251728;6690.464762818963;6694.230163531159;6695.832604184934;6583.144191255106;6583.374579414948;6586.045023471665;6588.703508342136;6590.209174899042;6545.770898018642;6667.099941507834;6668.866622667617;6670.266270710218;6675.933240667531;6149.831532008904;6324.083007963912;6419;6451.322611125952;6498.642574658439;6218.689065546795;6289.056641503811;6342.682865856596;6365.14070600463;6387.137736405526;6614.669266536558;6669.2997235289595;6670.799876003728;6676.198856137295;6677.866442671217;4363.934540981824;4411.779411029372;4440.6012106186445;4448;4448.7108337957925;6450.0969864218105;6459.192600924885;6465.482761379172;6473.708683109366;6474.902876456951;6282.183316168869;6282.403171698681;6284.4344009039405;6290.2766181889665;6301.96849015752;6148.538859585459;6266.874662506633;6268.435840774352;6268.52986026059;6281.466075383643;6145.907811382922;6162.198914141133;6168.228971378578;6172.876542469216;6178.135061091541;6253.968730156502;6274.466670333073;6277.466415354564;6279.843003924939;6286.088517165077;6040.546958978006;6129.172561704113;6156.107364432221;6156.538259630456;6158.630482171084 06:15:33 INFO - PROCESS | 7250 | |5;yui.html;703.9436845052393;713.4149997002457;719.8884172953187;816.249895004175;821.9753407397778;13180.604581862548;13452.125611835236;13466.25935573543;13467.865321346784;13472.797908031363;13332.733345333087;13368.131071480348;13391.933040334809;13393.397297121628;13413.865861341385;667.3793372163885;678.1082876018045;814.1329484099444;831.0816547714763;844.7930257087022;832.134580036761;833.8582440985047;846.834867200896;849.5285116760195;853.4026181672854;508.8727818045489;870.6996086350231;889.2041622747637;892.4957399069505;892.6161750447305;507.2568686873729;864.2912811494577;883.4169448164245;884.9336299777478;885.3802338363172;653.993460065398;655.4134050025249;655.6525041727892;655.8688262347549;656.2059907511916;13348.065635405526;13366.799498007538;13417.127886687334;13441.126326788728;13453.461861525528;12766.61700148997;13155.605331839964;13213.933930330382;13258.46966121354;13320.400581973834;10654.147668186604;10718.517666705016;10734.409607471585;10915.781684366348;10947.34315941046;3622.5652921649307;3701.759385639925;3706.0734816295926;3710.9814450927843;3776.4146557283666;49225.26162107571;49307.26039109416;49329.753351233376;49427;49438.50561494411;10249.739337669549;10448.477576121164;10518.947405262925;10583.682489525327;10606.522706478227;18932.242710291433;18939.810601893805;18946;18951.715724264148;18975.810241897405;7594.81012974669;7599.202083781123;7628.923710762932;7728.244123055491;7750.0458890823265;4185.142045880587;4318.892027699269;4357.782110894443;4403.119376124788;4404.185225733249;3207.8075315481146;3234.4178047951123;3243.043302225849;3265.6571060038355;3288.2108294009267;587.49475451112;609.2171559545963;612.1093808508609;617.0774691835734;620.4292051312804;674.5345711459078;677.1738479055545;700.6461736822872;703.1702590942634;709.6983781892675;7961.203879611992;8273.359840954274;8401.747947561584;8492.490450572985;8544.31645468361;573.8339654111182;683.0539702512057;692.1102411462998;698.9196242432083;709.7351343603706;4006.539247986519;4074.3888416737727;4078.7960601969785;4194.832206711697;4276.273033584298;53583.46416535863;53898;54608;55025.44974550203;55242.72378638161;47777.28334074992;49212.75393623009;49625.255621165714;49828.25257621139;49855.50144498581;44382;44760.77619611881;44890.77554612206;44900;45615.77192114085;8218.301444377295;8378.664853405795;8391.454555453876;8452.408331416742;8630.482171069756;33245.667543324256;33478.83260583682;33504.664953350155;34334.48498272478;34551.481727774604;38586.80706596449;38717.225655487295;42117.36823947582;42458;42771.14457710766;10800.675979720621;10898.346099234072;11481.311121332747;11545.422728863692;11571.363575003455;12396.31820249895;12443.875561244271;12447.253164810141;13014.674633134247;13139.671508212372;10801.135909127408;10896.237263391486;11160.10719142483;11257.268277561932;11316.37759923212;11078.446077696244;11389.259698119597;12216.267023978235;12371;12754;8116.75649730509;10425.687229383131;10827.51276192589;10867.184961128105;11141.83287250708;8675.392722509363;9102.453852768855;9130.634774609207;9196.58615362297;9585;8742.519161446182;8791.692290769792;8796.692115775917;8819.823603528022;9080.772980675536 06:15:33 INFO - PROCESS | 7250 | __end_tp_report 06:15:33 INFO - PROCESS | 7250 | __start_cc_report 06:15:33 INFO - PROCESS | 7250 | _x_x_mozilla_cycle_collect,909 06:15:33 INFO - PROCESS | 7250 | __end_cc_report 06:15:33 INFO - PROCESS | 7250 | __startTimestamp1454422533452__endTimestamp 06:15:33 INFO - PROCESS | 7250 | 06:15:33 INFO - PROCESS | 7250 | ------- Summary: start ------- 06:15:33 INFO - PROCESS | 7250 | Number of tests: 6 06:15:33 INFO - PROCESS | 7250 | 06:15:33 INFO - PROCESS | 7250 | [#0] dojo.html Cycles:165 Average:5155.71 Median:5362.97 stddev:550.35 (10.3%) stddev-sans-first:527.76 06:15:33 INFO - PROCESS | 7250 | Values: 3094.9 3154.7 3206.3 3206.6 3229.4 5077.8 5134.9 5135.3 5176.5 5178.0 5157.1 5203.1 5204.1 5207.9 5215.7 4675.9 4698.4 4728.1 4750.6 4770.1 4808.0 4823.4 4843.1 4864.5 4872.2 4657.4 4684.1 4737.1 4744.4 4764.8 4704.4 4721.2 4723.1 4767.1 4771.0 4688.1 4693.6 4697.2 4703.3 4712.4 4866.3 4910.7 4987.5 4997.8 5043.9 5567.2 5574.3 5576.0 5580.9 5582.8 5591.1 5595.6 5601.1 5604.4 5608.6 5103.3 5182.0 5184.4 5229.1 5271.5 5673.8 5676.0 5678.6 5713.1 5723.0 5474.1 5482.0 5487.8 5487.9 5492.1 5494.5 5571.4 5588.4 5612.3 5664.2 5427.8 5459.9 5461.4 5462.9 5466.9 5435.9 5460.0 5461.4 5477.3 5487.1 4246.8 4341.1 4358.4 4364.5 4376.0 3871.8 3880.9 3884.1 3907.9 3918.4 5101.4 5180.4 5191.5 5196.1 5235.2 5416.9 5425.5 5532.4 5538.3 5609.4 5160.5 5163.3 5168.5 5171.8 5176.5 4705.8 4774.6 4783.3 4786.5 4819.2 5721.1 5750.5 5811.6 5811.7 5813.3 5493.1 5494.8 5498.0 5503.2 5509.8 5724.8 5728.6 5730.5 5731.9 5733.5 5277.7 5408.1 5490.7 5514.5 5581.2 5505.6 5515.8 5532.2 5555.0 5569.0 5330.2 5420.9 5431.0 5431.7 5473.3 5316.8 5429.7 5473.1 5486.1 5527.4 5365.7 5378.2 5384.8 5386.4 5386.8 5363.0 5392.0 5472.3 5473.0 5517.6 5295.3 5328.4 5342.3 5346.3 5383.2 06:15:33 INFO - PROCESS | 7250 | 06:15:33 INFO - PROCESS | 7250 | [#1] ext.html Cycles:180 Average:43091.24 Median:38560.02 stddev:69475.52 (180.2%) stddev-sans-first:69596.92 06:15:33 INFO - PROCESS | 7250 | Values: 528.1 529.3 534.9 552.7 557.7 28464.1 28970.3 28978.9 37625.6 38168.2 40421.6 40623.3 40915.8 40975.4 40993.2 8536.4 8769.8 8773.3 8774.6 8778.5 8818.3 8967.4 8976.6 8981.7 8986.5 8926.9 8988.5 9003.0 9014.5 9017.1 8810.5 8871.2 8882.7 8887.1 8893.2 8827.4 8891.5 8947.2 8962.7 8963.8 38951.8 39341.2 39362.8 39437.2 39447.6 3404.6 3475.1 3575.3 3938.7 4126.1 27973.7 28105.4 28248.9 28291.0 29242.6 3912.7 3973.5 3992.5 4014.4 4057.7 218631.0 219552.0 220400.0 220554.0 221268.0 54138.2 55201.7 62875.9 63670.7 64922.7 57707.7 57821.0 58215.4 58223.7 58239.1 14428.7 14592.1 14595.2 14622.3 14623.3 10049.1 10395.8 10818.3 10911.5 11231.4 20057.1 20398.6 20448.3 20453.9 20529.6 7862.6 7930.2 7947.7 8082.0 8120.2 924.5 981.1 988.9 1063.2 1090.4 29195.9 29571.7 29630.7 29998.9 30144.2 1057.4 1138.4 1147.9 1179.1 1192.3 15224.6 15779.8 16772.4 17034.3 17083.8 180227.0 180775.0 180842.0 181286.0 181885.0 55472.4 55509.4 55786.0 55845.0 56093.2 1376.4 1393.5 1399.5 1403.9 1499.3 29807.7 30577.8 30613.0 31259.5 31592.7 46825.3 47442.5 47483.0 47487.3 47489.0 284278.0 288303.0 394986.0 397677.0 407118.0 32253.0 32533.3 32538.8 32560.7 32677.2 42566.7 43165.6 43215.8 43433.8 43904.6 36360.6 37100.0 37178.4 39497.8 40780.0 30092.7 39182.2 39979.2 40720.2 42328.2 34160.3 34314.3 35056.5 35068.6 35183.6 31207.0 33781.3 34214.7 34369.8 34415.5 25565.4 25851.2 25982.5 26189.0 26579.5 06:15:33 INFO - PROCESS | 7250 | 06:15:33 INFO - PROCESS | 7250 | [#2] jquery.html Cycles:180 Average:28562.89 Median:4534.72 stddev:92251.56 (2034.3%) stddev-sans-first:92486.05 06:15:33 INFO - PROCESS | 7250 | Values: 365.2 367.1 368.8 369.5 373.0 16643.3 16983.0 17272.6 17622.1 17658.2 12806.6 13911.5 16921.0 17328.7 17440.5 5783.4 5882.4 5929.5 5969.3 5979.1 5782.8 6021.0 6025.7 6030.5 6032.5 4337.8 4441.9 6430.7 6670.6 6676.7 6410.2 6604.4 6618.5 6630.8 6648.9 6236.3 6254.9 6335.8 6340.6 6343.6 20472.6 20839.3 21293.1 21443.2 21627.4 2337.4 2385.1 2403.4 2669.4 2897.8 12948.4 13087.7 13213.7 13350.6 13976.9 1921.6 2014.5 2033.9 2063.0 2103.0 52192.0 57917.4 62906.4 63357.3 65539.0 9740.7 10134.2 10472.8 10481.4 10541.7 13637.5 13760.4 13763.3 13792.1 13801.9 7355.5 7381.9 7406.1 7406.8 7413.6 7081.1 7084.3 7106.4 7115.0 7157.0 4488.6 4528.2 4541.3 4545.1 4583.5 1588.0 1669.7 1800.6 1871.2 2789.5 438.1 889.1 921.4 940.8 1003.5 10074.7 10389.8 10500.4 10642.8 11012.3 884.6 901.7 922.3 942.8 986.9 8749.6 9005.1 9017.6 9161.8 9184.2 558058.0 558774.0 560159.0 571967.0 575578.0 47578.8 72527.3 72939.3 74250.6 74750.0 1156.8 1167.9 1175.3 1192.2 1197.0 15320.0 15346.2 15524.5 15667.3 15716.5 34802.5 34822.0 34969.0 35421.0 35824.8 47575.5 47796.8 48078.0 48433.0 48614.3 7315.6 7323.8 7472.1 7540.8 7565.2 9441.4 11493.7 11635.8 12024.7 12029.3 7699.7 9350.1 9594.0 10365.1 10420.4 10034.8 10115.3 10132.7 10222.2 10424.4 8040.7 9985.3 10040.1 10114.4 10494.6 7378.1 7428.9 7814.7 7816.6 7870.9 7871.4 9703.0 9861.2 10410.6 10454.3 06:15:33 INFO - PROCESS | 7250 | 06:15:33 INFO - PROCESS | 7250 | [#3] mootools.html Cycles:180 Average:5550.83 Median:6525.72 stddev:2842.86 (43.6%) stddev-sans-first:2832.04 06:15:33 INFO - PROCESS | 7250 | Values: 1202.3 1492.3 1506.4 1696.5 1853.5 7030.9 7739.8 7895.0 7897.9 7905.2 7320.0 7437.3 7459.6 7472.2 7489.7 2008.3 2053.3 2278.1 2289.9 2307.3 2324.6 2333.5 2335.9 2336.8 2340.4 2261.8 2312.5 2315.3 2322.6 2327.5 2241.7 2279.5 2355.9 2361.4 2363.3 2305.7 2323.8 2339.3 2342.9 2347.3 7907.2 8023.9 8027.2 8027.5 8032.7 4784.9 4888.1 4888.3 4901.3 4929.3 3093.1 3152.3 3171.2 3219.5 3234.4 985.0 1009.1 1019.1 1054.1 1061.8 10877.6 10877.9 10889.8 10890.0 10912.2 4386.6 4454.1 4502.6 4506.5 4526.0 9381.2 9421.8 9423.5 9424.2 9437.0 4920.6 4924.9 4929.8 4930.4 4930.5 4460.6 4469.4 4482.5 4489.0 4499.6 3435.6 3477.0 3728.5 3767.3 3810.8 1228.0 1231.7 1233.1 1248.9 1258.3 1289.4 1304.7 1310.8 1341.2 1343.7 7326.0 7395.4 7397.1 7404.3 7434.7 1129.5 1135.6 1142.4 1142.6 1170.7 5799.4 5823.2 5869.6 5872.6 5885.7 9069.3 9330.6 9332.4 9399.3 9411.0 9201.8 9231.4 9328.9 9330.6 9336.7 7404.6 7465.7 7498.4 7547.2 7591.6 7162.9 7246.2 7248.5 7256.4 7313.4 8174.9 8409.9 8552.3 8700.7 8714.0 8660.8 8727.1 8741.1 8866.4 8876.4 6559.2 7515.7 7681.3 7699.1 7708.1 6939.2 7377.2 7524.7 7528.0 7548.5 7000.3 7099.8 7154.2 7192.1 7304.3 6925.3 6962.4 6985.9 7121.3 7159.9 6881.7 7044.7 7058.1 7121.3 7122.1 6491.2 6514.9 6542.0 6548.5 6563.2 6536.5 6572.9 6640.8 6645.3 6645.7 06:15:33 INFO - PROCESS | 7250 | 06:15:33 INFO - PROCESS | 7250 | [#4] prototype.html Cycles:180 Average:5188.61 Median:5868.91 stddev:1565.36 (26.7%) stddev-sans-first:1526.90 06:15:33 INFO - PROCESS | 7250 | Values: 342.3 345.4 347.7 353.4 354.1 5647.0 5738.0 5773.0 5781.8 5853.4 5560.2 5615.6 5670.2 5709.4 5726.1 4448.8 4458.4 4460.5 4462.4 4475.6 4315.9 4399.8 4412.9 4482.8 4496.1 4421.7 4437.6 4445.1 4464.7 4479.6 4467.7 4471.4 4472.4 4485.8 4487.1 3940.2 3969.0 3971.8 3974.8 3981.4 5380.2 5540.5 5552.4 5556.2 5560.6 5154.3 5159.4 5170.4 5170.7 5185.8 5863.4 6202.8 6206.4 6212.6 6215.5 4161.8 4196.8 4302.5 4303.4 4330.1 6358.9 6420.9 6430.4 6482.0 6499.0 4346.1 4365.3 4370.4 4372.2 4372.8 4323.1 4419.6 4429.3 4436.8 4492.3 5143.7 5143.8 5144.8 5146.0 5148.2 6200.0 6202.1 6204.0 6211.0 6211.3 1547.9 1580.4 1580.5 1580.9 1581.1 1057.8 1060.0 1071.2 1078.5 1089.3 5874.5 5907.8 5911.4 5911.8 5924.8 6362.1 6410.1 6413.4 6421.7 6431.4 5919.1 5919.2 5921.3 5921.5 5924.0 3369.3 3468.4 3472.5 3481.8 3482.1 6648.6 6678.4 6690.5 6694.2 6695.8 6583.1 6583.4 6586.0 6588.7 6590.2 6545.8 6667.1 6668.9 6670.3 6675.9 6149.8 6324.1 6419.0 6451.3 6498.6 6218.7 6289.1 6342.7 6365.1 6387.1 6614.7 6669.3 6670.8 6676.2 6677.9 4363.9 4411.8 4440.6 4448.0 4448.7 6450.1 6459.2 6465.5 6473.7 6474.9 6282.2 6282.4 6284.4 6290.3 6302.0 6148.5 6266.9 6268.4 6268.5 6281.5 6145.9 6162.2 6168.2 6172.9 6178.1 6254.0 6274.5 6277.5 6279.8 6286.1 6040.5 6129.2 6156.1 6156.5 6158.6 06:15:33 INFO - PROCESS | 7250 | 06:15:33 INFO - PROCESS | 7250 | [#5] yui.html Cycles:180 Average:13555.21 Median:44825.78 stddev:15353.29 (34.3%) stddev-sans-first:15366.03 06:15:33 INFO - PROCESS | 7250 | Values: 703.9 713.4 719.9 816.2 822.0 13180.6 13452.1 13466.3 13467.9 13472.8 13332.7 13368.1 13391.9 13393.4 13413.9 667.4 678.1 814.1 831.1 844.8 832.1 833.9 846.8 849.5 853.4 508.9 870.7 889.2 892.5 892.6 507.3 864.3 883.4 884.9 885.4 654.0 655.4 655.7 655.9 656.2 13348.1 13366.8 13417.1 13441.1 13453.5 12766.6 13155.6 13213.9 13258.5 13320.4 10654.1 10718.5 10734.4 10915.8 10947.3 3622.6 3701.8 3706.1 3711.0 3776.4 49225.3 49307.3 49329.8 49427.0 49438.5 10249.7 10448.5 10518.9 10583.7 10606.5 18932.2 18939.8 18946.0 18951.7 18975.8 7594.8 7599.2 7628.9 7728.2 7750.0 4185.1 4318.9 4357.8 4403.1 4404.2 3207.8 3234.4 3243.0 3265.7 3288.2 587.5 609.2 612.1 617.1 620.4 674.5 677.2 700.6 703.2 709.7 7961.2 8273.4 8401.7 8492.5 8544.3 573.8 683.1 692.1 698.9 709.7 4006.5 4074.4 4078.8 4194.8 4276.3 53583.5 53898.0 54608.0 55025.4 55242.7 47777.3 49212.8 49625.3 49828.3 49855.5 44382.0 44760.8 44890.8 44900.0 45615.8 8218.3 8378.7 8391.5 8452.4 8630.5 33245.7 33478.8 33504.7 34334.5 34551.5 38586.8 38717.2 42117.4 42458.0 42771.1 10800.7 10898.3 11481.3 11545.4 11571.4 12396.3 12443.9 12447.3 13014.7 13139.7 10801.1 10896.2 11160.1 11257.3 11316.4 11078.4 11389.3 12216.3 12371.0 12754.0 8116.8 10425.7 10827.5 10867.2 11141.8 8675.4 9102.5 9130.6 9196.6 9585.0 8742.5 8791.7 8796.7 8819.8 9080.8 06:15:33 INFO - PROCESS | 7250 | -------- Summary: end -------- 06:15:33 INFO - PROCESS | 7250 | 06:15:33 INFO - TEST-INFO | 7250: exit 0 06:15:33 INFO - TEST-OK | dromaeo_css | took 1112823ms 06:15:33 INFO - TEST-START | kraken 06:15:33 INFO - operating with platform_type : linux_ 06:15:33 INFO - Initialising browser for kraken test... 06:15:34 INFO - TEST-INFO | started process 7434 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjBH2ff/profile http://localhost:42278/getInfo.html) 06:15:34 INFO - PROCESS | 7434 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 06:15:37 INFO - PROCESS | 7434 | __metrics Screen width/height:1600/1200 06:15:37 INFO - PROCESS | 7434 | colorDepth:24 06:15:37 INFO - PROCESS | 7434 | Browser inner width/height: 1024/697 06:15:37 INFO - PROCESS | 7434 | __metrics 06:15:38 INFO - PROCESS | 7434 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:15:38 INFO - PROCESS | 7434 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:15:39 INFO - TEST-INFO | 7434: exit 0 06:15:39 INFO - Browser initialized. 06:15:39 INFO - Running cycle 1/1 for kraken test... 06:15:39 INFO - TEST-INFO | started process 7518 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjBH2ff/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:15:51 INFO - PROCESS | 7518 | RSS: Main: 149860352 06:15:51 INFO - PROCESS | 7518 | 06:15:53 INFO - PROCESS | 7518 | Cycle 1(1): loaded http://localhost:42278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42278/tests/kraken/driver.html?testName=audio-beat-detection) 06:15:54 INFO - PROCESS | 7518 | RSS: Main: 189423616 06:15:54 INFO - PROCESS | 7518 | 06:15:56 INFO - PROCESS | 7518 | Cycle 1(1): loaded http://localhost:42278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42278/tests/kraken/driver.html?testName=audio-dft) 06:15:57 INFO - PROCESS | 7518 | RSS: Main: 180097024 06:15:57 INFO - PROCESS | 7518 | 06:16:00 INFO - PROCESS | 7518 | Cycle 1(1): loaded http://localhost:42278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42278/tests/kraken/driver.html?testName=audio-fft) 06:16:00 INFO - PROCESS | 7518 | RSS: Main: 164257792 06:16:00 INFO - PROCESS | 7518 | 06:16:02 INFO - PROCESS | 7518 | Cycle 1(1): loaded http://localhost:42278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42278/tests/kraken/driver.html?testName=audio-oscillator) 06:16:03 INFO - PROCESS | 7518 | RSS: Main: 167096320 06:16:03 INFO - PROCESS | 7518 | 06:16:05 INFO - PROCESS | 7518 | Cycle 1(1): loaded http://localhost:42278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:16:06 INFO - PROCESS | 7518 | RSS: Main: 168284160 06:16:06 INFO - PROCESS | 7518 | 06:16:09 INFO - PROCESS | 7518 | Cycle 1(1): loaded http://localhost:42278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42278/tests/kraken/driver.html?testName=imaging-darkroom) 06:16:09 INFO - PROCESS | 7518 | RSS: Main: 167862272 06:16:09 INFO - PROCESS | 7518 | 06:16:13 INFO - PROCESS | 7518 | Cycle 1(1): loaded http://localhost:42278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42278/tests/kraken/driver.html?testName=imaging-desaturate) 06:16:13 INFO - PROCESS | 7518 | RSS: Main: 168316928 06:16:13 INFO - PROCESS | 7518 | 06:16:16 INFO - PROCESS | 7518 | Cycle 1(1): loaded http://localhost:42278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42278/tests/kraken/driver.html?testName=json-parse-financial) 06:16:17 INFO - PROCESS | 7518 | RSS: Main: 170049536 06:16:17 INFO - PROCESS | 7518 | 06:16:18 INFO - PROCESS | 7518 | Cycle 1(1): loaded http://localhost:42278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:16:19 INFO - PROCESS | 7518 | RSS: Main: 177872896 06:16:19 INFO - PROCESS | 7518 | 06:16:21 INFO - PROCESS | 7518 | Cycle 1(1): loaded http://localhost:42278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42278/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:16:21 INFO - PROCESS | 7518 | RSS: Main: 176193536 06:16:21 INFO - PROCESS | 7518 | 06:16:23 INFO - PROCESS | 7518 | Cycle 1(1): loaded http://localhost:42278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:16:24 INFO - PROCESS | 7518 | RSS: Main: 192753664 06:16:24 INFO - PROCESS | 7518 | 06:16:26 INFO - PROCESS | 7518 | Cycle 1(1): loaded http://localhost:42278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:16:27 INFO - PROCESS | 7518 | RSS: Main: 197332992 06:16:27 INFO - PROCESS | 7518 | 06:16:29 INFO - PROCESS | 7518 | Cycle 1(1): loaded http://localhost:42278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:16:30 INFO - PROCESS | 7518 | RSS: Main: 194363392 06:16:30 INFO - PROCESS | 7518 | 06:16:32 INFO - PROCESS | 7518 | Cycle 1(1): loaded http://localhost:42278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42278/tests/kraken/driver.html?testName=ai-astar) 06:16:32 INFO - PROCESS | 7518 | RSS: Main: 255504384 06:16:32 INFO - PROCESS | 7518 | 06:16:32 INFO - PROCESS | 7518 | __start_tp_report 06:16:32 INFO - PROCESS | 7518 | _x_x_mozilla_page_load 06:16:32 INFO - PROCESS | 7518 | _x_x_mozilla_page_load_details 06:16:32 INFO - PROCESS | 7518 | |i|pagename|runs| 06:16:32 INFO - PROCESS | 7518 | |0;ai-astar;109;110;105;109;110;110;98;110;108;109 06:16:32 INFO - PROCESS | 7518 | |1;audio-beat-detection;152;127;162;178;127;154;149;127;172;127 06:16:32 INFO - PROCESS | 7518 | |2;audio-dft;161;161;161;160;161;160;162;163;161;162 06:16:32 INFO - PROCESS | 7518 | |3;audio-fft;74;81;93;93;73;73;72;129;95;73 06:16:32 INFO - PROCESS | 7518 | |4;audio-oscillator;95;95;139;95;95;95;138;95;96;145 06:16:32 INFO - PROCESS | 7518 | |5;imaging-gaussian-blur;119;116;115;115;115;115;115;116;115;115 06:16:32 INFO - PROCESS | 7518 | |6;imaging-darkroom;147;145;146;145;145;145;145;145;146;145 06:16:32 INFO - PROCESS | 7518 | |7;imaging-desaturate;96;96;96;96;97;97;96;97;96;96 06:16:32 INFO - PROCESS | 7518 | |8;json-parse-financial;59;57;58;58;58;58;57;65;56;55 06:16:32 INFO - PROCESS | 7518 | |9;json-stringify-tinderbox;67;68;67;68;68;68;68;68;69;68 06:16:32 INFO - PROCESS | 7518 | |10;stanford-crypto-aes;81;85;83;82;83;83;92;83;82;90 06:16:32 INFO - PROCESS | 7518 | |11;stanford-crypto-ccm;118;116;116;116;136;118;114;117;121;117 06:16:32 INFO - PROCESS | 7518 | |12;stanford-crypto-pbkdf2;146;142;166;143;153;141;155;152;150;150 06:16:32 INFO - PROCESS | 7518 | |13;stanford-crypto-sha256-iterative;67;68;71;67;67;67;66;66;68;66 06:16:32 INFO - PROCESS | 7518 | __end_tp_report 06:16:32 INFO - PROCESS | 7518 | __start_cc_report 06:16:32 INFO - PROCESS | 7518 | _x_x_mozilla_cycle_collect,967 06:16:32 INFO - PROCESS | 7518 | __end_cc_report 06:16:32 INFO - PROCESS | 7518 | __startTimestamp1454422592452__endTimestamp 06:16:32 INFO - PROCESS | 7518 | 06:16:32 INFO - PROCESS | 7518 | ------- Summary: start ------- 06:16:32 INFO - PROCESS | 7518 | Number of tests: 14 06:16:32 INFO - PROCESS | 7518 | 06:16:32 INFO - PROCESS | 7518 | [#0] ai-astar Cycles:10 Average:107.80 Median:110.00 stddev:3.77 (3.4%) stddev-sans-first:3.97 06:16:32 INFO - PROCESS | 7518 | Values: 109.0 110.0 105.0 109.0 110.0 110.0 98.0 110.0 108.0 109.0 06:16:32 INFO - PROCESS | 7518 | 06:16:32 INFO - PROCESS | 7518 | [#1] audio-beat-detection Cycles:10 Average:147.50 Median:153.00 stddev:19.68 (12.9%) stddev-sans-first:20.81 06:16:32 INFO - PROCESS | 7518 | Values: 152.0 127.0 162.0 178.0 127.0 154.0 149.0 127.0 172.0 127.0 06:16:32 INFO - PROCESS | 7518 | 06:16:32 INFO - PROCESS | 7518 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 06:16:32 INFO - PROCESS | 7518 | Values: 161.0 161.0 161.0 160.0 161.0 160.0 162.0 163.0 161.0 162.0 06:16:32 INFO - PROCESS | 7518 | 06:16:32 INFO - PROCESS | 7518 | [#3] audio-fft Cycles:10 Average:85.60 Median:77.50 stddev:17.95 (23.2%) stddev-sans-first:18.54 06:16:32 INFO - PROCESS | 7518 | Values: 74.0 81.0 93.0 93.0 73.0 73.0 72.0 129.0 95.0 73.0 06:16:32 INFO - PROCESS | 7518 | 06:16:32 INFO - PROCESS | 7518 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:95.00 stddev:22.06 (23.2%) stddev-sans-first:22.83 06:16:32 INFO - PROCESS | 7518 | Values: 95.0 95.0 139.0 95.0 95.0 95.0 138.0 95.0 96.0 145.0 06:16:32 INFO - PROCESS | 7518 | 06:16:32 INFO - PROCESS | 7518 | [#5] imaging-gaussian-blur Cycles:10 Average:115.60 Median:115.00 stddev:1.26 (1.1%) stddev-sans-first:0.44 06:16:32 INFO - PROCESS | 7518 | Values: 119.0 116.0 115.0 115.0 115.0 115.0 115.0 116.0 115.0 115.0 06:16:32 INFO - PROCESS | 7518 | 06:16:32 INFO - PROCESS | 7518 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.44 06:16:32 INFO - PROCESS | 7518 | Values: 147.0 145.0 146.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 06:16:32 INFO - PROCESS | 7518 | 06:16:32 INFO - PROCESS | 7518 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 06:16:32 INFO - PROCESS | 7518 | Values: 96.0 96.0 96.0 96.0 97.0 97.0 96.0 97.0 96.0 96.0 06:16:32 INFO - PROCESS | 7518 | 06:16:32 INFO - PROCESS | 7518 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:58.00 stddev:2.69 (4.6%) stddev-sans-first:2.83 06:16:32 INFO - PROCESS | 7518 | Values: 59.0 57.0 58.0 58.0 58.0 58.0 57.0 65.0 56.0 55.0 06:16:32 INFO - PROCESS | 7518 | 06:16:32 INFO - PROCESS | 7518 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.50 06:16:32 INFO - PROCESS | 7518 | Values: 67.0 68.0 67.0 68.0 68.0 68.0 68.0 68.0 69.0 68.0 06:16:32 INFO - PROCESS | 7518 | 06:16:32 INFO - PROCESS | 7518 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:83.00 stddev:3.66 (4.4%) stddev-sans-first:3.67 06:16:32 INFO - PROCESS | 7518 | Values: 81.0 85.0 83.0 82.0 83.0 83.0 92.0 83.0 82.0 90.0 06:16:32 INFO - PROCESS | 7518 | 06:16:32 INFO - PROCESS | 7518 | [#11] stanford-crypto-ccm Cycles:10 Average:118.90 Median:117.50 stddev:6.28 (5.3%) stddev-sans-first:6.65 06:16:32 INFO - PROCESS | 7518 | Values: 118.0 116.0 116.0 116.0 136.0 118.0 114.0 117.0 121.0 117.0 06:16:32 INFO - PROCESS | 7518 | 06:16:32 INFO - PROCESS | 7518 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.80 Median:151.00 stddev:7.48 (5.0%) stddev-sans-first:7.81 06:16:32 INFO - PROCESS | 7518 | Values: 146.0 142.0 166.0 143.0 153.0 141.0 155.0 152.0 150.0 150.0 06:16:32 INFO - PROCESS | 7518 | 06:16:32 INFO - PROCESS | 7518 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:1.49 (2.2%) stddev-sans-first:1.58 06:16:32 INFO - PROCESS | 7518 | Values: 67.0 68.0 71.0 67.0 67.0 67.0 66.0 66.0 68.0 66.0 06:16:32 INFO - PROCESS | 7518 | -------- Summary: end -------- 06:16:32 INFO - PROCESS | 7518 | 06:16:33 INFO - TEST-INFO | 7518: exit 0 06:16:33 INFO - TEST-OK | kraken | took 59385ms 06:16:33 INFO - SUITE-END | took 1172s 06:16:33 INFO - Completed test suite (00:19:32) 06:16:33 INFO - Working with test: dromaeo_css 06:16:33 INFO - Generating results file: dromaeo_css 06:16:33 INFO - Working with test: kraken 06:16:33 INFO - Generating results file: kraken 06:16:33 INFO - javascript benchmark 06:16:33 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:16:33 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 06:16:33 INFO - process_Request line: dromaeo_css 6900.51 graph.html#tests=[[72,1,35]] 06:16:33 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:16:33 INFO - process_Request line: kraken 1514.60 graph.html#tests=[[232,1,35]] 06:16:33 INFO - RETURN: dromaeo_css: 6900.51 06:16:33 INFO - RETURN: kraken: 1514.60 06:16:33 INFO - javascript benchmark 06:16:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3094.9071527854167, 3154.747620190385, 3206.262559611288, 3206.599175103112, 3229.3541291741644, 5077.771500282487, 5134.8973020539615, 5135.281060651507, 5176.45647207043, 5178.042062218492, 5157.123289040863, 5203.115470370037, 5204.089284375229, 5207.947920520794, 5215.713135777531, 4675.88310292242, 4698.365720627723, 4728.078024785168, 4750.619950403977, 4770.117528257283, 4808.0, 4823.445303790074, 4843.07981483517, 4864.464908860023, 4872.196087645534, 4657.4411070671395, 4684.063187362507, 4737.099951009314, 4744.4069491313585, 4764.761761911891, 4704.411948506437, 4721.173794585968, 4723.126221648971, 4767.070421267854, 4771.0, 4688.085823264465, 4693.647976401783, 4697.201475749131, 4703.294505824154, 4712.387389639359, 4866.31871537985, 4910.680805747615, 4987.451380348195, 4997.750112494361, 5043.899122017539, 5567.164925261202, 5574.275344205227, 5576.024195765765, 5580.944190558083, 5582.7766889324375, 5591.077472217079, 5595.580331475156, 5601.131824567198, 5604.355499117612, 5608.551315894719, 5103.336566246401, 5182.0, 5184.377874655028, 5229.058769421503, 5271.499207575274, 5673.801416950387, 5676.0, 5678.602497825195, 5713.05734553794, 5723.0, 5474.124140137559, 5482.0, 5487.75305111271, 5487.917681234785, 5492.093804522209, 5494.5054945055135, 5571.387147413781, 5588.413216612278, 5612.298462692163, 5664.150377443417, 5427.810026649048, 5459.863503412446, 5461.42655021225, 5462.863428414242, 5466.945330546723, 5435.945640543623, 5459.972700136474, 5461.371942226615, 5477.315335583052, 5487.1494918286935, 4246.787660616957, 4341.066670665822, 4358.411614432011, 4364.54172311909, 4375.978120109443, 3871.825767840454, 3880.9223815524097, 3884.0872394987155, 3907.8632247871187, 3918.4122381642983, 5101.362329708786, 5180.378354597472, 5191.532762051434, 5196.064708352533, 5235.240890070994, 5416.945830541644, 5425.484578964992, 5532.363778165482, 5538.252335934678, 5609.411011843779, 5160.50975157367, 5163.328767260307, 5168.53483186515, 5171.793128274827, 5176.50823171798, 4705.788239529229, 4774.641901857374, 4783.306420568998, 4786.545278198566, 4819.204831202883, 5721.113227449669, 5750.453706897838, 5811.593188476851, 5811.651300921873, 5813.331466881278, 5493.09363954943, 5494.835154945358, 5498.0, 5503.174523821459, 5509.779608815603, 5724.8282551523525, 5728.598998070262, 5730.512906402836, 5731.856703582277, 5733.5126514245085, 5277.736113194402, 5408.080626293461, 5490.670559766427, 5514.476124768141, 5581.218629391808, 5505.559555235652, 5515.779368825202, 5532.197831314517, 5555.0, 5568.972155139199, 5330.227117067926, 5420.864478388072, 5430.972845135749, 5431.701256430934, 5473.343198816167, 5316.8139115132335, 5429.728513574227, 5473.096939005179, 5486.1222204447095, 5527.419620939743, 5365.704886231295, 5378.220158077135, 5384.7576859040655, 5386.380566234933, 5386.784528618811, 5362.973185134206, 5392.029434701792, 5472.26124473207, 5472.972635136799, 5517.613767036269, 5295.311609490742, 5328.440513746156, 5342.305500284938, 5346.331708536433, 5383.219433182245], "unit": "score", "name": "dojo.html", "value": 5121.699277255702}, {"lowerIsBetter": false, "replicates": [528.0521463972169, 529.3066083430705, 534.8636097795062, 552.6628756458559, 557.6960556496709, 28464.14607561774, 28970.275743106435, 28978.85510572447, 37625.62374376255, 38168.236635267276, 40421.595784042154, 40623.328317243526, 40915.79542102293, 40975.38536921948, 40993.180136397255, 8536.402451828359, 8769.824603507926, 8773.341999350043, 8774.64901403943, 8778.473291602493, 8818.338624603148, 8967.41711788735, 8976.551172441385, 8981.685641002567, 8986.505742184178, 8926.86609700855, 8988.505632190227, 9003.0, 9014.54927253638, 9017.053209413016, 8810.515421651806, 8871.157240062184, 8882.733517994471, 8887.066857979884, 8893.244074253631, 8827.426217295919, 8891.466512009236, 8947.150020748019, 8962.73111806647, 8963.775905602346, 38951.805240973896, 39341.213175736324, 39362.80318598417, 39437.21125577501, 39447.60552394468, 3404.608470025954, 3475.131217195701, 3575.2670702506184, 3938.72428929975, 4126.051008268115, 27973.720262797317, 28105.437891242265, 28248.858755706297, 28291.0, 29242.561361579592, 3912.7456715313697, 3973.4635824163656, 3992.500937382827, 4014.437978682987, 4057.736247143926, 218631.0, 219552.0, 220400.0, 220554.0, 221268.0, 54138.18792718113, 55201.72399137979, 62875.91306565059, 63670.68164659147, 64922.67538662277, 57707.71146144242, 57821.0, 58215.417845821845, 58223.70888145532, 58239.12641310384, 14428.711425771426, 14592.124472531683, 14595.197264150362, 14622.26888655563, 14623.341949612293, 10049.145822605014, 10395.84406233907, 10818.29681070728, 10911.454427278604, 11231.38227397501, 20057.097430615657, 20398.592028159354, 20448.284310049374, 20453.897730511253, 20529.612613918835, 7862.606869656494, 7930.246626570467, 7947.721829736047, 8082.049437483759, 8120.187981201951, 924.496149598457, 981.1316984468654, 988.8714467119229, 1063.1601035182275, 1090.4275255490932, 29195.85402072976, 29571.704282956896, 29630.703692963227, 29998.85000574983, 30144.24639384033, 1057.4184198690689, 1138.3909608359488, 1147.936863472517, 1179.097990037622, 1192.2548407245472, 15224.619384515476, 15779.816513761514, 16772.412965546147, 17034.31862725502, 17083.829161708472, 180227.0, 180775.0, 180842.0, 181286.0, 181885.0, 55472.445275547536, 55509.44490555124, 55786.0, 55845.0, 56093.15860262099, 1376.4287820554557, 1393.4565519447424, 1399.5241617849777, 1403.880670143029, 1499.2878382768097, 29807.70192298136, 30577.847110764305, 30613.0, 31259.53110703296, 31592.684073158973, 46825.297620535035, 47442.52557474381, 47483.0, 47487.287690685356, 47489.0, 284278.0, 288303.0, 394986.0, 397677.0, 407118.0, 32253.0, 32533.349333012735, 32538.837305814268, 32560.674393255766, 32677.18307042343, 42566.65250743384, 43165.568344316154, 43215.78392108019, 43433.78283108564, 43904.56095439132, 36360.63639363572, 37100.0, 37178.44232336463, 39497.80251098726, 40780.0, 30092.69907300899, 39182.2163556733, 39979.2004159921, 40720.1855962885, 42328.15343693047, 34160.26717862515, 34314.313713726086, 35056.47415288824, 35068.64931350654, 35183.64816351804, 31207.0, 33781.324373512885, 34214.657853421144, 34369.82815085909, 34415.483767743004, 25565.3608659785, 25851.22446326613, 25982.480350392507, 26189.0, 26579.468410631292], "unit": "score", "name": "ext.html", "value": 18386.416788375223}, {"lowerIsBetter": false, "replicates": [365.19474558598284, 367.11158995231546, 368.7861040596454, 369.5417682074229, 373.015239767015, 16643.25105370258, 16983.0, 17272.56818579536, 17622.11889405531, 17658.20538075788, 12806.61580152597, 13911.513097041605, 16921.038818206827, 17328.740068898976, 17440.47678569645, 5783.392743761908, 5882.411758824105, 5929.495992840613, 5969.283685957669, 5979.103134529833, 5782.826515204551, 6020.969895150518, 6025.728842202089, 6030.547708921848, 6032.487238584726, 4337.761423121727, 4441.911161776762, 6430.7106180222, 6670.566413183127, 6676.732930682791, 6410.230772307353, 6604.3725846044545, 6618.4705223582, 6630.7679231226675, 6648.900266496006, 6236.345183755686, 6254.874902501924, 6335.778247761306, 6340.587861788969, 6343.555951083426, 20472.590548189102, 20839.270625528185, 21293.14827406902, 21443.249486267905, 21627.35117946464, 2337.39227800773, 2385.0817435287368, 2403.399150212447, 2669.42607339421, 2897.768178545711, 12948.352582370939, 13087.738245235041, 13213.73572528544, 13350.599482015556, 13976.930115349358, 1921.5868588253452, 2014.4661664658877, 2033.918643254268, 2063.0406860809644, 2103.0220947259445, 52192.0, 57917.420825791625, 62906.370936290965, 63357.30433524098, 65539.0, 9740.707778766648, 10134.23993200513, 10472.842907356397, 10481.423521706227, 10541.736456588647, 13637.454501819817, 13760.380782864795, 13763.31183440824, 13792.103513271606, 13801.861981380258, 7355.521891077063, 7381.852362952711, 7406.14829294638, 7406.777796666109, 7413.592252426169, 7081.114860642419, 7084.256153103953, 7106.395956343666, 7115.0, 7156.964215178891, 4488.618467430305, 4528.184926713223, 4541.250693635579, 4545.0909818036525, 4583.518730533313, 1587.952361429159, 1669.7495375693743, 1800.5948661551047, 1871.2036445012668, 2789.511835428792, 438.14780252409395, 889.0886840988039, 921.3872774604947, 940.7648087978006, 1003.4781913404988, 10074.74813129663, 10389.804798211715, 10500.369977801356, 10642.840357394645, 11012.284201526874, 884.5577211394303, 901.7204666553389, 922.3359181389388, 942.7548837302213, 986.9358491698017, 8749.56252187388, 9005.14451127142, 9017.594208260643, 9161.816763664823, 9184.173424391704, 558058.0, 558774.0, 560159.0, 571967.0, 575578.0, 47578.76210618925, 72527.27472725311, 72939.27060729325, 74250.62874685592, 74750.0, 1156.8264760286024, 1167.8890505401973, 1175.3476820364608, 1192.1893112683458, 1197.0, 15320.0, 15346.23268836576, 15524.456644017406, 15667.336552785826, 15716.528504144893, 34802.477962831086, 34822.0, 34969.0, 35421.0, 35824.82087589546, 47575.52424475711, 47796.761016194694, 48078.0, 48433.0, 48614.27078593753, 7315.63421828917, 7323.816904577428, 7472.103347598323, 7540.8491830164185, 7565.167831538636, 9441.386309889835, 11493.655190344303, 11635.825462617899, 12024.699382515157, 12029.278243305429, 7699.6535155917, 9350.083232937368, 9594.0, 10365.06714395708, 10420.374777513374, 10034.849477257701, 10115.342502737298, 10132.696019119438, 10222.1822254218, 10424.374537527772, 8040.67837286502, 9985.252580798477, 10040.096391324816, 10114.443705595968, 10494.632687855888, 7378.114626244885, 7428.892122632876, 7814.726484573012, 7816.648250828613, 7870.898074269492, 7871.409644276588, 9702.951485242529, 9861.211103111591, 10410.635627752992, 10454.32046916948], "unit": "score", "name": "jquery.html", "value": 8465.745602128956}, {"lowerIsBetter": false, "replicates": [1202.3327053485311, 1492.3284521965115, 1506.3522685245343, 1696.4825728152916, 1853.4995551201175, 7030.929690703091, 7739.806504837382, 7895.013123359573, 7897.92102078979, 7905.209479052106, 7319.963400182992, 7437.25627437256, 7459.627018649073, 7472.17806041335, 7489.737859174917, 2008.337248707923, 2053.260826102602, 2278.100150440579, 2289.8969546370454, 2307.3424074138875, 2324.6280595104786, 2333.4866329407587, 2335.8948847301913, 2336.836421450499, 2340.391498210469, 2261.807746341563, 2312.5490529346785, 2315.340128063502, 2322.581935251654, 2327.464683122883, 2241.742199647037, 2279.464325883416, 2355.9057637694473, 2361.3506285771464, 2363.291012696184, 2305.7117860267467, 2323.779240972105, 2339.2865176121277, 2342.8711420871846, 2347.319277409549, 7907.169747176521, 8023.879641805319, 8027.15714849944, 8027.478213916135, 8032.678692852279, 4784.880377990578, 4888.144574699413, 4888.315635810989, 4901.338319326881, 4929.309896614477, 3093.056617731591, 3152.274976755336, 3171.1913462067255, 3219.4687876500348, 3234.433974054531, 985.0, 1009.0766948242349, 1019.1235537437798, 1054.1408751867205, 1061.8329495084595, 10877.619283325046, 10877.891221087846, 10889.83665245022, 10890.0, 10912.181586381133, 4386.627136693353, 4454.064646424223, 4502.594766471033, 4506.526814684476, 4526.0, 9381.249500040118, 9421.811563768822, 9423.481708506099, 9424.151826335663, 9437.0, 4920.630952678492, 4924.8768780780765, 4929.75351232437, 4930.359053323045, 4930.482299358588, 4460.598546130864, 4469.374287599739, 4482.5069242383315, 4488.955110448919, 4499.617532509707, 3435.553378060836, 3476.982615086959, 3728.4593733908973, 3767.3030489359558, 3810.8285127169343, 1228.0, 1231.6982339326921, 1233.0690328801877, 1248.887600115994, 1258.314218750783, 1289.4262053386153, 1304.693397051692, 1310.7902735562454, 1341.2354957674227, 1343.6775173958374, 7326.047613810277, 7395.408367330709, 7397.075365579302, 7404.2595740426605, 7434.702611895572, 1129.5030186717818, 1135.625243669587, 1142.4002398740727, 1142.6343570057502, 1170.744344308428, 5799.391063938226, 5823.2429784128635, 5869.64782113066, 5872.647641141545, 5885.676287804212, 9069.274458043341, 9330.580123894306, 9332.440053596805, 9399.342046056847, 9411.0, 9201.769955751026, 9231.399959002778, 9328.860067098998, 9330.626774928927, 9336.673216437392, 7404.592747398945, 7465.738699145504, 7498.400127989857, 7547.207543207994, 7591.62041897914, 7162.856742865218, 7246.239144889711, 7248.492605517563, 7256.4194864411775, 7313.414926805949, 8174.918250817415, 8409.915900841159, 8552.273056789994, 8700.651973920973, 8713.956430218062, 8660.78348041304, 8727.083656216006, 8741.08218637034, 8866.379353445196, 8876.423032502867, 6559.212894452697, 7515.736949206752, 7681.347085497795, 7699.114601820862, 7708.075030996092, 6939.236683964659, 7377.151627562899, 7524.736634217995, 7527.962360188164, 7548.4716069874585, 7000.299970002959, 7099.82250443743, 7154.177269613853, 7192.100987376578, 7304.269573042653, 6925.3074692530345, 6962.443004559522, 6985.9301406987315, 7121.287871212838, 7159.8926016110845, 6881.690323935335, 7044.682989265393, 7058.082449281561, 7121.252268511939, 7122.109736282965, 6491.221053473425, 6514.902276465762, 6541.967290163519, 6548.508861835287, 6563.245226798979, 6536.542442029012, 6572.901406478811, 6640.767573134917, 6645.269020407848, 6645.734170633121], "unit": "score", "name": "mootools.html", "value": 4583.03345674994}, {"lowerIsBetter": false, "replicates": [342.2726705750281, 345.4076259215445, 347.6558207374698, 353.3657085531472, 354.07409623833684, 5647.0, 5737.971310143454, 5772.971135144324, 5781.82654520365, 5853.414658534155, 5560.165975103737, 5615.606907516475, 5670.177824215486, 5709.400512946143, 5726.141078838176, 4448.799804008811, 4458.3535387368975, 4460.50934397216, 4462.3752674625575, 4475.597196252336, 4315.913681726363, 4399.780010999453, 4412.889677758049, 4482.753448560328, 4496.078303947683, 4421.734695918239, 4437.64498840092, 4445.066536027438, 4464.709793863405, 4479.552044795527, 4467.687261891669, 4471.418715566955, 4472.440944881906, 4485.820567177309, 4487.057717879249, 3940.2119576084897, 3968.980155099206, 3971.7616942983514, 3974.7813870237123, 3981.442598036277, 5380.166074258496, 5540.529055030327, 5552.444755524456, 5556.249906262643, 5560.582956278255, 5154.30416893722, 5159.380874295071, 5170.353705786777, 5170.689758614458, 5185.766640501149, 5863.355030946593, 6202.782902598433, 6206.410391012847, 6212.596181248205, 6215.502759779252, 4161.791910404498, 4196.769177695225, 4302.505211900609, 4303.376010478463, 4330.112326972963, 6358.904616430757, 6420.93579064208, 6430.421262086435, 6481.967590162019, 6498.967505162491, 4346.087321662486, 4365.345198220292, 4370.431843860341, 4372.191144638252, 4372.781360931941, 4323.0705398339505, 4419.558044195554, 4429.313456414261, 4436.755978421218, 4492.303692927601, 5143.742812859342, 5143.8456846294675, 5144.819931302462, 5146.022255771391, 5148.2277658350795, 6200.038993955944, 6202.100695399232, 6204.038374052029, 6211.0372892201785, 6211.3167551569295, 1547.922603869802, 1580.399448209673, 1580.5100418870188, 1580.8814338924626, 1581.1382796376004, 1057.8466122412208, 1059.9788004239872, 1071.223363061774, 1078.5092782783815, 1089.2974031749636, 5874.471297583153, 5907.793227237026, 5911.408859114054, 5911.822645320647, 5924.7926322578505, 6362.1093046973465, 6410.102585638015, 6413.422791948747, 6421.678916054178, 6431.356864313531, 5919.112133180058, 5919.1713160157615, 5921.348651648315, 5921.496672782861, 5923.970380148072, 3369.25876307212, 3468.3756923753967, 3472.5138480612736, 3481.7736847104857, 3482.0598438421484, 6648.634325112165, 6678.432333251728, 6690.464762818963, 6694.230163531159, 6695.832604184934, 6583.144191255106, 6583.374579414948, 6586.045023471665, 6588.703508342136, 6590.209174899042, 6545.770898018642, 6667.099941507834, 6668.866622667617, 6670.266270710218, 6675.933240667531, 6149.831532008904, 6324.083007963912, 6419.0, 6451.322611125952, 6498.642574658439, 6218.689065546795, 6289.056641503811, 6342.682865856596, 6365.14070600463, 6387.137736405526, 6614.669266536558, 6669.2997235289595, 6670.799876003728, 6676.198856137295, 6677.866442671217, 4363.934540981824, 4411.779411029372, 4440.6012106186445, 4448.0, 4448.7108337957925, 6450.0969864218105, 6459.192600924885, 6465.482761379172, 6473.708683109366, 6474.902876456951, 6282.183316168869, 6282.403171698681, 6284.4344009039405, 6290.2766181889665, 6301.96849015752, 6148.538859585459, 6266.874662506633, 6268.435840774352, 6268.52986026059, 6281.466075383643, 6145.907811382922, 6162.198914141133, 6168.228971378578, 6172.876542469216, 6178.135061091541, 6253.968730156502, 6274.466670333073, 6277.466415354564, 6279.843003924939, 6286.088517165077, 6040.546958978006, 6129.172561704113, 6156.107364432221, 6156.538259630456, 6158.630482171084], "unit": "score", "name": "prototype.html", "value": 4688.06118191905}, {"lowerIsBetter": false, "replicates": [703.9436845052393, 713.4149997002457, 719.8884172953187, 816.249895004175, 821.9753407397778, 13180.604581862548, 13452.125611835236, 13466.25935573543, 13467.865321346784, 13472.797908031363, 13332.733345333087, 13368.131071480348, 13391.933040334809, 13393.397297121628, 13413.865861341385, 667.3793372163885, 678.1082876018045, 814.1329484099444, 831.0816547714763, 844.7930257087022, 832.134580036761, 833.8582440985047, 846.834867200896, 849.5285116760195, 853.4026181672854, 508.8727818045489, 870.6996086350231, 889.2041622747637, 892.4957399069505, 892.6161750447305, 507.2568686873729, 864.2912811494577, 883.4169448164245, 884.9336299777478, 885.3802338363172, 653.993460065398, 655.4134050025249, 655.6525041727892, 655.8688262347549, 656.2059907511916, 13348.065635405526, 13366.799498007538, 13417.127886687334, 13441.126326788728, 13453.461861525528, 12766.61700148997, 13155.605331839964, 13213.933930330382, 13258.46966121354, 13320.400581973834, 10654.147668186604, 10718.517666705016, 10734.409607471585, 10915.781684366348, 10947.34315941046, 3622.5652921649307, 3701.759385639925, 3706.0734816295926, 3710.9814450927843, 3776.4146557283666, 49225.26162107571, 49307.26039109416, 49329.753351233376, 49427.0, 49438.50561494411, 10249.739337669549, 10448.477576121164, 10518.947405262925, 10583.682489525327, 10606.522706478227, 18932.242710291433, 18939.810601893805, 18946.0, 18951.715724264148, 18975.810241897405, 7594.81012974669, 7599.202083781123, 7628.923710762932, 7728.244123055491, 7750.0458890823265, 4185.142045880587, 4318.892027699269, 4357.782110894443, 4403.119376124788, 4404.185225733249, 3207.8075315481146, 3234.4178047951123, 3243.043302225849, 3265.6571060038355, 3288.2108294009267, 587.49475451112, 609.2171559545963, 612.1093808508609, 617.0774691835734, 620.4292051312804, 674.5345711459078, 677.1738479055545, 700.6461736822872, 703.1702590942634, 709.6983781892675, 7961.203879611992, 8273.359840954274, 8401.747947561584, 8492.490450572985, 8544.31645468361, 573.8339654111182, 683.0539702512057, 692.1102411462998, 698.9196242432083, 709.7351343603706, 4006.539247986519, 4074.3888416737727, 4078.7960601969785, 4194.832206711697, 4276.273033584298, 53583.46416535863, 53898.0, 54608.0, 55025.44974550203, 55242.72378638161, 47777.28334074992, 49212.75393623009, 49625.255621165714, 49828.25257621139, 49855.50144498581, 44382.0, 44760.77619611881, 44890.77554612206, 44900.0, 45615.77192114085, 8218.301444377295, 8378.664853405795, 8391.454555453876, 8452.408331416742, 8630.482171069756, 33245.667543324256, 33478.83260583682, 33504.664953350155, 34334.48498272478, 34551.481727774604, 38586.80706596449, 38717.225655487295, 42117.36823947582, 42458.0, 42771.14457710766, 10800.675979720621, 10898.346099234072, 11481.311121332747, 11545.422728863692, 11571.363575003455, 12396.31820249895, 12443.875561244271, 12447.253164810141, 13014.674633134247, 13139.671508212372, 10801.135909127408, 10896.237263391486, 11160.10719142483, 11257.268277561932, 11316.37759923212, 11078.446077696244, 11389.259698119597, 12216.267023978235, 12371.0, 12754.0, 8116.75649730509, 10425.687229383131, 10827.51276192589, 10867.184961128105, 11141.83287250708, 8675.392722509363, 9102.453852768855, 9130.634774609207, 9196.58615362297, 9585.0, 8742.519161446182, 8791.692290769792, 8796.692115775917, 8819.823603528022, 9080.772980675536], "unit": "score", "name": "yui.html", "value": 6302.690763104102}], "name": "dromaeo_css", "value": 6900.5098451632575}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 105.0, 109.0, 110.0, 110.0, 98.0, 110.0, 108.0, 109.0], "unit": "score", "name": "ai-astar", "value": 107.8}, {"lowerIsBetter": true, "replicates": [152.0, 127.0, 162.0, 178.0, 127.0, 154.0, 149.0, 127.0, 172.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 147.5}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 160.0, 161.0, 160.0, 162.0, 163.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [74.0, 81.0, 93.0, 93.0, 73.0, 73.0, 72.0, 129.0, 95.0, 73.0], "unit": "score", "name": "audio-fft", "value": 85.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 139.0, 95.0, 95.0, 95.0, 138.0, 95.0, 96.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 108.8}, {"lowerIsBetter": true, "replicates": [119.0, 116.0, 115.0, 115.0, 115.0, 115.0, 115.0, 116.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.6}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 97.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [59.0, 57.0, 58.0, 58.0, 58.0, 58.0, 57.0, 65.0, 56.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.1}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [81.0, 85.0, 83.0, 82.0, 83.0, 83.0, 92.0, 83.0, 82.0, 90.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.4}, {"lowerIsBetter": true, "replicates": [118.0, 116.0, 116.0, 116.0, 136.0, 118.0, 114.0, 117.0, 121.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.9}, {"lowerIsBetter": true, "replicates": [146.0, 142.0, 166.0, 143.0, 153.0, 141.0, 155.0, 152.0, 150.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.8}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 71.0, 67.0, 67.0, 67.0, 66.0, 66.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.3}], "name": "kraken", "value": 1514.6000000000001}]} 06:16:33 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1514.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6900.51"}}} 06:16:33 INFO - Return code: 0 06:16:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:16:33 INFO - # TBPL SUCCESS # 06:16:33 INFO - Running post-action listener: _resource_record_post_action 06:16:33 INFO - Running post-run listener: _resource_record_post_run 06:16:34 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 547606528; Read time: 0; Write time: 627264 06:16:34 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 251240448; Read time: 0; Write time: 398528 06:16:34 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 296366080; Read time: 0; Write time: 228736 06:16:34 INFO - Running post-run listener: _upload_blobber_files 06:16:34 INFO - Blob upload gear active. 06:16:34 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 06:16:34 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:16:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 06:16:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 06:16:35 INFO - (blobuploader) - INFO - Open directory for files ... 06:16:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 06:16:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:16:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:16:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:16:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:16:36 INFO - (blobuploader) - INFO - Done attempting. 06:16:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:16:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:16:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:16:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:16:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:16:37 INFO - (blobuploader) - INFO - Done attempting. 06:16:37 INFO - (blobuploader) - INFO - Iteration through files over. 06:16:37 INFO - Return code: 0 06:16:37 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 06:16:37 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 06:16:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ec8f245212b068a59fc6c0035200c9c25d77ba8db26f73ac8fbcd13164db937f9fec76091a37b70c3d7857981991e59640c84062beb999f42d862e0070ebec8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/374e70e1bb8daf0618b2087a10b5743d956c8b783d3b8c00b886fd04609890ccb848ed12c549229f480917fd096d87e576b957159a05f182ac45605bb6b82fed"} 06:16:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 06:16:37 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 06:16:37 INFO - Contents: 06:16:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ec8f245212b068a59fc6c0035200c9c25d77ba8db26f73ac8fbcd13164db937f9fec76091a37b70c3d7857981991e59640c84062beb999f42d862e0070ebec8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/374e70e1bb8daf0618b2087a10b5743d956c8b783d3b8c00b886fd04609890ccb848ed12c549229f480917fd096d87e576b957159a05f182ac45605bb6b82fed"} 06:16:37 INFO - Running post-run listener: copy_logs_to_upload_dir 06:16:37 INFO - Copying logs to upload dir... 06:16:37 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 06:16:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.460643 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-02-02 06:16:37.132535) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-02 06:16:37.135715) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1454420239.319311-1558869167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ec8f245212b068a59fc6c0035200c9c25d77ba8db26f73ac8fbcd13164db937f9fec76091a37b70c3d7857981991e59640c84062beb999f42d862e0070ebec8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/374e70e1bb8daf0618b2087a10b5743d956c8b783d3b8c00b886fd04609890ccb848ed12c549229f480917fd096d87e576b957159a05f182ac45605bb6b82fed"} build_url:https://queue.taskcluster.net/v1/task/TJRgG50jSA-1gvmJdFd-1g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011328 build_url: 'https://queue.taskcluster.net/v1/task/TJRgG50jSA-1gvmJdFd-1g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ec8f245212b068a59fc6c0035200c9c25d77ba8db26f73ac8fbcd13164db937f9fec76091a37b70c3d7857981991e59640c84062beb999f42d862e0070ebec8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/374e70e1bb8daf0618b2087a10b5743d956c8b783d3b8c00b886fd04609890ccb848ed12c549229f480917fd096d87e576b957159a05f182ac45605bb6b82fed"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-02 06:16:37.160487) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 06:16:37.160821) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1454420239.319311-1558869167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004437 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 06:16:37.245674) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-02 06:16:37.246051) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-02 06:16:37.246415) ========= ========= Total master_lag: 0.26 =========