builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-035 starttime: 1460480899.09 results: success (0) buildid: 20160412073352 builduid: 4e06f4cd47dd473ba94e99421f8c756c revision: 49d7fb650c9dde7cf6e4b2c7aa578a4a11e83f83 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 10:08:19.086613) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 10:08:19.087057) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 10:08:19.087357) ========= 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=ed14279e38b05397cf4aa391000001a4-1460479458.685719-1679285492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006328 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 10:08:19.110171) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-12 10:08:19.110461) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-12 10:08:19.123117) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 10:08:19.123402) ========= 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=ed14279e38b05397cf4aa391000001a4-1460479458.685719-1679285492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004585 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 10:08:19.171794) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-12 10:08:19.172068) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-12 10:08:19.172421) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 10:08:19.172712) ========= 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=ed14279e38b05397cf4aa391000001a4-1460479458.685719-1679285492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-12 10:08:19-- 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% 87.8M=0s 2016-04-12 10:08:20 (87.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.144581 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 10:08:19.331462) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 10:08:19.332085) ========= 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=ed14279e38b05397cf4aa391000001a4-1460479458.685719-1679285492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020580 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 10:08:19.384046) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 10:08:19.384594) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 49d7fb650c9dde7cf6e4b2c7aa578a4a11e83f83 --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 49d7fb650c9dde7cf6e4b2c7aa578a4a11e83f83 --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=ed14279e38b05397cf4aa391000001a4-1460479458.685719-1679285492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-12 10:08:20,161 truncating revision to first 12 chars 2016-04-12 10:08:20,161 Setting DEBUG logging. 2016-04-12 10:08:20,162 attempt 1/10 2016-04-12 10:08:20,162 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/49d7fb650c9d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-12 10:08:20,422 unpacking tar archive at: mozilla-central-49d7fb650c9d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.545292 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 10:08:19.945976) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 10:08:19.946630) ========= echo 49d7fb650c9dde7cf6e4b2c7aa578a4a11e83f83 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'49d7fb650c9dde7cf6e4b2c7aa578a4a11e83f83'] 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=ed14279e38b05397cf4aa391000001a4-1460479458.685719-1679285492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 49d7fb650c9dde7cf6e4b2c7aa578a4a11e83f83 program finished with exit code 0 elapsedTime=0.004511 script_repo_revision: '49d7fb650c9dde7cf6e4b2c7aa578a4a11e83f83' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 10:08:20.001658) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-12 10:08:20.002155) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-12 10:08:20.013313) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-04-12 10:08:20.013790) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=ed14279e38b05397cf4aa391000001a4-1460479458.685719-1679285492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:08:20 INFO - MultiFileLogger online at 20160412 10:08:20 in /builds/slave/test-pgo 10:08:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:08:20 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:08:20 INFO - {'append_to_log': False, 10:08:20 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:08:20 INFO - 'blob_upload_branch': 'Firefox', 10:08:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:08:20 INFO - 'branch': 'Firefox', 10:08:20 INFO - 'buildbot_json_path': 'buildprops.json', 10:08:20 INFO - 'config_files': ('talos/linux_config.py',), 10:08:20 INFO - 'default_actions': ('clobber', 10:08:20 INFO - 'read-buildbot-config', 10:08:20 INFO - 'download-and-extract', 10:08:20 INFO - 'populate-webroot', 10:08:20 INFO - 'create-virtualenv', 10:08:20 INFO - 'install', 10:08:20 INFO - 'run-tests'), 10:08:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:08:20 INFO - 'download_minidump_stackwalk': True, 10:08:20 INFO - 'download_symbols': 'ondemand', 10:08:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:08:20 INFO - 'tooltool.py': '/tools/tooltool.py', 10:08:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:08:20 INFO - '/tools/misc-python/virtualenv.py')}, 10:08:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:08:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:08:20 INFO - 'installer_path': 'installer.exe', 10:08:20 INFO - 'log_level': 'info', 10:08:20 INFO - 'log_name': 'talos', 10:08:20 INFO - 'log_to_console': True, 10:08:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:08:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:08:20 INFO - 'opt_config_files': (), 10:08:20 INFO - 'pip_index': False, 10:08:20 INFO - 'sps_profile': False, 10:08:20 INFO - 'sps_profile_interval': 0, 10:08:20 INFO - 'suite': 'dromaeojs-e10s', 10:08:20 INFO - 'system_bits': '32', 10:08:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:08:20 INFO - 'title': 'talos-linux64-ix-035', 10:08:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:08:20 INFO - 'use_talos_json': True, 10:08:20 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:08:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:08:20 INFO - 'work_dir': 'build'} 10:08:20 INFO - ##### 10:08:20 INFO - ##### Running clobber step. 10:08:20 INFO - ##### 10:08:20 INFO - Running pre-action listener: _resource_record_pre_action 10:08:20 INFO - Running main action method: clobber 10:08:20 INFO - rmtree: /builds/slave/test-pgo/build 10:08:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:08:21 INFO - Running post-action listener: _resource_record_post_action 10:08:21 INFO - ##### 10:08:21 INFO - ##### Running read-buildbot-config step. 10:08:21 INFO - ##### 10:08:21 INFO - Running pre-action listener: _resource_record_pre_action 10:08:21 INFO - Running main action method: read_buildbot_config 10:08:21 INFO - Using buildbot properties: 10:08:21 INFO - { 10:08:21 INFO - "project": "", 10:08:21 INFO - "product": "firefox", 10:08:21 INFO - "script_repo_revision": "production", 10:08:21 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 10:08:21 INFO - "repository": "", 10:08:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 10:08:21 INFO - "buildid": "20160412073352", 10:08:21 INFO - "pgo_build": "True", 10:08:21 INFO - "basedir": "/builds/slave/test-pgo", 10:08:21 INFO - "buildnumber": 175, 10:08:21 INFO - "slavename": "talos-linux64-ix-035", 10:08:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:08:21 INFO - "platform": "ubuntu64_hw", 10:08:21 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:08:21 INFO - "branch": "mozilla-central", 10:08:21 INFO - "repo_path": "mozilla-central", 10:08:21 INFO - "revision": "49d7fb650c9dde7cf6e4b2c7aa578a4a11e83f83", 10:08:21 INFO - "stage_platform": "linux64-pgo", 10:08:21 INFO - "builduid": "4e06f4cd47dd473ba94e99421f8c756c", 10:08:21 INFO - "slavebuilddir": "test" 10:08:21 INFO - } 10:08:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/dVfcuBxiSVKhneL51Qu2pA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 10:08:21 INFO - Running post-action listener: _resource_record_post_action 10:08:21 INFO - ##### 10:08:21 INFO - ##### Running download-and-extract step. 10:08:21 INFO - ##### 10:08:21 INFO - Running pre-action listener: _resource_record_pre_action 10:08:21 INFO - Running main action method: download_and_extract 10:08:21 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:08:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:21 INFO - https://queue.taskcluster.net/v1/task/dVfcuBxiSVKhneL51Qu2pA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:08:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVfcuBxiSVKhneL51Qu2pA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:08:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVfcuBxiSVKhneL51Qu2pA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:08:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVfcuBxiSVKhneL51Qu2pA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:08:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVfcuBxiSVKhneL51Qu2pA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:08:24 INFO - Downloaded 1361 bytes. 10:08:24 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:08:24 INFO - Using the following test package requirements: 10:08:24 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 10:08:24 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:08:24 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:08:24 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:24 INFO - u'jsshell-linux-x86_64.zip'], 10:08:24 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:08:24 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 10:08:24 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:08:24 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:08:24 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:08:24 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:08:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:08:24 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:08:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:24 INFO - https://queue.taskcluster.net/v1/task/dVfcuBxiSVKhneL51Qu2pA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:08:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVfcuBxiSVKhneL51Qu2pA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:08:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVfcuBxiSVKhneL51Qu2pA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:08:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVfcuBxiSVKhneL51Qu2pA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:08:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVfcuBxiSVKhneL51Qu2pA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:08:29 INFO - Downloaded 23764250 bytes. 10:08:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 10:08:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 10:08:30 INFO - Return code: 0 10:08:30 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:08: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')]} 10:08:30 INFO - https://queue.taskcluster.net/v1/task/dVfcuBxiSVKhneL51Qu2pA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:08:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVfcuBxiSVKhneL51Qu2pA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:08:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVfcuBxiSVKhneL51Qu2pA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:08:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVfcuBxiSVKhneL51Qu2pA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:08:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVfcuBxiSVKhneL51Qu2pA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:08:40 INFO - Downloaded 23764250 bytes. 10:08:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 10:08:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 10:08:41 INFO - Return code: 0 10:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:41 INFO - https://queue.taskcluster.net/v1/task/dVfcuBxiSVKhneL51Qu2pA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:08:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVfcuBxiSVKhneL51Qu2pA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:08:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVfcuBxiSVKhneL51Qu2pA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:08:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVfcuBxiSVKhneL51Qu2pA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:08:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVfcuBxiSVKhneL51Qu2pA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:08:42 INFO - Downloaded 10841076 bytes. 10:08:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 10:08:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 10:08:42 INFO - Return code: 0 10:08:42 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')]} 10:08:42 INFO - https://queue.taskcluster.net/v1/task/dVfcuBxiSVKhneL51Qu2pA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:08:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVfcuBxiSVKhneL51Qu2pA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:08:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVfcuBxiSVKhneL51Qu2pA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:08:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVfcuBxiSVKhneL51Qu2pA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:08:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dVfcuBxiSVKhneL51Qu2pA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:08:45 INFO - Downloaded 57866225 bytes. 10:08:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dVfcuBxiSVKhneL51Qu2pA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:08:45 INFO - mkdir: /builds/slave/test-pgo/properties 10:08:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:08:45 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:08:45 INFO - Contents: 10:08:45 INFO - build_url:https://queue.taskcluster.net/v1/task/dVfcuBxiSVKhneL51Qu2pA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:08:46 INFO - Running post-action listener: _resource_record_post_action 10:08:46 INFO - Running post-action listener: set_extra_try_arguments 10:08:46 INFO - ##### 10:08:46 INFO - ##### Running populate-webroot step. 10:08:46 INFO - ##### 10:08:46 INFO - Running pre-action listener: _resource_record_pre_action 10:08:46 INFO - Running main action method: populate_webroot 10:08:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:08:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:08:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:08:46 INFO - '--tppagecycles', 10:08:46 INFO - '7'], 10:08:46 INFO - 'tests': ['tsvgm']}}, 10:08:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:08:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:08:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:08:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:08:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:08:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:08:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:46 INFO - 'talos_options': ['--disable-e10s'], 10:08:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:08:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:08:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:46 INFO - 'talos_options': ['--disable-e10s'], 10:08:46 INFO - 'tests': ['damp', 'tps']}, 10:08:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:46 INFO - 'tests': ['damp', 'tps']}, 10:08:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:08:46 INFO - 'tests': ['dromaeo_dom']}, 10:08:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:08:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:08:46 INFO - 'tests': ['a11yr', 10:08:46 INFO - 'ts_paint', 10:08:46 INFO - 'tpaint', 10:08:46 INFO - 'sessionrestore', 10:08:46 INFO - 'sessionrestore_no_auto_restore', 10:08:46 INFO - 'tabpaint']}, 10:08:46 INFO - 'other-e10s': {'tests': ['a11yr', 10:08:46 INFO - 'ts_paint', 10:08:46 INFO - 'tpaint', 10:08:46 INFO - 'sessionrestore', 10:08:46 INFO - 'sessionrestore_no_auto_restore', 10:08:46 INFO - 'tabpaint']}, 10:08:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:08:46 INFO - 'ts_paint', 10:08:46 INFO - 'tpaint', 10:08:46 INFO - 'sessionrestore', 10:08:46 INFO - 'sessionrestore_no_auto_restore', 10:08:46 INFO - 'tabpaint']}, 10:08:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:08:46 INFO - 'ts_paint', 10:08:46 INFO - 'tpaint', 10:08:46 INFO - 'sessionrestore', 10:08:46 INFO - 'sessionrestore_no_auto_restore', 10:08:46 INFO - 'tabpaint']}, 10:08:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:08:46 INFO - 'tests': ['a11yr', 10:08:46 INFO - 'ts_paint', 10:08:46 INFO - 'tpaint', 10:08:46 INFO - 'sessionrestore', 10:08:46 INFO - 'sessionrestore_no_auto_restore', 10:08:46 INFO - 'tabpaint']}, 10:08:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:08:46 INFO - 'tests': ['a11yr', 10:08:46 INFO - 'ts_paint', 10:08:46 INFO - 'tpaint', 10:08:46 INFO - 'sessionrestore', 10:08:46 INFO - 'sessionrestore_no_auto_restore', 10:08:46 INFO - 'tabpaint']}, 10:08:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:08:46 INFO - 'tests': ['tsvgx', 10:08:46 INFO - 'tsvgr_opacity', 10:08:46 INFO - 'tart', 10:08:46 INFO - 'tscrollx', 10:08:46 INFO - 'cart']}, 10:08:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:08:46 INFO - 'tsvgr_opacity', 10:08:46 INFO - 'tart', 10:08:46 INFO - 'tscrollx', 10:08:46 INFO - 'cart']}, 10:08:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:46 INFO - 'talos_options': ['--disable-e10s'], 10:08:46 INFO - 'tests': ['tp5o']}, 10:08:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:46 INFO - 'tests': ['tp5o']}, 10:08:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:46 INFO - 'talos_options': ['--disable-e10s', 10:08:46 INFO - '--xperf_path', 10:08:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:08:46 INFO - 'tests': ['tp5n']}, 10:08:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:46 INFO - 'talos_options': ['--xperf_path', 10:08:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:08:46 INFO - 'tests': ['tp5n']}}, 10:08:46 INFO - 'talos.zip': {'path': '', 10:08:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:08:46 INFO - Running post-action listener: _resource_record_post_action 10:08:46 INFO - ##### 10:08:46 INFO - ##### Running create-virtualenv step. 10:08:46 INFO - ##### 10:08:46 INFO - Running pre-action listener: _resource_record_pre_action 10:08:46 INFO - Running main action method: create_virtualenv 10:08:46 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:08:46 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 10:08:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:08:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:08:46 INFO - Using real prefix '/usr' 10:08:46 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:08:47 INFO - Installing distribute.............................................................................................................................................................................................done. 10:08:49 INFO - Installing pip.................done. 10:08:49 INFO - Return code: 0 10:08:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:08:49 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')]} 10:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:49 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')]} 10:08:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:49 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 0x7fcc0a1b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237d8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240c8b0>, '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 0x240d7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240dc60>, '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': 'ed14279e38b05397cf4aa391000001a4-1460479458.685719-1679285492', '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 10:08:49 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 10:08:49 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 10:08:49 INFO - Using env: {'DISPLAY': ':0', 10:08:49 INFO - 'HOME': '/home/cltbld', 10:08:49 INFO - 'LANG': 'en_US.UTF-8', 10:08:49 INFO - 'LANGUAGE': 'en_US:en', 10:08:49 INFO - 'LOGNAME': 'cltbld', 10:08:49 INFO - 'MAIL': '/var/mail/cltbld', 10:08:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:49 INFO - 'MOZ_NO_REMOTE': '1', 10:08:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:49 INFO - 'NO_EM_RESTART': '1', 10:08:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:08:49 INFO - 'PWD': '/builds/slave/test-pgo', 10:08:49 INFO - 'SHELL': '/bin/bash', 10:08:49 INFO - 'SHLVL': '1', 10:08:49 INFO - 'TERM': 'linux', 10:08:49 INFO - 'TMOUT': '86400', 10:08:49 INFO - 'USER': 'cltbld', 10:08:49 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460479458.685719-1679285492', 10:08:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:49 INFO - '_': '/tools/buildbot/bin/python'} 10:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:49 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 10:08:49 INFO - Cleaning up... 10:08:49 INFO - Return code: 0 10:08:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:08:49 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')]} 10:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:49 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')]} 10:08:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:49 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 0x7fcc0a1b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237d8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240c8b0>, '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 0x240d7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240dc60>, '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': 'ed14279e38b05397cf4aa391000001a4-1460479458.685719-1679285492', '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 10:08:49 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 10:08:49 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 10:08:49 INFO - Using env: {'DISPLAY': ':0', 10:08:49 INFO - 'HOME': '/home/cltbld', 10:08:49 INFO - 'LANG': 'en_US.UTF-8', 10:08:49 INFO - 'LANGUAGE': 'en_US:en', 10:08:49 INFO - 'LOGNAME': 'cltbld', 10:08:49 INFO - 'MAIL': '/var/mail/cltbld', 10:08:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:49 INFO - 'MOZ_NO_REMOTE': '1', 10:08:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:49 INFO - 'NO_EM_RESTART': '1', 10:08:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:08:49 INFO - 'PWD': '/builds/slave/test-pgo', 10:08:49 INFO - 'SHELL': '/bin/bash', 10:08:49 INFO - 'SHLVL': '1', 10:08:49 INFO - 'TERM': 'linux', 10:08:49 INFO - 'TMOUT': '86400', 10:08:49 INFO - 'USER': 'cltbld', 10:08:49 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460479458.685719-1679285492', 10:08:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:49 INFO - '_': '/tools/buildbot/bin/python'} 10:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:49 INFO - Downloading/unpacking psutil>=0.7.1 10:08:49 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 10:08:49 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 10:08:49 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 10:08:49 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 10:08:49 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 10:08:49 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 10:08:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:08:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:08:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:08:51 INFO - Installing collected packages: psutil 10:08:51 INFO - Running setup.py install for psutil 10:08:51 INFO - building 'psutil._psutil_linux' extension 10:08:51 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 10:08:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:08:51 INFO - building 'psutil._psutil_posix' extension 10:08:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:08:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:08:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:08:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:08:51 INFO - Successfully installed psutil 10:08:51 INFO - Cleaning up... 10:08:51 INFO - Return code: 0 10:08:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc0a1b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237d8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240c8b0>, '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 0x240d7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240dc60>, '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': 'ed14279e38b05397cf4aa391000001a4-1460479458.685719-1679285492', '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 10:08:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 10:08:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:08:51 INFO - Using env: {'DISPLAY': ':0', 10:08:51 INFO - 'HOME': '/home/cltbld', 10:08:51 INFO - 'LANG': 'en_US.UTF-8', 10:08:51 INFO - 'LANGUAGE': 'en_US:en', 10:08:51 INFO - 'LOGNAME': 'cltbld', 10:08:51 INFO - 'MAIL': '/var/mail/cltbld', 10:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:51 INFO - 'MOZ_NO_REMOTE': '1', 10:08:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:52 INFO - 'NO_EM_RESTART': '1', 10:08:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:08:52 INFO - 'PWD': '/builds/slave/test-pgo', 10:08:52 INFO - 'SHELL': '/bin/bash', 10:08:52 INFO - 'SHLVL': '1', 10:08:52 INFO - 'TERM': 'linux', 10:08:52 INFO - 'TMOUT': '86400', 10:08:52 INFO - 'USER': 'cltbld', 10:08:52 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460479458.685719-1679285492', 10:08:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:52 INFO - '_': '/tools/buildbot/bin/python'} 10:08:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:08:52 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 10:08:52 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 10:08:52 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 10:08:52 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 10:08:52 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 10:08:52 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 10:08:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:08:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:08:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:08:54 INFO - Installing collected packages: mozsystemmonitor 10:08:54 INFO - Running setup.py install for mozsystemmonitor 10:08:54 INFO - Successfully installed mozsystemmonitor 10:08:54 INFO - Cleaning up... 10:08:54 INFO - Return code: 0 10:08:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:54 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 0x7fcc0a1b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237d8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240c8b0>, '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 0x240d7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240dc60>, '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': 'ed14279e38b05397cf4aa391000001a4-1460479458.685719-1679285492', '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 10:08:54 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 10:08:54 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 10:08:54 INFO - Using env: {'DISPLAY': ':0', 10:08:54 INFO - 'HOME': '/home/cltbld', 10:08:54 INFO - 'LANG': 'en_US.UTF-8', 10:08:54 INFO - 'LANGUAGE': 'en_US:en', 10:08:54 INFO - 'LOGNAME': 'cltbld', 10:08:54 INFO - 'MAIL': '/var/mail/cltbld', 10:08:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:54 INFO - 'MOZ_NO_REMOTE': '1', 10:08:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:54 INFO - 'NO_EM_RESTART': '1', 10:08:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:08:54 INFO - 'PWD': '/builds/slave/test-pgo', 10:08:54 INFO - 'SHELL': '/bin/bash', 10:08:54 INFO - 'SHLVL': '1', 10:08:54 INFO - 'TERM': 'linux', 10:08:54 INFO - 'TMOUT': '86400', 10:08:54 INFO - 'USER': 'cltbld', 10:08:54 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460479458.685719-1679285492', 10:08:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:54 INFO - '_': '/tools/buildbot/bin/python'} 10:08:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:54 INFO - Downloading/unpacking blobuploader==1.2.4 10:08:54 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 10:08:54 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 10:08:54 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 10:08:54 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 10:08:54 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 10:08:54 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 10:08:56 INFO - Downloading blobuploader-1.2.4.tar.gz 10:08:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:08:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:08:56 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 10:08:56 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 10:08:56 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 10:08:56 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 10:08:56 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 10:08:56 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 10:08:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:08:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:08:56 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 10:08:56 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 10:08:56 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 10:08:56 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 10:08:56 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 10:08:56 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 10:08:56 INFO - Downloading docopt-0.6.1.tar.gz 10:08:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:08:57 INFO - Installing collected packages: blobuploader, requests, docopt 10:08:57 INFO - Running setup.py install for blobuploader 10:08:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:08:57 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:08:57 INFO - Running setup.py install for requests 10:08:57 INFO - Running setup.py install for docopt 10:08:57 INFO - Successfully installed blobuploader requests docopt 10:08:57 INFO - Cleaning up... 10:08:57 INFO - Return code: 0 10:08:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:08:57 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')]} 10:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:57 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')]} 10:08:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:57 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 0x7fcc0a1b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237d8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240c8b0>, '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 0x240d7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240dc60>, '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': 'ed14279e38b05397cf4aa391000001a4-1460479458.685719-1679285492', '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 10:08:57 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 10:08:57 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 10:08:57 INFO - Using env: {'DISPLAY': ':0', 10:08:57 INFO - 'HOME': '/home/cltbld', 10:08:57 INFO - 'LANG': 'en_US.UTF-8', 10:08:57 INFO - 'LANGUAGE': 'en_US:en', 10:08:57 INFO - 'LOGNAME': 'cltbld', 10:08:57 INFO - 'MAIL': '/var/mail/cltbld', 10:08:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:57 INFO - 'MOZ_NO_REMOTE': '1', 10:08:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:57 INFO - 'NO_EM_RESTART': '1', 10:08:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:08:57 INFO - 'PWD': '/builds/slave/test-pgo', 10:08:57 INFO - 'SHELL': '/bin/bash', 10:08:57 INFO - 'SHLVL': '1', 10:08:57 INFO - 'TERM': 'linux', 10:08:57 INFO - 'TMOUT': '86400', 10:08:57 INFO - 'USER': 'cltbld', 10:08:57 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460479458.685719-1679285492', 10:08:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:57 INFO - '_': '/tools/buildbot/bin/python'} 10:08:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:08:57 INFO - Running setup.py (path:/tmp/pip-4zneUq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:08:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:08:57 INFO - Running setup.py (path:/tmp/pip-7HN_5K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:08:58 INFO - Running setup.py (path:/tmp/pip-XuSXkE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:08:58 INFO - Running setup.py (path:/tmp/pip-m5wIvW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:08:58 INFO - Running setup.py (path:/tmp/pip-9LpkSd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:08:58 INFO - Running setup.py (path:/tmp/pip-qLKh7v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:08:58 INFO - Running setup.py (path:/tmp/pip-5ToT2w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:08:58 INFO - Running setup.py (path:/tmp/pip-s4lkIn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:08:58 INFO - Running setup.py (path:/tmp/pip-kLsDEI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:08:58 INFO - Running setup.py (path:/tmp/pip-Vsa8b3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:08:58 INFO - Running setup.py (path:/tmp/pip-G91ikW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:08:58 INFO - Running setup.py (path:/tmp/pip-CciojV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:08:58 INFO - Running setup.py (path:/tmp/pip-uRZ3M0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:08:58 INFO - Running setup.py (path:/tmp/pip-IzC0Ql-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:08:58 INFO - Running setup.py (path:/tmp/pip-2xVG9p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:08:58 INFO - Running setup.py (path:/tmp/pip-Ochbc1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:08:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:08:59 INFO - Running setup.py (path:/tmp/pip-bRwgJk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:08:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:08:59 INFO - Running setup.py install for manifestparser 10:08:59 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:08:59 INFO - Running setup.py install for mozcrash 10:08:59 INFO - Running setup.py install for mozdebug 10:08:59 INFO - Running setup.py install for mozdevice 10:08:59 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:08:59 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:08:59 INFO - Running setup.py install for mozfile 10:08:59 INFO - Running setup.py install for mozhttpd 10:08:59 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:08:59 INFO - Running setup.py install for mozinfo 10:08:59 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:08:59 INFO - Running setup.py install for mozInstall 10:08:59 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:08:59 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:08:59 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:08:59 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:08:59 INFO - Running setup.py install for mozleak 10:08:59 INFO - Running setup.py install for mozlog 10:09:00 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:09:00 INFO - Running setup.py install for moznetwork 10:09:00 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:09:00 INFO - Running setup.py install for mozprocess 10:09:00 INFO - Running setup.py install for mozprofile 10:09:00 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:09:00 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:09:00 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:09:00 INFO - Running setup.py install for mozrunner 10:09:00 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:09:00 INFO - Running setup.py install for mozscreenshot 10:09:00 INFO - Running setup.py install for moztest 10:09:00 INFO - Running setup.py install for mozversion 10:09:00 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:09:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:09:00 INFO - Cleaning up... 10:09:00 INFO - Return code: 0 10:09:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc0a1b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237d8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240c8b0>, '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 0x240d7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240dc60>, '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': 'ed14279e38b05397cf4aa391000001a4-1460479458.685719-1679285492', '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 10:09:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 10:09:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:09:00 INFO - Using env: {'DISPLAY': ':0', 10:09:00 INFO - 'HOME': '/home/cltbld', 10:09:00 INFO - 'LANG': 'en_US.UTF-8', 10:09:00 INFO - 'LANGUAGE': 'en_US:en', 10:09:00 INFO - 'LOGNAME': 'cltbld', 10:09:00 INFO - 'MAIL': '/var/mail/cltbld', 10:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:00 INFO - 'MOZ_NO_REMOTE': '1', 10:09:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:00 INFO - 'NO_EM_RESTART': '1', 10:09:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:09:00 INFO - 'PWD': '/builds/slave/test-pgo', 10:09:00 INFO - 'SHELL': '/bin/bash', 10:09:00 INFO - 'SHLVL': '1', 10:09:00 INFO - 'TERM': 'linux', 10:09:00 INFO - 'TMOUT': '86400', 10:09:00 INFO - 'USER': 'cltbld', 10:09:00 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460479458.685719-1679285492', 10:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:00 INFO - '_': '/tools/buildbot/bin/python'} 10:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:09:01 INFO - Running setup.py (path:/tmp/pip-yl0_hb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:09:01 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)) 10:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:09:01 INFO - Running setup.py (path:/tmp/pip-L9FPzY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 10:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:09:01 INFO - Running setup.py (path:/tmp/pip-eceOUA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:09:01 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)) 10:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:09:01 INFO - Running setup.py (path:/tmp/pip-mXvoYl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:09:01 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)) 10:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:09:01 INFO - Running setup.py (path:/tmp/pip-uB3O0J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:09:01 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)) 10:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:09:01 INFO - Running setup.py (path:/tmp/pip-TuxPac-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:09:01 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)) 10:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:09:01 INFO - Running setup.py (path:/tmp/pip-Yb3upz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:09:01 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)) 10:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:09:01 INFO - Running setup.py (path:/tmp/pip-FwTWl6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:09:01 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)) 10:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:09:01 INFO - Running setup.py (path:/tmp/pip-rva5ZM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:09:01 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)) 10:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:09:01 INFO - Running setup.py (path:/tmp/pip-Lg_ri1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:09:01 INFO - Running setup.py (path:/tmp/pip-kDptbi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 10:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:09:01 INFO - Running setup.py (path:/tmp/pip-rLJA45-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 10:09:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:09:01 INFO - Running setup.py (path:/tmp/pip-8l5H8U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:09:02 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)) 10:09:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:09:02 INFO - Running setup.py (path:/tmp/pip-KIqDXs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:09:02 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)) 10:09:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:09:02 INFO - Running setup.py (path:/tmp/pip-S9PFb8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:09:02 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)) 10:09:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:09:02 INFO - Running setup.py (path:/tmp/pip-Xw8MQE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:09:02 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)) 10:09:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:09:02 INFO - Running setup.py (path:/tmp/pip-ndXdma-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:09:02 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)) 10:09:02 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:09:02 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:09:02 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)) 10:09:02 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)) 10:09:02 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)) 10:09:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:09:02 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 10:09:02 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 10:09:02 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 10:09:02 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 10:09:02 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 10:09:02 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 10:09:04 INFO - Downloading blessings-1.6.tar.gz 10:09:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:09:04 INFO - Installing collected packages: blessings 10:09:04 INFO - Running setup.py install for blessings 10:09:04 INFO - Successfully installed blessings 10:09:04 INFO - Cleaning up... 10:09:04 INFO - Return code: 0 10:09:04 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:09:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:09:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:09:04 INFO - Reading from file tmpfile_stdout 10:09:04 INFO - Current package versions: 10:09:04 INFO - argparse == 1.2.1 10:09:04 INFO - blessings == 1.6 10:09:04 INFO - blobuploader == 1.2.4 10:09:04 INFO - docopt == 0.6.1 10:09:04 INFO - manifestparser == 1.1 10:09:04 INFO - mozInstall == 1.12 10:09:04 INFO - mozcrash == 0.17 10:09:04 INFO - mozdebug == 0.1 10:09:04 INFO - mozdevice == 0.48 10:09:04 INFO - mozfile == 1.2 10:09:04 INFO - mozhttpd == 0.7 10:09:04 INFO - mozinfo == 0.9 10:09:04 INFO - mozleak == 0.1 10:09:04 INFO - mozlog == 3.1 10:09:04 INFO - moznetwork == 0.27 10:09:04 INFO - mozprocess == 0.22 10:09:04 INFO - mozprofile == 0.28 10:09:04 INFO - mozrunner == 6.11 10:09:04 INFO - mozscreenshot == 0.1 10:09:04 INFO - mozsystemmonitor == 0.0 10:09:04 INFO - moztest == 0.7 10:09:04 INFO - mozversion == 1.4 10:09:04 INFO - psutil == 3.1.1 10:09:04 INFO - requests == 1.2.3 10:09:04 INFO - wsgiref == 0.1.2 10:09:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:04 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 0x7fcc0a1b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237d8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240c8b0>, '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 0x240d7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240dc60>, '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': 'ed14279e38b05397cf4aa391000001a4-1460479458.685719-1679285492', '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 10:09:04 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 10:09:04 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 10:09:04 INFO - Using env: {'DISPLAY': ':0', 10:09:04 INFO - 'HOME': '/home/cltbld', 10:09:04 INFO - 'LANG': 'en_US.UTF-8', 10:09:04 INFO - 'LANGUAGE': 'en_US:en', 10:09:04 INFO - 'LOGNAME': 'cltbld', 10:09:04 INFO - 'MAIL': '/var/mail/cltbld', 10:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:04 INFO - 'MOZ_NO_REMOTE': '1', 10:09:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:04 INFO - 'NO_EM_RESTART': '1', 10:09:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:09:04 INFO - 'PWD': '/builds/slave/test-pgo', 10:09:04 INFO - 'SHELL': '/bin/bash', 10:09:04 INFO - 'SHLVL': '1', 10:09:04 INFO - 'TERM': 'linux', 10:09:04 INFO - 'TMOUT': '86400', 10:09:04 INFO - 'USER': 'cltbld', 10:09:04 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460479458.685719-1679285492', 10:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:04 INFO - '_': '/tools/buildbot/bin/python'} 10:09:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:04 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)) 10:09:04 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)) 10:09:04 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)) 10:09:04 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)) 10:09:04 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)) 10:09:04 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)) 10:09:04 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)) 10:09:04 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)) 10:09:04 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)) 10:09:04 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)) 10:09:04 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)) 10:09:04 INFO - Cleaning up... 10:09:04 INFO - Return code: 0 10:09:04 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc0a1b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237d8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240c8b0>, '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 0x240d7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240dc60>, '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': 'ed14279e38b05397cf4aa391000001a4-1460479458.685719-1679285492', '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 10:09:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 10:09:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:09:04 INFO - Using env: {'DISPLAY': ':0', 10:09:04 INFO - 'HOME': '/home/cltbld', 10:09:04 INFO - 'LANG': 'en_US.UTF-8', 10:09:04 INFO - 'LANGUAGE': 'en_US:en', 10:09:04 INFO - 'LOGNAME': 'cltbld', 10:09:04 INFO - 'MAIL': '/var/mail/cltbld', 10:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:04 INFO - 'MOZ_NO_REMOTE': '1', 10:09:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:04 INFO - 'NO_EM_RESTART': '1', 10:09:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:09:04 INFO - 'PWD': '/builds/slave/test-pgo', 10:09:04 INFO - 'SHELL': '/bin/bash', 10:09:04 INFO - 'SHLVL': '1', 10:09:04 INFO - 'TERM': 'linux', 10:09:04 INFO - 'TMOUT': '86400', 10:09:04 INFO - 'USER': 'cltbld', 10:09:04 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460479458.685719-1679285492', 10:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:04 INFO - '_': '/tools/buildbot/bin/python'} 10:09:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:05 INFO - Downloading/unpacking jsonschema 10:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:09:06 INFO - Downloading/unpacking functools32 (from jsonschema) 10:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:07 INFO - Downloading functools32-3.2.3-2.tar.gz 10:09:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:09:07 INFO - warning: no files found matching '*.txt' 10:09:07 INFO - no previously-included directories found matching 'build' 10:09:07 INFO - no previously-included directories found matching 'dist' 10:09:07 INFO - no previously-included directories found matching '.git*' 10:09:07 INFO - Installing collected packages: jsonschema, functools32 10:09:07 INFO - Running setup.py install for functools32 10:09:07 INFO - warning: no files found matching '*.txt' 10:09:07 INFO - no previously-included directories found matching 'build' 10:09:07 INFO - no previously-included directories found matching 'dist' 10:09:07 INFO - no previously-included directories found matching '.git*' 10:09:07 INFO - Successfully installed jsonschema functools32 10:09:07 INFO - Cleaning up... 10:09:07 INFO - Return code: 0 10:09:07 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc0a1b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237d8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240c8b0>, '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 0x240d7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240dc60>, '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': 'ed14279e38b05397cf4aa391000001a4-1460479458.685719-1679285492', '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 10:09:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 10:09:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:09:07 INFO - Using env: {'DISPLAY': ':0', 10:09:07 INFO - 'HOME': '/home/cltbld', 10:09:07 INFO - 'LANG': 'en_US.UTF-8', 10:09:07 INFO - 'LANGUAGE': 'en_US:en', 10:09:07 INFO - 'LOGNAME': 'cltbld', 10:09:07 INFO - 'MAIL': '/var/mail/cltbld', 10:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:07 INFO - 'MOZ_NO_REMOTE': '1', 10:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:07 INFO - 'NO_EM_RESTART': '1', 10:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:09:07 INFO - 'PWD': '/builds/slave/test-pgo', 10:09:07 INFO - 'SHELL': '/bin/bash', 10:09:07 INFO - 'SHLVL': '1', 10:09:07 INFO - 'TERM': 'linux', 10:09:07 INFO - 'TMOUT': '86400', 10:09:07 INFO - 'USER': 'cltbld', 10:09:07 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460479458.685719-1679285492', 10:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:07 INFO - '_': '/tools/buildbot/bin/python'} 10:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:07 INFO - Downloading/unpacking flake8 10:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:09:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:09:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:09:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:09:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:09:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:09:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:09:10 INFO - no previously-included directories found matching 'docs/_build' 10:09:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:09:10 INFO - Running setup.py install for pep8 10:09:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:09:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:09:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:09:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:09:10 INFO - no previously-included directories found matching 'docs/_build' 10:09:10 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:09:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:09:10 INFO - Cleaning up... 10:09:10 INFO - Return code: 0 10:09:10 INFO - Running post-action listener: _resource_record_post_action 10:09:10 INFO - Running post-action listener: _start_resource_monitoring 10:09:10 INFO - Starting resource monitoring. 10:09:10 INFO - ##### 10:09:10 INFO - ##### Running install step. 10:09:10 INFO - ##### 10:09:10 INFO - Running pre-action listener: _resource_record_pre_action 10:09:10 INFO - Running main action method: install 10:09:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:09:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:09:10 INFO - Reading from file tmpfile_stdout 10:09:10 INFO - Detecting whether we're running mozinstall >=1.0... 10:09:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:09:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:09:10 INFO - Reading from file tmpfile_stdout 10:09:10 INFO - Output received: 10:09:10 INFO - Usage: mozinstall [options] installer 10:09:10 INFO - Options: 10:09:10 INFO - -h, --help show this help message and exit 10:09:10 INFO - -d DEST, --destination=DEST 10:09:10 INFO - Directory to install application into. [default: 10:09:10 INFO - "/builds/slave/test-pgo"] 10:09:10 INFO - --app=APP Application being installed. [default: firefox] 10:09:10 INFO - mkdir: /builds/slave/test-pgo/build/application 10:09:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 10:09:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 10:09:27 INFO - Reading from file tmpfile_stdout 10:09:27 INFO - Output received: 10:09:27 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:09:27 INFO - Running post-action listener: _resource_record_post_action 10:09:27 INFO - ##### 10:09:27 INFO - ##### Running run-tests step. 10:09:27 INFO - ##### 10:09:27 INFO - Running pre-action listener: _resource_record_pre_action 10:09:27 INFO - Running main action method: run_tests 10:09:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:09:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:09:27 INFO - Python 2.7.3 10:09:27 INFO - Return code: 0 10:09:27 INFO - grabbing minidump binary from tooltool 10:09: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')]} 10:09:27 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 0x240c8b0>, '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 0x240d7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240dc60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:09:27 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 10:09:27 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 10:09:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:09:27 INFO - Return code: 0 10:09:27 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:09:27 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:09:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:09:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:09:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:09:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:09:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:09:28 INFO - Return code: 0 10:09:28 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dVfcuBxiSVKhneL51Qu2pA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 10:09:28 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dVfcuBxiSVKhneL51Qu2pA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:09:28 INFO - Using env: {'DISPLAY': ':0', 10:09:28 INFO - 'HOME': '/home/cltbld', 10:09:28 INFO - 'LANG': 'en_US.UTF-8', 10:09:28 INFO - 'LANGUAGE': 'en_US:en', 10:09:28 INFO - 'LOGNAME': 'cltbld', 10:09:28 INFO - 'MAIL': '/var/mail/cltbld', 10:09:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:09:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:09:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:28 INFO - 'MOZ_NO_REMOTE': '1', 10:09:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:09:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:09:28 INFO - 'NO_EM_RESTART': '1', 10:09:28 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:09:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:09:28 INFO - 'PWD': '/builds/slave/test-pgo', 10:09:28 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:09:28 INFO - 'SHELL': '/bin/bash', 10:09:28 INFO - 'SHLVL': '1', 10:09:28 INFO - 'TERM': 'linux', 10:09:28 INFO - 'TMOUT': '86400', 10:09:28 INFO - 'USER': 'cltbld', 10:09:28 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460479458.685719-1679285492', 10:09:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:28 INFO - '_': '/tools/buildbot/bin/python'} 10:09:28 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dVfcuBxiSVKhneL51Qu2pA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:09:28 INFO - mozversion application_buildid: 20160412073352 10:09:28 INFO - mozversion application_changeset: 49d7fb650c9dde7cf6e4b2c7aa578a4a11e83f83 10:09:28 INFO - mozversion application_display_name: Nightly 10:09:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:09:28 INFO - mozversion application_name: Firefox 10:09:28 INFO - mozversion application_remotingname: firefox 10:09:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:09:28 INFO - mozversion application_vendor: Mozilla 10:09:28 INFO - mozversion application_version: 48.0a1 10:09:28 INFO - mozversion platform_buildid: 20160412073352 10:09:28 INFO - mozversion platform_changeset: 49d7fb650c9dde7cf6e4b2c7aa578a4a11e83f83 10:09:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:09:28 INFO - mozversion platform_version: 48.0a1 10:09:28 INFO - using testdate: 1460480968 10:09:28 INFO - actual date: 1460480968 10:09:28 INFO - starting webserver on 'localhost:36959' 10:09:28 INFO - SUITE-START | Running 2 tests 10:09:28 INFO - TEST-START | dromaeo_css 10:09:28 INFO - operating with platform_type : linux_ 10:09:28 INFO - Initialising browser for dromaeo_css test... 10:09:28 INFO - TEST-INFO | started process 25793 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRzWn_1/profile http://localhost:36959/getInfo.html) 10:09:31 INFO - PROCESS | 25793 | 10:09:31 INFO - PROCESS | 25793 | (process:25859): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:09:32 INFO - PROCESS | 25793 | JavaScript error: jar:file:///builds/slave/test-pgo/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 10:09:32 INFO - PROCESS | 25793 | __metrics Screen width/height:1600/1200 10:09:32 INFO - PROCESS | 25793 | colorDepth:24 10:09:32 INFO - PROCESS | 25793 | Browser inner width/height: 1024/697 10:09:32 INFO - PROCESS | 25793 | __metrics 10:09:33 ERROR - PROCESS | 25793 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 10:09:34 INFO - TEST-INFO | 25793: exit 0 10:09:34 INFO - Browser initialized. 10:09:34 INFO - Running cycle 1/1 for dromaeo_css test... 10:09:34 INFO - TEST-INFO | started process 25910 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRzWn_1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:09:36 INFO - PROCESS | 25910 | 10:09:36 INFO - PROCESS | 25910 | (process:25970): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:09:46 INFO - PROCESS | 25910 | RSS: Main: 163143680 10:09:46 INFO - PROCESS | 25910 | 10:10:35 INFO - PROCESS | 25910 | 1460481035649 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] 10:12:43 INFO - PROCESS | 25910 | Cycle 1(1): loaded http://localhost:36959/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36959/tests/dromaeo/cssquery-ext.html) 10:12:44 INFO - PROCESS | 25910 | RSS: Main: 169398272 10:12:44 INFO - PROCESS | 25910 | 10:15:46 INFO - PROCESS | 25910 | Cycle 1(1): loaded http://localhost:36959/tests/dromaeo/cssquery-ext.html (next: http://localhost:36959/tests/dromaeo/cssquery-jquery.html) 10:15:47 INFO - PROCESS | 25910 | RSS: Main: 165498880 10:15:47 INFO - PROCESS | 25910 | 10:18:49 INFO - PROCESS | 25910 | Cycle 1(1): loaded http://localhost:36959/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36959/tests/dromaeo/cssquery-mootools.html) 10:18:49 INFO - PROCESS | 25910 | RSS: Main: 166170624 10:18:49 INFO - PROCESS | 25910 | 10:21:51 INFO - PROCESS | 25910 | Cycle 1(1): loaded http://localhost:36959/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36959/tests/dromaeo/cssquery-prototype.html) 10:21:52 INFO - PROCESS | 25910 | RSS: Main: 164315136 10:21:52 INFO - PROCESS | 25910 | 10:24:54 INFO - PROCESS | 25910 | Cycle 1(1): loaded http://localhost:36959/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36959/tests/dromaeo/cssquery-yui.html) 10:24:55 INFO - PROCESS | 25910 | RSS: Main: 165769216 10:24:55 INFO - PROCESS | 25910 | 10:27:57 INFO - PROCESS | 25910 | Cycle 1(1): loaded http://localhost:36959/tests/dromaeo/cssquery-yui.html (next: http://localhost:36959/tests/dromaeo/cssquery-dojo.html) 10:27:57 INFO - PROCESS | 25910 | RSS: Main: 168026112 10:27:57 INFO - PROCESS | 25910 | 10:27:57 INFO - PROCESS | 25910 | __start_tp_report 10:27:57 INFO - PROCESS | 25910 | _x_x_mozilla_page_load 10:27:57 INFO - PROCESS | 25910 | _x_x_mozilla_page_load_details 10:27:57 INFO - PROCESS | 25910 | |i|pagename|runs| 10:27:57 INFO - PROCESS | 25910 | |0;dojo.html;3151.4800057990433;3214.7428205743545;3239.2549713565863;3274.2469232076623;3299.983500082499;5383.784648614051;5393.73031348433;5395.0558652235895;5423.240746295517;5428.538574221191;5341.385740639827;5431.945680543194;5517.834464966048;5527.972360138204;5547.861303467415;4903.558679718833;4932.654714170009;4972.179590367585;5020.824271150511;5038.7228702421535;4951.950480495203;5024.899502009957;5073.974630126844;5085.516875896784;5136.974315128419;4861.927071093919;4864.805407783684;4888.560029597354;4921.458639549646;4924.409070911478;4915.090708218991;4931.112399768041;4937.456879743226;4948.678335908155;4973.403191616993;4894.828680996148;4897.2898929655;4899.044686286175;4901.142300097468;4915.115279249733;5281.841544753664;5325.733713314319;5343.946560534423;5346;5350.197470379435;5827.242458480413;5832.650040997553;5840.795572154997;5848.327442344143;5862.560307976919;5748.5975981681295;5836.649801011953;5899.882002359972;5924.407559244084;5931.288245410536;5453.400125986138;5473.233747275384;5492.697901615409;5499.1476321170285;5542.722863856791;5938.732757025858;5996.310424301174;5997.520198384119;5999.580029397987;6001.1898393717165;5646.802361917313;5689.857753556194;5757.222774925415;5772.94227057724;5783.929972955017;5886.676232807236;5914.674692891932;5928.140419639214;5928.258967629046;5951.553633477506;5717.113847353667;5811.2445382100905;5857.853553661193;5883.676397798076;5943.762249510058;5670.461306175906;5677.744501497443;5777.855553611109;5779.479846813807;5783.942160578425;4398.516163222043;4403.251447253974;4403.427554417969;4408.162449134654;4451.844185453559;3980.6218409251073;3986.1629057897585;3999.1601763629383;4007.5391329997424;4023.396490526386;5567.860803479945;5633.211350410946;5636.915446268309;5646.71766411686;5682.090865461589;5828.358880523139;5879.029960056543;5879.911801322984;5882.147088672119;5907.793227237112;5522.779088836402;5558.749856256478;5559.33288005442;5565.165225216169;5576.247206627135;4868.78090485929;4959.380077490314;4999.975000124976;5008.298838162587;5034.093863104603;5906.173135760997;5952.434518720715;5961.046232602763;5964.075568286922;5989.880202395928;5807.709614519342;5810.854728631818;5817.941820581909;5822.796202132905;5823.563232757476;5872.442117998783;6072.392760723892;6105.641708308169;6124.626121635095;6138.447539721446;5710.314762228393;5714.885702286014;5721.027425337619;5733.111367738007;5787.8553036174435;5716.8570785729025;5820.796272130455;5829.213056237523;5840.591158618856;5842.503387212135;5713.514351280021;5752.539796816161;5791.797287094932;5803.9419605803405;5831.825045248649;5564.77740890376;5702.942970570241;5722.17028530869;5737.196792449144;5741.770329186953;5517.200005999188;5592.7762889483965;5595.804146854841;5612.8877422450505;5612.915806262991;5593.552515798645;5667.858303542444;5741.885162296647;5841.474267315962;5864.706764661664;5547.8890422190525;5568.081266590967;5585;5591.8881622368135;5612.158176273591 10:27:57 INFO - PROCESS | 25910 | |1;ext.html;611.4008271893545;631.5263552335748;646.095466347114;655.1384928818603;684.6131935456464;37474.812625936866;37522.249555008886;37771.62228377716;37790.622093779086;38977;39012;39132.41301380481;39178;39363;39396;8500.234978851886;8676.8698469523;8693.478391296543;8696.608652610616;8731.214190722834;8562.186592273754;8912.64349426022;8913.465192088463;8915.821683566324;8917.242034427081;8884.156005179497;8990.865137022949;8993.010768815426;8993.28053755698;9001.23489503393;8869.37914345996;8896.822063558757;8904.554772261394;8912.420692654956;8963.462192268453;8683.696070637561;8725.254949010223;8776.473411595261;8808.955955220183;8832.646694132227;33615.15962100943;39099.60900391017;39652.20695586101;39660.20679586421;39664.20671586552;3336.7664263501565;3499.24766175271;3516.507688923527;3554.9111272218142;3577.3024260269;26236.21291361243;26876.328091797863;28329.150125496268;28331.291717707016;28747.13758587225;4045.7572545647063;4050.2591268000506;4054.736442131252;4097.221527909687;4112.177564487085;220880;221111;223310;224664;225742;31495.527567086512;31536.369272614418;32184;32251.677483224867;33107.51016204277;31540.684593154234;31802.522962155585;31821.045368638977;31864;33004.3399132016;13904.721905561832;14096;14132.081414708216;14144.43422263098;14178.220197889215;12595.370231488572;12712.237265764084;12732.681682958;12828.35858207086;12858.292793896238;7517.285857843496;7595.506292091107;7616.69533218665;7657.119431265364;7687.500312479671;2886.235147685865;2897.753690936294;2931.6628587712257;2939.750121239676;2943.617329747119;971.50453268832;979.3095867413457;1035.637526865591;1039.2880876599554;1192.8508936382952;30572;30981;31623.683763162073;31891.840540797148;32316.19209519781;1003.8745156855393;1078.0890147825232;1112.5827814569536;1127.2841745491507;1139.4530625299903;15272.16003119817;15550.688986220212;15673.216339182994;15733.213339333217;15789.21053947298;446184;562108;577313;578523;587507;57058.7147064262;57951;58033.09834508257;58329;58358.416415836145;1353.2895230004326;1373.478078330248;1375.7386096641806;1400.229873569553;1403.5929580421769;30219.244518887204;31079.689203108584;31264.687353127087;31372.372552549277;31915.042548723577;48517.5148248513;49295.7535212336;49423;49512.75243623759;49638.25542616791;412178;414318;414890;415720;418270;26255.212343629722;26653.733462665125;26753.464930701666;26758.331041724112;42868.35697464603;43195.78402107969;43211.783941080095;43287.56712432835;47234;48637.75681121572;35877;36070.27859442744;36407;36655.45016824696;37018;36500;37237.81381093077;37300;37648;37937.810310949375;37518.06204844901;39745.2050958985;40620.3906941402;41111.17777644371;41548.79225603853;31016.68983310138;32314;32723.509147362332;32811.67188328086;32879.67120328766;25483.61774573346;25545.74454255508;25896.741032589434;26195.345116372242;26269.868650656623 10:27:57 INFO - PROCESS | 25910 | |2;jquery.html;373.33918963434706;374.88753373987817;377.3396556026953;377.901745546158;383.75056213461227;17956.73064904026;18189.545261368472;18254.908725456386;19004.524886877836;19081.332153374653;16406.26171822268;16545.586360340996;16913;17091.914540427282;17367.82632173678;4884.511548845114;5015.673981191211;5020.196768517038;5020.97489512552;5025.271335656327;3130.843457827111;5171.612129090315;5392.56859451243;5422.457754224585;5439.3200849893765;5379.946200537984;5426.104692725696;5426.21319908615;5428.5928555358305;5430.75561599727;4993.176125939216;5274.129768588178;5276.577873770089;5305.7877684892555;5318.175682769138;4966.404031516205;5049.520295571915;5059.2916991621205;5092.949070509285;5102.948970510284;11446.255993360404;11765.470553825098;11880.524779008916;11959.40202989847;12052.758944821142;2112.947176320589;2212.203606701586;2215.125025614889;2215.789499997498;2320.791128798416;9422.575984080733;9839.458829764431;10026.298159128864;11976.640700778991;14227.502037428743;1755.1662960093981;1844.5204246895769;1871.5508278013315;1920.1647283431612;1923.4902750771057;72972;75632.62183689102;75868.86196707109;76573.23426765772;77145.61427192828;9336.719898403058;9532.809343813224;9719.125278724807;9823.115919567274;9901.75245618851;12843.357832108544;12899.097063205672;12907.935460322638;12970.675733106558;12992.350382480838;7376.557406555624;7518;7723.420743444264;7758.844823103506;7794.805129871798;7034.3669069782945;7074.115735533059;7204.603746793872;7263.636818159071;7328;4012.598740125964;4019.8995025124023;4022.879313620596;4049.149678567475;4083.3670781028986;1671.966560668804;1758.5603599100225;1858.5260758506495;1896.1986113192247;1911.4447128341274;877.9473231605996;909.1771946388529;1030.4744580264119;1040.245821779204;1095.3592148593002;17661.7350739739;18024.188911499015;18326.175322110535;18646.160922758507;18899.527511812314;968.3270127261486;990.1237404896574;1002;1042.4214560918763;1071.9571217151383;9873.40759554429;10114.54484548197;10198.745031374126;10240.795184096276;10267.127294179929;303446;313929;315526;317475;474868;78566;80887.59556202182;93469.5326523363;93726.53136734273;94877;468.8195044907735;477.30313741936465;479.0180130731986;479.6834089500982;480.87737626904914;10029.448380339152;10397.792044159225;10619.840702389625;10713;10791.082757965662;34877.302453951284;35271.82364088163;35605.28789424145;35622.643773562966;36438.08495320421;51833;53875.56898348372;53956.73021634867;54461.72769136129;54596;8167.1424500428975;8193.426460147732;8321.95839020801;8393.748187554384;8403.873941890999;12402.503899844267;12871.678208044874;12899.419526121535;12949.417276222404;13149.802752958905;11041.889581104086;11198.888011119785;11212.607558735404;11356.94321528387;11583;10878.292910960763;10966.506507207354;11114.944425277821;11421.771564568828;11560.94219528897;11037.392943388191;11236.719082023015;11304.434778261219;11714.297142171497;11747.060235181336;7345.265473452612;7849.097353804385;8332.458390204618;8434.114417986024;8676.262517685815;10913.345199288067;10970.890291096986;10997.395143267197;11191.32852028881;11246.66260012201 10:27:57 INFO - PROCESS | 25910 | |3;mootools.html;1486.4797320937673;1506.6986602679463;1645.7695922570836;1729.0663041957343;1794.8205179482054;6662.9006213974635;7956.244156805102;8032.879506807402;8203.753887383373;8219.876701849476;8111.269985701286;8165.632546535406;8195.139510351417;8210.753677389674;8211.260986511214;2244.2145249162786;2299.7125359330084;2308.549832782608;2310.306907927615;2310.330004298751;2244.932652020434;2249.932502024942;2260.762619924909;2270.4437412833877;2287.8512896661664;2291.8510296830736;2296.047140436725;2302.320815359473;2304.320225533463;2309.203324852923;2235.5305385868987;2247.3932038349553;2259.751427342991;2269.841111122222;2269.886505674718;2193.802557769792;2207.7792220777956;2224.621814291558;2226.4545186429427;2239.104358256694;8092.919070809335;8191.303739182176;8232.300254478376;8234.176582341777;8237.299829514499;4875.8781030474165;5022.347094877679;5049.419316778581;5059.038782631288;5062.721550314731;3111.175538482304;3189.7448204143843;3241.173500757292;3250.869965201413;3251.1059458648824;1131.7227279316621;1141.1042331769604;1141.8287256911447;1145.6219447582362;1157.1841851494676;10987.61543345987;11028.172887033425;11046.281991670596;11097.72255693606;11106.555737770479;4330.372096046119;4339.305711086211;4380.102079073782;4483.586072306904;4505.391772110788;9345.672901448552;9355.625774968925;9391.248700103975;9397.201237894718;9428.575714092882;4867.440244371872;4897.681650692693;4942.5057494251005;4948.876278093005;4960.776765045582;3879.8060096995036;4500.617447516997;4549.772511374418;4563.927477042892;4581.358609794632;3685.94471082934;3791.7156213284115;3799.7910114943943;3862.1889403225077;3943.211357728466;1273.4269578689627;1294.58573256557;1299.9545015924398;1302.0690206502206;1306.660268330241;1353.2489468344966;1357.5045108535314;1382.9930850345886;1386.0367044903896;1391.325207274471;7615.466917315845;7825.491343062683;7844.568548729761;7848.450608457353;7901.367890568856;459.59325996492674;459.90342028174456;460.3233247126718;466.82027419443756;474.84092828902016;6025.15647809307;6138.294096178907;6138.508919286446;6144.539159563051;6180.567360284737;9606.375585586915;9769.364991275545;9798.216142708567;9821;9857.55640996157;9372.95313523428;9715.757106072404;9788.755281118029;9799.069088436587;9818.067283608047;7512.699492020367;7591.848163036598;7632.427567932427;7634.809129771689;7690.230976902265;7525.397968162643;7762.5342479449155;7769.72805951789;7771.805704857424;7892.447528673168;8900.955495222483;8910.910890891008;8948.373613847229;9005.05446928063;9033.638654454011;8820.955895220482;8962.32782541299;9078.54607269647;9136.451812891248;9166.220871225754;6472;6856.485763567653;6917.239103698488;6984.4063254623925;7153.928460715326;7277.090363704537;7356.264373562601;7365.373943214887;7410.407167426701;7447.329740323397;6910.516263861481;7167.928320716726;7187.101612298463;7278.163011253773;7347;6944.791656250321;6997.720091196499;7091.432685385053;7105.396041336544;7135.714571417086;7354.889676654748;7402.3707984821895;7479.738209162653;7577.962110189414;7584.962075189589;6802.3537763912345;6835.453163746988;6898.517103802686;6904.240533541206;6947.270536593787;6789.694463749044;6800.625965571941;6916.55042422241;6923.480738944499;6937 10:27:57 INFO - PROCESS | 25910 | |4;prototype.html;315.97472202223815;317.4492255935951;323.51957343345146;325.83545309618654;328.23848671083084;5902.911456328153;5966.925953328405;5990.940090599092;6000.279966404032;6004.249468816387;5812.244408226935;5855.297364316278;5869.618474799146;5897.675627840467;5944;4221.978890105545;4352.3471479278205;4486.865394038167;4502.707324023928;4520.2089634314025;4506.707064040843;4517.119161763458;4543.477500087482;4554.180247555455;4560.882583766966;4499.212637788391;4499.572540608653;4500.347449619803;4502.414686090804;4514.367988481616;4368.912621747563;4467.932981005288;4496.190685676577;4519.186546421643;4523.705959112647;3913.1391093959282;3921.1765529238896;3921.725479216456;3937.8424863005444;3945.3687410014545;5631.0708733059;5648.661080335152;5651.943480565183;5671.404502527216;5703.486686198262;5099.923501147486;5254.605904557136;5266.34170728659;5267.3942496613;5271.736413179326;6131.448169664752;6147.907781383283;6162.383761623802;6177.413145751191;6226.564140510166;4392.165488557164;4393.692441529094;4402.427684401039;4407.911841763179;4419.602235798793;6261.812145635593;6482.995135753966;6483.513736469784;6517.608943463408;6520.282768895418;4477.552244775497;4487.842925497592;4494.303382975644;4504.842330518416;4508.909821803545;4494.752788596593;4569.177548041318;4581.473130589959;4582.152301824173;4586.151561961048;5197.350331208599;5198.246254293106;5206.921896171485;5212.244224587414;5274.7626356814035;6293.433590976742;6305.306416294204;6342.365763423713;6345.206849143857;6348.619082855043;1479.5413421839048;1558.205315289188;1567.8275389707123;1576.4157022192624;1580.462642701487;955.0211033690523;1003.2124782046204;1017.064300843226;1027.5941003303653;1039.147898723055;5868.383819698955;5873.089671100986;5892.823215303548;5904.380040095728;5910.674912879746;6269.279032911182;6285.465735412449;6288.182536270256;6308.810735677937;6310.5898116622275;5741.827745167651;5871.6183448075735;5889.322727886348;5890.4698577128265;5903.583140046358;3363.142398688368;3379.9155021124175;3380.1042723678247;3394.7114495267683;3415.9316813663586;6398.072279519443;6446.4520515756685;6484.286728459866;6506.674666266667;6541.0188471729625;6442.194725659293;6454.515911306671;6498.642574658439;6508.866869537783;6512.641804700787;6269.811905642838;6507.34926507355;6521.576097553644;6527.216733991856;6534.705938232791;6249.375062493714;6255.5907030669305;6258.968705156445;6286.528510361833;6298.71655775482;6135.815925522242;6198.876022479615;6226.533010024357;6243.96878015607;6262.495001999237;6357.682115894279;6490.058941453369;6493.545451818327;6499.350064993652;6519.250286216956;4274.764887931194;4294.549072347483;4338.479382473997;4345.913081738411;4353.825846966086;6181.81454556364;6248.656323902047;6304.432601065926;6312.779052733133;6324.272708638381;6001.639901605918;6045.727942242522;6063.242094738158;6084.908726369196;6088.4824789893355;5978.641281523122;6024.668643224665;6092.939070609237;6108.6945652716295;6109.151234722274;6000.729967151401;6032.276126864629;6064.4541991221;6219.440250377488;6227.813165605039;6366;6380.170577825039;6381.457576106083;6386.93613063882;6414.166158399378;6004.669743164168;6234.189555357956;6237.812865614039;6244.625322480666;6265 10:27:57 INFO - PROCESS | 25910 | |5;yui.html;776.440962506995;819.3977426591458;830.0869044051544;835.2107258640583;876.5529579914249;12880.484780608776;13889.583312500616;14980;15021.849781502167;15049.62375940602;13195.60413187606;13472.393742281596;13531.864681353183;13583.93208033961;13584.524541641045;672.7880717573948;800.0519384529351;832.4339449174558;833.204289903141;833.5873742497442;797.0515087046425;808.3169721585251;814.1004190369645;820.4543978254453;820.7783898347443;830.0744669693279;852.1350828908662;852.5183271451641;855.0893298636963;858.0432817408607;822.0792712162387;840.1304649687575;844.5059640110543;844.7001314533375;845.0577605969362;615.5906322295668;621.8507558186049;626.764963138823;626.9937300626981;629.5750368501289;14305.78541321881;14336.56990290293;14347.856521434756;14389.856101438956;14408.423663053465;14279;14319.140851548837;14320.283985800668;14354.282285885663;14366.066205696701;10657.733556661067;10666.520006599721;10781.299215551042;10804.837927431096;11014.559417623286;3804.410316400962;3839.6352346527037;3944.6252606002386;3974.3641017437362;4033.858814941463;51928.22107668388;52163.73918130423;53266;53733;54006.18990715143;10339.224558158168;10423.5830566778;10434.791304174027;10617.628383006711;10636.149108071335;17768.91115544414;17772.200250988735;17802;17826.643467130583;18234.544136396697;8028.839423211503;8072.757817265491;8113.310368618615;8115.756527304072;8159.632816523271;4714.5992590630185;4724.291356296583;4732.621390288768;4759.571638552547;4802.303665968415;3175.4601717708047;3295.1597342677464;3301.884434044845;3307.470804671289;3309.8014119152926;595.4611076975344;607.1166452811149;608.7230310208845;619.3249358199585;623.0685125736961;631.4537924695105;761.147514783435;763.4770182425057;777.4480119115378;798.8601994650912;8267.751967440987;8447.577621118919;8506.447080939843;8586.613602387908;8745.256653184551;750.2834792772888;758.6586036283584;768.0859776865512;783.0916137280727;783.50247592779;4030.496187976503;4116.9794151029055;4122.958770412258;4133.731307465006;4168.73301461982;56781;56970.715146424;57059;57450.42549574451;57948;51065.234021489705;51528;52384.21423678648;52975.47024529782;52982.205266921024;46290.53709462862;47173.29240061402;47406.76296618495;47556.2866556995;47673;7697.846043078995;7952;7979.122296547491;8064.677412903418;8131.105578386255;32102.35795284128;32194.839025804722;32348.514772277966;32471.512927306583;33034.83482582572;40145.59854401419;41789;43132.68673132662;43241.567584325014;43609.781951090044;11311;11494.655160345203;11610.419479026184;11773;12037.939810300892;12174.57388991381;13710.24593647359;13958.58124256274;14140.717185656024;14195.148291102567;12177;12210.816837747263;12214.206076604993;12268;12702.983761298889;12542.1847579907;12851;12887.677808054874;13040.804387934379;13366.599002029954;11097.944510277719;11350.716232094264;11584.420778961186;12068.034557235576;12770.744585108432;9779.462129582942;9828.803423931624;10011.749706257111;10058.446785426579;10348.53431595595;10089.949550252202;10258.743531411774;10292;10323.690289291333;10349.9482502587 10:27:57 INFO - PROCESS | 25910 | __end_tp_report 10:27:57 INFO - PROCESS | 25910 | __start_cc_report 10:27:57 INFO - PROCESS | 25910 | _x_x_mozilla_cycle_collect,341 10:27:57 INFO - PROCESS | 25910 | __end_cc_report 10:27:57 INFO - PROCESS | 25910 | __startTimestamp1460482077877__endTimestamp 10:27:57 INFO - PROCESS | 25910 | 10:27:57 INFO - PROCESS | 25910 | ------- Summary: start ------- 10:27:57 INFO - PROCESS | 25910 | Number of tests: 6 10:27:57 INFO - PROCESS | 25910 | 10:27:57 INFO - PROCESS | 25910 | [#0] dojo.html Cycles:165 Average:5419.39 Median:5612.92 stddev:611.56 (10.9%) stddev-sans-first:586.99 10:27:57 INFO - PROCESS | 25910 | Values: 3151.5 3214.7 3239.3 3274.2 3300.0 5383.8 5393.7 5395.1 5423.2 5428.5 5341.4 5431.9 5517.8 5528.0 5547.9 4903.6 4932.7 4972.2 5020.8 5038.7 4952.0 5024.9 5074.0 5085.5 5137.0 4861.9 4864.8 4888.6 4921.5 4924.4 4915.1 4931.1 4937.5 4948.7 4973.4 4894.8 4897.3 4899.0 4901.1 4915.1 5281.8 5325.7 5343.9 5346.0 5350.2 5827.2 5832.7 5840.8 5848.3 5862.6 5748.6 5836.6 5899.9 5924.4 5931.3 5453.4 5473.2 5492.7 5499.1 5542.7 5938.7 5996.3 5997.5 5999.6 6001.2 5646.8 5689.9 5757.2 5772.9 5783.9 5886.7 5914.7 5928.1 5928.3 5951.6 5717.1 5811.2 5857.9 5883.7 5943.8 5670.5 5677.7 5777.9 5779.5 5783.9 4398.5 4403.3 4403.4 4408.2 4451.8 3980.6 3986.2 3999.2 4007.5 4023.4 5567.9 5633.2 5636.9 5646.7 5682.1 5828.4 5879.0 5879.9 5882.1 5907.8 5522.8 5558.7 5559.3 5565.2 5576.2 4868.8 4959.4 5000.0 5008.3 5034.1 5906.2 5952.4 5961.0 5964.1 5989.9 5807.7 5810.9 5817.9 5822.8 5823.6 5872.4 6072.4 6105.6 6124.6 6138.4 5710.3 5714.9 5721.0 5733.1 5787.9 5716.9 5820.8 5829.2 5840.6 5842.5 5713.5 5752.5 5791.8 5803.9 5831.8 5564.8 5702.9 5722.2 5737.2 5741.8 5517.2 5592.8 5595.8 5612.9 5612.9 5593.6 5667.9 5741.9 5841.5 5864.7 5547.9 5568.1 5585.0 5591.9 5612.2 10:27:57 INFO - PROCESS | 25910 | 10:27:57 INFO - PROCESS | 25910 | [#1] ext.html Cycles:180 Average:53377.70 Median:37387.41 stddev:112151.99 (300.0%) stddev-sans-first:112396.63 10:27:57 INFO - PROCESS | 25910 | Values: 611.4 631.5 646.1 655.1 684.6 37474.8 37522.2 37771.6 37790.6 38977.0 39012.0 39132.4 39178.0 39363.0 39396.0 8500.2 8676.9 8693.5 8696.6 8731.2 8562.2 8912.6 8913.5 8915.8 8917.2 8884.2 8990.9 8993.0 8993.3 9001.2 8869.4 8896.8 8904.6 8912.4 8963.5 8683.7 8725.3 8776.5 8809.0 8832.6 33615.2 39099.6 39652.2 39660.2 39664.2 3336.8 3499.2 3516.5 3554.9 3577.3 26236.2 26876.3 28329.2 28331.3 28747.1 4045.8 4050.3 4054.7 4097.2 4112.2 220880.0 221111.0 223310.0 224664.0 225742.0 31495.5 31536.4 32184.0 32251.7 33107.5 31540.7 31802.5 31821.0 31864.0 33004.3 13904.7 14096.0 14132.1 14144.4 14178.2 12595.4 12712.2 12732.7 12828.4 12858.3 7517.3 7595.5 7616.7 7657.1 7687.5 2886.2 2897.8 2931.7 2939.8 2943.6 971.5 979.3 1035.6 1039.3 1192.9 30572.0 30981.0 31623.7 31891.8 32316.2 1003.9 1078.1 1112.6 1127.3 1139.5 15272.2 15550.7 15673.2 15733.2 15789.2 446184.0 562108.0 577313.0 578523.0 587507.0 57058.7 57951.0 58033.1 58329.0 58358.4 1353.3 1373.5 1375.7 1400.2 1403.6 30219.2 31079.7 31264.7 31372.4 31915.0 48517.5 49295.8 49423.0 49512.8 49638.3 412178.0 414318.0 414890.0 415720.0 418270.0 26255.2 26653.7 26753.5 26758.3 42868.4 43195.8 43211.8 43287.6 47234.0 48637.8 35877.0 36070.3 36407.0 36655.5 37018.0 36500.0 37237.8 37300.0 37648.0 37937.8 37518.1 39745.2 40620.4 41111.2 41548.8 31016.7 32314.0 32723.5 32811.7 32879.7 25483.6 25545.7 25896.7 26195.3 26269.9 10:27:57 INFO - PROCESS | 25910 | 10:27:57 INFO - PROCESS | 25910 | [#2] jquery.html Cycles:180 Average:23487.96 Median:35613.97 stddev:58839.00 (165.2%) stddev-sans-first:58978.46 10:27:57 INFO - PROCESS | 25910 | Values: 373.3 374.9 377.3 377.9 383.8 17956.7 18189.5 18254.9 19004.5 19081.3 16406.3 16545.6 16913.0 17091.9 17367.8 4884.5 5015.7 5020.2 5021.0 5025.3 3130.8 5171.6 5392.6 5422.5 5439.3 5379.9 5426.1 5426.2 5428.6 5430.8 4993.2 5274.1 5276.6 5305.8 5318.2 4966.4 5049.5 5059.3 5092.9 5102.9 11446.3 11765.5 11880.5 11959.4 12052.8 2112.9 2212.2 2215.1 2215.8 2320.8 9422.6 9839.5 10026.3 11976.6 14227.5 1755.2 1844.5 1871.6 1920.2 1923.5 72972.0 75632.6 75868.9 76573.2 77145.6 9336.7 9532.8 9719.1 9823.1 9901.8 12843.4 12899.1 12907.9 12970.7 12992.4 7376.6 7518.0 7723.4 7758.8 7794.8 7034.4 7074.1 7204.6 7263.6 7328.0 4012.6 4019.9 4022.9 4049.1 4083.4 1672.0 1758.6 1858.5 1896.2 1911.4 877.9 909.2 1030.5 1040.2 1095.4 17661.7 18024.2 18326.2 18646.2 18899.5 968.3 990.1 1002.0 1042.4 1072.0 9873.4 10114.5 10198.7 10240.8 10267.1 303446.0 313929.0 315526.0 317475.0 474868.0 78566.0 80887.6 93469.5 93726.5 94877.0 468.8 477.3 479.0 479.7 480.9 10029.4 10397.8 10619.8 10713.0 10791.1 34877.3 35271.8 35605.3 35622.6 36438.1 51833.0 53875.6 53956.7 54461.7 54596.0 8167.1 8193.4 8322.0 8393.7 8403.9 12402.5 12871.7 12899.4 12949.4 13149.8 11041.9 11198.9 11212.6 11356.9 11583.0 10878.3 10966.5 11114.9 11421.8 11560.9 11037.4 11236.7 11304.4 11714.3 11747.1 7345.3 7849.1 8332.5 8434.1 8676.3 10913.3 10970.9 10997.4 11191.3 11246.7 10:27:57 INFO - PROCESS | 25910 | 10:27:57 INFO - PROCESS | 25910 | [#3] mootools.html Cycles:180 Average:5670.02 Median:6567.45 stddev:2973.35 (45.3%) stddev-sans-first:2965.06 10:27:57 INFO - PROCESS | 25910 | Values: 1486.5 1506.7 1645.8 1729.1 1794.8 6662.9 7956.2 8032.9 8203.8 8219.9 8111.3 8165.6 8195.1 8210.8 8211.3 2244.2 2299.7 2308.5 2310.3 2310.3 2244.9 2249.9 2260.8 2270.4 2287.9 2291.9 2296.0 2302.3 2304.3 2309.2 2235.5 2247.4 2259.8 2269.8 2269.9 2193.8 2207.8 2224.6 2226.5 2239.1 8092.9 8191.3 8232.3 8234.2 8237.3 4875.9 5022.3 5049.4 5059.0 5062.7 3111.2 3189.7 3241.2 3250.9 3251.1 1131.7 1141.1 1141.8 1145.6 1157.2 10987.6 11028.2 11046.3 11097.7 11106.6 4330.4 4339.3 4380.1 4483.6 4505.4 9345.7 9355.6 9391.2 9397.2 9428.6 4867.4 4897.7 4942.5 4948.9 4960.8 3879.8 4500.6 4549.8 4563.9 4581.4 3685.9 3791.7 3799.8 3862.2 3943.2 1273.4 1294.6 1300.0 1302.1 1306.7 1353.2 1357.5 1383.0 1386.0 1391.3 7615.5 7825.5 7844.6 7848.5 7901.4 459.6 459.9 460.3 466.8 474.8 6025.2 6138.3 6138.5 6144.5 6180.6 9606.4 9769.4 9798.2 9821.0 9857.6 9373.0 9715.8 9788.8 9799.1 9818.1 7512.7 7591.8 7632.4 7634.8 7690.2 7525.4 7762.5 7769.7 7771.8 7892.4 8901.0 8910.9 8948.4 9005.1 9033.6 8821.0 8962.3 9078.5 9136.5 9166.2 6472.0 6856.5 6917.2 6984.4 7153.9 7277.1 7356.3 7365.4 7410.4 7447.3 6910.5 7167.9 7187.1 7278.2 7347.0 6944.8 6997.7 7091.4 7105.4 7135.7 7354.9 7402.4 7479.7 7578.0 7585.0 6802.4 6835.5 6898.5 6904.2 6947.3 6789.7 6800.6 6916.6 6923.5 6937.0 10:27:57 INFO - PROCESS | 25910 | 10:27:57 INFO - PROCESS | 25910 | [#4] prototype.html Cycles:180 Average:5175.96 Median:5903.25 stddev:1547.31 (26.2%) stddev-sans-first:1508.04 10:27:57 INFO - PROCESS | 25910 | Values: 316.0 317.4 323.5 325.8 328.2 5902.9 5966.9 5990.9 6000.3 6004.2 5812.2 5855.3 5869.6 5897.7 5944.0 4222.0 4352.3 4486.9 4502.7 4520.2 4506.7 4517.1 4543.5 4554.2 4560.9 4499.2 4499.6 4500.3 4502.4 4514.4 4368.9 4467.9 4496.2 4519.2 4523.7 3913.1 3921.2 3921.7 3937.8 3945.4 5631.1 5648.7 5651.9 5671.4 5703.5 5099.9 5254.6 5266.3 5267.4 5271.7 6131.4 6147.9 6162.4 6177.4 6226.6 4392.2 4393.7 4402.4 4407.9 4419.6 6261.8 6483.0 6483.5 6517.6 6520.3 4477.6 4487.8 4494.3 4504.8 4508.9 4494.8 4569.2 4581.5 4582.2 4586.2 5197.4 5198.2 5206.9 5212.2 5274.8 6293.4 6305.3 6342.4 6345.2 6348.6 1479.5 1558.2 1567.8 1576.4 1580.5 955.0 1003.2 1017.1 1027.6 1039.1 5868.4 5873.1 5892.8 5904.4 5910.7 6269.3 6285.5 6288.2 6308.8 6310.6 5741.8 5871.6 5889.3 5890.5 5903.6 3363.1 3379.9 3380.1 3394.7 3415.9 6398.1 6446.5 6484.3 6506.7 6541.0 6442.2 6454.5 6498.6 6508.9 6512.6 6269.8 6507.3 6521.6 6527.2 6534.7 6249.4 6255.6 6259.0 6286.5 6298.7 6135.8 6198.9 6226.5 6244.0 6262.5 6357.7 6490.1 6493.5 6499.4 6519.3 4274.8 4294.5 4338.5 4345.9 4353.8 6181.8 6248.7 6304.4 6312.8 6324.3 6001.6 6045.7 6063.2 6084.9 6088.5 5978.6 6024.7 6092.9 6108.7 6109.2 6000.7 6032.3 6064.5 6219.4 6227.8 6366.0 6380.2 6381.5 6386.9 6414.2 6004.7 6234.2 6237.8 6244.6 6265.0 10:27:57 INFO - PROCESS | 25910 | 10:27:57 INFO - PROCESS | 25910 | [#5] yui.html Cycles:180 Average:14173.43 Median:43187.13 stddev:16087.19 (37.2%) stddev-sans-first:16100.86 10:27:57 INFO - PROCESS | 25910 | Values: 776.4 819.4 830.1 835.2 876.6 12880.5 13889.6 14980.0 15021.8 15049.6 13195.6 13472.4 13531.9 13583.9 13584.5 672.8 800.1 832.4 833.2 833.6 797.1 808.3 814.1 820.5 820.8 830.1 852.1 852.5 855.1 858.0 822.1 840.1 844.5 844.7 845.1 615.6 621.9 626.8 627.0 629.6 14305.8 14336.6 14347.9 14389.9 14408.4 14279.0 14319.1 14320.3 14354.3 14366.1 10657.7 10666.5 10781.3 10804.8 11014.6 3804.4 3839.6 3944.6 3974.4 4033.9 51928.2 52163.7 53266.0 53733.0 54006.2 10339.2 10423.6 10434.8 10617.6 10636.1 17768.9 17772.2 17802.0 17826.6 18234.5 8028.8 8072.8 8113.3 8115.8 8159.6 4714.6 4724.3 4732.6 4759.6 4802.3 3175.5 3295.2 3301.9 3307.5 3309.8 595.5 607.1 608.7 619.3 623.1 631.5 761.1 763.5 777.4 798.9 8267.8 8447.6 8506.4 8586.6 8745.3 750.3 758.7 768.1 783.1 783.5 4030.5 4117.0 4123.0 4133.7 4168.7 56781.0 56970.7 57059.0 57450.4 57948.0 51065.2 51528.0 52384.2 52975.5 52982.2 46290.5 47173.3 47406.8 47556.3 47673.0 7697.8 7952.0 7979.1 8064.7 8131.1 32102.4 32194.8 32348.5 32471.5 33034.8 40145.6 41789.0 43132.7 43241.6 43609.8 11311.0 11494.7 11610.4 11773.0 12037.9 12174.6 13710.2 13958.6 14140.7 14195.1 12177.0 12210.8 12214.2 12268.0 12703.0 12542.2 12851.0 12887.7 13040.8 13366.6 11097.9 11350.7 11584.4 12068.0 12770.7 9779.5 9828.8 10011.7 10058.4 10348.5 10089.9 10258.7 10292.0 10323.7 10349.9 10:27:57 INFO - PROCESS | 25910 | -------- Summary: end -------- 10:27:57 INFO - PROCESS | 25910 | 10:27:58 INFO - TEST-INFO | 25910: exit 0 10:27:58 INFO - TEST-OK | dromaeo_css | took 1110042ms 10:27:58 INFO - TEST-START | kraken 10:27:58 INFO - operating with platform_type : linux_ 10:27:58 INFO - Initialising browser for kraken test... 10:27:58 INFO - TEST-INFO | started process 26146 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsQWY9L/profile http://localhost:36959/getInfo.html) 10:28:02 INFO - PROCESS | 26146 | 10:28:02 INFO - PROCESS | 26146 | (process:26217): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:28:02 INFO - PROCESS | 26146 | JavaScript error: jar:file:///builds/slave/test-pgo/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 10:28:02 INFO - PROCESS | 26146 | __metrics Screen width/height:1600/1200 10:28:02 INFO - PROCESS | 26146 | colorDepth:24 10:28:02 INFO - PROCESS | 26146 | Browser inner width/height: 1024/697 10:28:02 INFO - PROCESS | 26146 | __metrics 10:28:03 ERROR - PROCESS | 26146 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 10:28:04 INFO - TEST-INFO | 26146: exit 0 10:28:04 INFO - Browser initialized. 10:28:04 INFO - Running cycle 1/1 for kraken test... 10:28:04 INFO - TEST-INFO | started process 26268 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsQWY9L/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:28:05 INFO - PROCESS | 26268 | 10:28:05 INFO - PROCESS | 26268 | (process:26329): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:28:16 INFO - PROCESS | 26268 | RSS: Main: 163438592 10:28:16 INFO - PROCESS | 26268 | 10:28:18 INFO - PROCESS | 26268 | Cycle 1(1): loaded http://localhost:36959/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36959/tests/kraken/driver.html?testName=audio-beat-detection) 10:28:19 INFO - PROCESS | 26268 | RSS: Main: 167849984 10:28:19 INFO - PROCESS | 26268 | 10:28:22 INFO - PROCESS | 26268 | Cycle 1(1): loaded http://localhost:36959/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36959/tests/kraken/driver.html?testName=audio-dft) 10:28:22 INFO - PROCESS | 26268 | RSS: Main: 171593728 10:28:22 INFO - PROCESS | 26268 | 10:28:25 INFO - PROCESS | 26268 | Cycle 1(1): loaded http://localhost:36959/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36959/tests/kraken/driver.html?testName=audio-fft) 10:28:26 INFO - PROCESS | 26268 | RSS: Main: 164179968 10:28:26 INFO - PROCESS | 26268 | 10:28:28 INFO - PROCESS | 26268 | Cycle 1(1): loaded http://localhost:36959/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36959/tests/kraken/driver.html?testName=audio-oscillator) 10:28:28 INFO - PROCESS | 26268 | RSS: Main: 163971072 10:28:28 INFO - PROCESS | 26268 | 10:28:31 INFO - PROCESS | 26268 | Cycle 1(1): loaded http://localhost:36959/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36959/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:28:31 INFO - PROCESS | 26268 | RSS: Main: 165036032 10:28:31 INFO - PROCESS | 26268 | 10:28:34 INFO - PROCESS | 26268 | Cycle 1(1): loaded http://localhost:36959/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36959/tests/kraken/driver.html?testName=imaging-darkroom) 10:28:35 INFO - PROCESS | 26268 | RSS: Main: 164900864 10:28:35 INFO - PROCESS | 26268 | 10:28:38 INFO - PROCESS | 26268 | Cycle 1(1): loaded http://localhost:36959/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36959/tests/kraken/driver.html?testName=imaging-desaturate) 10:28:39 INFO - PROCESS | 26268 | RSS: Main: 164966400 10:28:39 INFO - PROCESS | 26268 | 10:28:42 INFO - PROCESS | 26268 | Cycle 1(1): loaded http://localhost:36959/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36959/tests/kraken/driver.html?testName=json-parse-financial) 10:28:42 INFO - PROCESS | 26268 | RSS: Main: 165007360 10:28:42 INFO - PROCESS | 26268 | 10:28:44 INFO - PROCESS | 26268 | Cycle 1(1): loaded http://localhost:36959/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36959/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:28:45 INFO - PROCESS | 26268 | RSS: Main: 165613568 10:28:45 INFO - PROCESS | 26268 | 10:28:46 INFO - PROCESS | 26268 | Cycle 1(1): loaded http://localhost:36959/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36959/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:28:47 INFO - PROCESS | 26268 | RSS: Main: 165416960 10:28:47 INFO - PROCESS | 26268 | 10:28:49 INFO - PROCESS | 26268 | Cycle 1(1): loaded http://localhost:36959/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36959/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:28:50 INFO - PROCESS | 26268 | RSS: Main: 165654528 10:28:50 INFO - PROCESS | 26268 | 10:28:52 INFO - PROCESS | 26268 | Cycle 1(1): loaded http://localhost:36959/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36959/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:28:53 INFO - PROCESS | 26268 | RSS: Main: 166125568 10:28:53 INFO - PROCESS | 26268 | 10:28:56 INFO - PROCESS | 26268 | Cycle 1(1): loaded http://localhost:36959/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36959/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:28:56 INFO - PROCESS | 26268 | RSS: Main: 166309888 10:28:56 INFO - PROCESS | 26268 | 10:28:58 INFO - PROCESS | 26268 | Cycle 1(1): loaded http://localhost:36959/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36959/tests/kraken/driver.html?testName=ai-astar) 10:28:58 INFO - PROCESS | 26268 | RSS: Main: 167243776 10:28:58 INFO - PROCESS | 26268 | 10:28:58 INFO - PROCESS | 26268 | __start_tp_report 10:28:58 INFO - PROCESS | 26268 | _x_x_mozilla_page_load 10:28:58 INFO - PROCESS | 26268 | _x_x_mozilla_page_load_details 10:28:58 INFO - PROCESS | 26268 | |i|pagename|runs| 10:28:58 INFO - PROCESS | 26268 | |0;ai-astar;112;106;112;112;111;126;114;112;112;111 10:28:58 INFO - PROCESS | 26268 | |1;audio-beat-detection;153;131;156;184;135;155;147;127;181;129 10:28:58 INFO - PROCESS | 26268 | |2;audio-dft;163;163;164;161;163;165;174;167;165;165 10:28:58 INFO - PROCESS | 26268 | |3;audio-fft;76;75;76;156;77;77;75;75;167;77 10:28:58 INFO - PROCESS | 26268 | |4;audio-oscillator;98;93;160;96;97;94;151;92;92;155 10:28:58 INFO - PROCESS | 26268 | |5;imaging-gaussian-blur;118;118;118;118;118;118;118;117;117;120 10:28:58 INFO - PROCESS | 26268 | |6;imaging-darkroom;146;146;147;147;146;146;146;146;146;146 10:28:58 INFO - PROCESS | 26268 | |7;imaging-desaturate;95;96;97;96;96;96;96;95;96;96 10:28:58 INFO - PROCESS | 26268 | |8;json-parse-financial;57;57;57;55;58;57;56;78;55;55 10:28:58 INFO - PROCESS | 26268 | |9;json-stringify-tinderbox;66;65;64;64;66;64;64;65;64;66 10:28:58 INFO - PROCESS | 26268 | |10;stanford-crypto-aes;80;79;79;79;80;89;81;80;81;82 10:28:58 INFO - PROCESS | 26268 | |11;stanford-crypto-ccm;134;128;130;127;138;129;129;139;160;128 10:28:58 INFO - PROCESS | 26268 | |12;stanford-crypto-pbkdf2;165;166;162;164;166;164;165;166;162;161 10:28:58 INFO - PROCESS | 26268 | |13;stanford-crypto-sha256-iterative;67;68;69;70;65;75;69;68;66;67 10:28:58 INFO - PROCESS | 26268 | __end_tp_report 10:28:58 INFO - PROCESS | 26268 | __start_cc_report 10:28:58 INFO - PROCESS | 26268 | _x_x_mozilla_cycle_collect,835 10:28:58 INFO - PROCESS | 26268 | __end_cc_report 10:28:58 INFO - PROCESS | 26268 | __startTimestamp1460482138815__endTimestamp 10:28:58 INFO - PROCESS | 26268 | 10:28:58 INFO - PROCESS | 26268 | ------- Summary: start ------- 10:28:58 INFO - PROCESS | 26268 | Number of tests: 14 10:28:58 INFO - PROCESS | 26268 | 10:28:58 INFO - PROCESS | 26268 | [#0] ai-astar Cycles:10 Average:112.80 Median:112.00 stddev:5.07 (4.5%) stddev-sans-first:5.37 10:28:58 INFO - PROCESS | 26268 | Values: 112.0 106.0 112.0 112.0 111.0 126.0 114.0 112.0 112.0 111.0 10:28:58 INFO - PROCESS | 26268 | 10:28:58 INFO - PROCESS | 26268 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:154.00 stddev:20.42 (13.3%) stddev-sans-first:21.62 10:28:58 INFO - PROCESS | 26268 | Values: 153.0 131.0 156.0 184.0 135.0 155.0 147.0 127.0 181.0 129.0 10:28:58 INFO - PROCESS | 26268 | 10:28:58 INFO - PROCESS | 26268 | [#2] audio-dft Cycles:10 Average:165.00 Median:165.00 stddev:3.56 (2.2%) stddev-sans-first:3.70 10:28:58 INFO - PROCESS | 26268 | Values: 163.0 163.0 164.0 161.0 163.0 165.0 174.0 167.0 165.0 165.0 10:28:58 INFO - PROCESS | 26268 | 10:28:58 INFO - PROCESS | 26268 | [#3] audio-fft Cycles:10 Average:93.10 Median:76.00 stddev:36.15 (47.6%) stddev-sans-first:37.81 10:28:58 INFO - PROCESS | 26268 | Values: 76.0 75.0 76.0 156.0 77.0 77.0 75.0 75.0 167.0 77.0 10:28:58 INFO - PROCESS | 26268 | 10:28:58 INFO - PROCESS | 26268 | [#4] audio-oscillator Cycles:10 Average:112.80 Median:93.50 stddev:29.50 (31.5%) stddev-sans-first:30.79 10:28:58 INFO - PROCESS | 26268 | Values: 98.0 93.0 160.0 96.0 97.0 94.0 151.0 92.0 92.0 155.0 10:28:58 INFO - PROCESS | 26268 | 10:28:58 INFO - PROCESS | 26268 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 10:28:58 INFO - PROCESS | 26268 | Values: 118.0 118.0 118.0 118.0 118.0 118.0 118.0 117.0 117.0 120.0 10:28:58 INFO - PROCESS | 26268 | 10:28:58 INFO - PROCESS | 26268 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 10:28:58 INFO - PROCESS | 26268 | Values: 146.0 146.0 147.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 10:28:58 INFO - PROCESS | 26268 | 10:28:58 INFO - PROCESS | 26268 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 10:28:58 INFO - PROCESS | 26268 | Values: 95.0 96.0 97.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 10:28:58 INFO - PROCESS | 26268 | 10:28:58 INFO - PROCESS | 26268 | [#8] json-parse-financial Cycles:10 Average:58.50 Median:57.00 stddev:6.93 (12.2%) stddev-sans-first:7.33 10:28:58 INFO - PROCESS | 26268 | Values: 57.0 57.0 57.0 55.0 58.0 57.0 56.0 78.0 55.0 55.0 10:28:58 INFO - PROCESS | 26268 | 10:28:58 INFO - PROCESS | 26268 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.92 (1.4%) stddev-sans-first:0.87 10:28:58 INFO - PROCESS | 26268 | Values: 66.0 65.0 64.0 64.0 66.0 64.0 64.0 65.0 64.0 66.0 10:28:58 INFO - PROCESS | 26268 | 10:28:58 INFO - PROCESS | 26268 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:80.50 stddev:2.98 (3.7%) stddev-sans-first:3.14 10:28:58 INFO - PROCESS | 26268 | Values: 80.0 79.0 79.0 79.0 80.0 89.0 81.0 80.0 81.0 82.0 10:28:58 INFO - PROCESS | 26268 | 10:28:58 INFO - PROCESS | 26268 | [#11] stanford-crypto-ccm Cycles:10 Average:134.20 Median:132.00 stddev:10.02 (7.6%) stddev-sans-first:10.63 10:28:58 INFO - PROCESS | 26268 | Values: 134.0 128.0 130.0 127.0 138.0 129.0 129.0 139.0 160.0 128.0 10:28:58 INFO - PROCESS | 26268 | 10:28:58 INFO - PROCESS | 26268 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.10 Median:165.00 stddev:1.85 (1.1%) stddev-sans-first:1.94 10:28:58 INFO - PROCESS | 26268 | Values: 165.0 166.0 162.0 164.0 166.0 164.0 165.0 166.0 162.0 161.0 10:28:58 INFO - PROCESS | 26268 | 10:28:58 INFO - PROCESS | 26268 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:2.76 (4.0%) stddev-sans-first:2.88 10:28:58 INFO - PROCESS | 26268 | Values: 67.0 68.0 69.0 70.0 65.0 75.0 69.0 68.0 66.0 67.0 10:28:58 INFO - PROCESS | 26268 | -------- Summary: end -------- 10:28:58 INFO - PROCESS | 26268 | 10:28:59 INFO - TEST-INFO | 26268: exit 0 10:28:59 INFO - TEST-OK | kraken | took 61201ms 10:28:59 INFO - SUITE-END | took 1171s 10:28:59 INFO - Completed test suite (00:19:31) 10:28:59 INFO - javascript benchmark 10:29:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3151.4800057990433, 3214.7428205743545, 3239.2549713565863, 3274.2469232076623, 3299.983500082499, 5383.784648614051, 5393.73031348433, 5395.0558652235895, 5423.240746295517, 5428.538574221191, 5341.385740639827, 5431.945680543194, 5517.834464966048, 5527.972360138204, 5547.861303467415, 4903.558679718833, 4932.654714170009, 4972.179590367585, 5020.824271150511, 5038.7228702421535, 4951.950480495203, 5024.899502009957, 5073.974630126844, 5085.516875896784, 5136.974315128419, 4861.927071093919, 4864.805407783684, 4888.560029597354, 4921.458639549646, 4924.409070911478, 4915.090708218991, 4931.112399768041, 4937.456879743226, 4948.678335908155, 4973.403191616993, 4894.828680996148, 4897.2898929655, 4899.044686286175, 4901.142300097468, 4915.115279249733, 5281.841544753664, 5325.733713314319, 5343.946560534423, 5346.0, 5350.197470379435, 5827.242458480413, 5832.650040997553, 5840.795572154997, 5848.327442344143, 5862.560307976919, 5748.5975981681295, 5836.649801011953, 5899.882002359972, 5924.407559244084, 5931.288245410536, 5453.400125986138, 5473.233747275384, 5492.697901615409, 5499.1476321170285, 5542.722863856791, 5938.732757025858, 5996.310424301174, 5997.520198384119, 5999.580029397987, 6001.1898393717165, 5646.802361917313, 5689.857753556194, 5757.222774925415, 5772.94227057724, 5783.929972955017, 5886.676232807236, 5914.674692891932, 5928.140419639214, 5928.258967629046, 5951.553633477506, 5717.113847353667, 5811.2445382100905, 5857.853553661193, 5883.676397798076, 5943.762249510058, 5670.461306175906, 5677.744501497443, 5777.855553611109, 5779.479846813807, 5783.942160578425, 4398.516163222043, 4403.251447253974, 4403.427554417969, 4408.162449134654, 4451.844185453559, 3980.6218409251073, 3986.1629057897585, 3999.1601763629383, 4007.5391329997424, 4023.396490526386, 5567.860803479945, 5633.211350410946, 5636.915446268309, 5646.71766411686, 5682.090865461589, 5828.358880523139, 5879.029960056543, 5879.911801322984, 5882.147088672119, 5907.793227237112, 5522.779088836402, 5558.749856256478, 5559.33288005442, 5565.165225216169, 5576.247206627135, 4868.78090485929, 4959.380077490314, 4999.975000124976, 5008.298838162587, 5034.093863104603, 5906.173135760997, 5952.434518720715, 5961.046232602763, 5964.075568286922, 5989.880202395928, 5807.709614519342, 5810.854728631818, 5817.941820581909, 5822.796202132905, 5823.563232757476, 5872.442117998783, 6072.392760723892, 6105.641708308169, 6124.626121635095, 6138.447539721446, 5710.314762228393, 5714.885702286014, 5721.027425337619, 5733.111367738007, 5787.8553036174435, 5716.8570785729025, 5820.796272130455, 5829.213056237523, 5840.591158618856, 5842.503387212135, 5713.514351280021, 5752.539796816161, 5791.797287094932, 5803.9419605803405, 5831.825045248649, 5564.77740890376, 5702.942970570241, 5722.17028530869, 5737.196792449144, 5741.770329186953, 5517.200005999188, 5592.7762889483965, 5595.804146854841, 5612.8877422450505, 5612.915806262991, 5593.552515798645, 5667.858303542444, 5741.885162296647, 5841.474267315962, 5864.706764661664, 5547.8890422190525, 5568.081266590967, 5585.0, 5591.8881622368135, 5612.158176273591], "value": 5378.853095442574, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.4008271893545, 631.5263552335748, 646.095466347114, 655.1384928818603, 684.6131935456464, 37474.812625936866, 37522.249555008886, 37771.62228377716, 37790.622093779086, 38977.0, 39012.0, 39132.41301380481, 39178.0, 39363.0, 39396.0, 8500.234978851886, 8676.8698469523, 8693.478391296543, 8696.608652610616, 8731.214190722834, 8562.186592273754, 8912.64349426022, 8913.465192088463, 8915.821683566324, 8917.242034427081, 8884.156005179497, 8990.865137022949, 8993.010768815426, 8993.28053755698, 9001.23489503393, 8869.37914345996, 8896.822063558757, 8904.554772261394, 8912.420692654956, 8963.462192268453, 8683.696070637561, 8725.254949010223, 8776.473411595261, 8808.955955220183, 8832.646694132227, 33615.15962100943, 39099.60900391017, 39652.20695586101, 39660.20679586421, 39664.20671586552, 3336.7664263501565, 3499.24766175271, 3516.507688923527, 3554.9111272218142, 3577.3024260269, 26236.21291361243, 26876.328091797863, 28329.150125496268, 28331.291717707016, 28747.13758587225, 4045.7572545647063, 4050.2591268000506, 4054.736442131252, 4097.221527909687, 4112.177564487085, 220880.0, 221111.0, 223310.0, 224664.0, 225742.0, 31495.527567086512, 31536.369272614418, 32184.0, 32251.677483224867, 33107.51016204277, 31540.684593154234, 31802.522962155585, 31821.045368638977, 31864.0, 33004.3399132016, 13904.721905561832, 14096.0, 14132.081414708216, 14144.43422263098, 14178.220197889215, 12595.370231488572, 12712.237265764084, 12732.681682958, 12828.35858207086, 12858.292793896238, 7517.285857843496, 7595.506292091107, 7616.69533218665, 7657.119431265364, 7687.500312479671, 2886.235147685865, 2897.753690936294, 2931.6628587712257, 2939.750121239676, 2943.617329747119, 971.50453268832, 979.3095867413457, 1035.637526865591, 1039.2880876599554, 1192.8508936382952, 30572.0, 30981.0, 31623.683763162073, 31891.840540797148, 32316.19209519781, 1003.8745156855393, 1078.0890147825232, 1112.5827814569536, 1127.2841745491507, 1139.4530625299903, 15272.16003119817, 15550.688986220212, 15673.216339182994, 15733.213339333217, 15789.21053947298, 446184.0, 562108.0, 577313.0, 578523.0, 587507.0, 57058.7147064262, 57951.0, 58033.09834508257, 58329.0, 58358.416415836145, 1353.2895230004326, 1373.478078330248, 1375.7386096641806, 1400.229873569553, 1403.5929580421769, 30219.244518887204, 31079.689203108584, 31264.687353127087, 31372.372552549277, 31915.042548723577, 48517.5148248513, 49295.7535212336, 49423.0, 49512.75243623759, 49638.25542616791, 412178.0, 414318.0, 414890.0, 415720.0, 418270.0, 26255.212343629722, 26653.733462665125, 26753.464930701666, 26758.331041724112, 42868.35697464603, 43195.78402107969, 43211.783941080095, 43287.56712432835, 47234.0, 48637.75681121572, 35877.0, 36070.27859442744, 36407.0, 36655.45016824696, 37018.0, 36500.0, 37237.81381093077, 37300.0, 37648.0, 37937.810310949375, 37518.06204844901, 39745.2050958985, 40620.3906941402, 41111.17777644371, 41548.79225603853, 31016.68983310138, 32314.0, 32723.509147362332, 32811.67188328086, 32879.67120328766, 25483.61774573346, 25545.74454255508, 25896.741032589434, 26195.345116372242, 26269.868650656623], "value": 17602.29342701073, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.33918963434706, 374.88753373987817, 377.3396556026953, 377.901745546158, 383.75056213461227, 17956.73064904026, 18189.545261368472, 18254.908725456386, 19004.524886877836, 19081.332153374653, 16406.26171822268, 16545.586360340996, 16913.0, 17091.914540427282, 17367.82632173678, 4884.511548845114, 5015.673981191211, 5020.196768517038, 5020.97489512552, 5025.271335656327, 3130.843457827111, 5171.612129090315, 5392.56859451243, 5422.457754224585, 5439.3200849893765, 5379.946200537984, 5426.104692725696, 5426.21319908615, 5428.5928555358305, 5430.75561599727, 4993.176125939216, 5274.129768588178, 5276.577873770089, 5305.7877684892555, 5318.175682769138, 4966.404031516205, 5049.520295571915, 5059.2916991621205, 5092.949070509285, 5102.948970510284, 11446.255993360404, 11765.470553825098, 11880.524779008916, 11959.40202989847, 12052.758944821142, 2112.947176320589, 2212.203606701586, 2215.125025614889, 2215.789499997498, 2320.791128798416, 9422.575984080733, 9839.458829764431, 10026.298159128864, 11976.640700778991, 14227.502037428743, 1755.1662960093981, 1844.5204246895769, 1871.5508278013315, 1920.1647283431612, 1923.4902750771057, 72972.0, 75632.62183689102, 75868.86196707109, 76573.23426765772, 77145.61427192828, 9336.719898403058, 9532.809343813224, 9719.125278724807, 9823.115919567274, 9901.75245618851, 12843.357832108544, 12899.097063205672, 12907.935460322638, 12970.675733106558, 12992.350382480838, 7376.557406555624, 7518.0, 7723.420743444264, 7758.844823103506, 7794.805129871798, 7034.3669069782945, 7074.115735533059, 7204.603746793872, 7263.636818159071, 7328.0, 4012.598740125964, 4019.8995025124023, 4022.879313620596, 4049.149678567475, 4083.3670781028986, 1671.966560668804, 1758.5603599100225, 1858.5260758506495, 1896.1986113192247, 1911.4447128341274, 877.9473231605996, 909.1771946388529, 1030.4744580264119, 1040.245821779204, 1095.3592148593002, 17661.7350739739, 18024.188911499015, 18326.175322110535, 18646.160922758507, 18899.527511812314, 968.3270127261486, 990.1237404896574, 1002.0, 1042.4214560918763, 1071.9571217151383, 9873.40759554429, 10114.54484548197, 10198.745031374126, 10240.795184096276, 10267.127294179929, 303446.0, 313929.0, 315526.0, 317475.0, 474868.0, 78566.0, 80887.59556202182, 93469.5326523363, 93726.53136734273, 94877.0, 468.8195044907735, 477.30313741936465, 479.0180130731986, 479.6834089500982, 480.87737626904914, 10029.448380339152, 10397.792044159225, 10619.840702389625, 10713.0, 10791.082757965662, 34877.302453951284, 35271.82364088163, 35605.28789424145, 35622.643773562966, 36438.08495320421, 51833.0, 53875.56898348372, 53956.73021634867, 54461.72769136129, 54596.0, 8167.1424500428975, 8193.426460147732, 8321.95839020801, 8393.748187554384, 8403.873941890999, 12402.503899844267, 12871.678208044874, 12899.419526121535, 12949.417276222404, 13149.802752958905, 11041.889581104086, 11198.888011119785, 11212.607558735404, 11356.94321528387, 11583.0, 10878.292910960763, 10966.506507207354, 11114.944425277821, 11421.771564568828, 11560.94219528897, 11037.392943388191, 11236.719082023015, 11304.434778261219, 11714.297142171497, 11747.060235181336, 7345.265473452612, 7849.097353804385, 8332.458390204618, 8434.114417986024, 8676.262517685815, 10913.345199288067, 10970.890291096986, 10997.395143267197, 11191.32852028881, 11246.66260012201], "value": 8154.41471638362, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1486.4797320937673, 1506.6986602679463, 1645.7695922570836, 1729.0663041957343, 1794.8205179482054, 6662.9006213974635, 7956.244156805102, 8032.879506807402, 8203.753887383373, 8219.876701849476, 8111.269985701286, 8165.632546535406, 8195.139510351417, 8210.753677389674, 8211.260986511214, 2244.2145249162786, 2299.7125359330084, 2308.549832782608, 2310.306907927615, 2310.330004298751, 2244.932652020434, 2249.932502024942, 2260.762619924909, 2270.4437412833877, 2287.8512896661664, 2291.8510296830736, 2296.047140436725, 2302.320815359473, 2304.320225533463, 2309.203324852923, 2235.5305385868987, 2247.3932038349553, 2259.751427342991, 2269.841111122222, 2269.886505674718, 2193.802557769792, 2207.7792220777956, 2224.621814291558, 2226.4545186429427, 2239.104358256694, 8092.919070809335, 8191.303739182176, 8232.300254478376, 8234.176582341777, 8237.299829514499, 4875.8781030474165, 5022.347094877679, 5049.419316778581, 5059.038782631288, 5062.721550314731, 3111.175538482304, 3189.7448204143843, 3241.173500757292, 3250.869965201413, 3251.1059458648824, 1131.7227279316621, 1141.1042331769604, 1141.8287256911447, 1145.6219447582362, 1157.1841851494676, 10987.61543345987, 11028.172887033425, 11046.281991670596, 11097.72255693606, 11106.555737770479, 4330.372096046119, 4339.305711086211, 4380.102079073782, 4483.586072306904, 4505.391772110788, 9345.672901448552, 9355.625774968925, 9391.248700103975, 9397.201237894718, 9428.575714092882, 4867.440244371872, 4897.681650692693, 4942.5057494251005, 4948.876278093005, 4960.776765045582, 3879.8060096995036, 4500.617447516997, 4549.772511374418, 4563.927477042892, 4581.358609794632, 3685.94471082934, 3791.7156213284115, 3799.7910114943943, 3862.1889403225077, 3943.211357728466, 1273.4269578689627, 1294.58573256557, 1299.9545015924398, 1302.0690206502206, 1306.660268330241, 1353.2489468344966, 1357.5045108535314, 1382.9930850345886, 1386.0367044903896, 1391.325207274471, 7615.466917315845, 7825.491343062683, 7844.568548729761, 7848.450608457353, 7901.367890568856, 459.59325996492674, 459.90342028174456, 460.3233247126718, 466.82027419443756, 474.84092828902016, 6025.15647809307, 6138.294096178907, 6138.508919286446, 6144.539159563051, 6180.567360284737, 9606.375585586915, 9769.364991275545, 9798.216142708567, 9821.0, 9857.55640996157, 9372.95313523428, 9715.757106072404, 9788.755281118029, 9799.069088436587, 9818.067283608047, 7512.699492020367, 7591.848163036598, 7632.427567932427, 7634.809129771689, 7690.230976902265, 7525.397968162643, 7762.5342479449155, 7769.72805951789, 7771.805704857424, 7892.447528673168, 8900.955495222483, 8910.910890891008, 8948.373613847229, 9005.05446928063, 9033.638654454011, 8820.955895220482, 8962.32782541299, 9078.54607269647, 9136.451812891248, 9166.220871225754, 6472.0, 6856.485763567653, 6917.239103698488, 6984.4063254623925, 7153.928460715326, 7277.090363704537, 7356.264373562601, 7365.373943214887, 7410.407167426701, 7447.329740323397, 6910.516263861481, 7167.928320716726, 7187.101612298463, 7278.163011253773, 7347.0, 6944.791656250321, 6997.720091196499, 7091.432685385053, 7105.396041336544, 7135.714571417086, 7354.889676654748, 7402.3707984821895, 7479.738209162653, 7577.962110189414, 7584.962075189589, 6802.3537763912345, 6835.453163746988, 6898.517103802686, 6904.240533541206, 6947.270536593787, 6789.694463749044, 6800.625965571941, 6916.55042422241, 6923.480738944499, 6937.0], "value": 4572.098917146472, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.97472202223815, 317.4492255935951, 323.51957343345146, 325.83545309618654, 328.23848671083084, 5902.911456328153, 5966.925953328405, 5990.940090599092, 6000.279966404032, 6004.249468816387, 5812.244408226935, 5855.297364316278, 5869.618474799146, 5897.675627840467, 5944.0, 4221.978890105545, 4352.3471479278205, 4486.865394038167, 4502.707324023928, 4520.2089634314025, 4506.707064040843, 4517.119161763458, 4543.477500087482, 4554.180247555455, 4560.882583766966, 4499.212637788391, 4499.572540608653, 4500.347449619803, 4502.414686090804, 4514.367988481616, 4368.912621747563, 4467.932981005288, 4496.190685676577, 4519.186546421643, 4523.705959112647, 3913.1391093959282, 3921.1765529238896, 3921.725479216456, 3937.8424863005444, 3945.3687410014545, 5631.0708733059, 5648.661080335152, 5651.943480565183, 5671.404502527216, 5703.486686198262, 5099.923501147486, 5254.605904557136, 5266.34170728659, 5267.3942496613, 5271.736413179326, 6131.448169664752, 6147.907781383283, 6162.383761623802, 6177.413145751191, 6226.564140510166, 4392.165488557164, 4393.692441529094, 4402.427684401039, 4407.911841763179, 4419.602235798793, 6261.812145635593, 6482.995135753966, 6483.513736469784, 6517.608943463408, 6520.282768895418, 4477.552244775497, 4487.842925497592, 4494.303382975644, 4504.842330518416, 4508.909821803545, 4494.752788596593, 4569.177548041318, 4581.473130589959, 4582.152301824173, 4586.151561961048, 5197.350331208599, 5198.246254293106, 5206.921896171485, 5212.244224587414, 5274.7626356814035, 6293.433590976742, 6305.306416294204, 6342.365763423713, 6345.206849143857, 6348.619082855043, 1479.5413421839048, 1558.205315289188, 1567.8275389707123, 1576.4157022192624, 1580.462642701487, 955.0211033690523, 1003.2124782046204, 1017.064300843226, 1027.5941003303653, 1039.147898723055, 5868.383819698955, 5873.089671100986, 5892.823215303548, 5904.380040095728, 5910.674912879746, 6269.279032911182, 6285.465735412449, 6288.182536270256, 6308.810735677937, 6310.5898116622275, 5741.827745167651, 5871.6183448075735, 5889.322727886348, 5890.4698577128265, 5903.583140046358, 3363.142398688368, 3379.9155021124175, 3380.1042723678247, 3394.7114495267683, 3415.9316813663586, 6398.072279519443, 6446.4520515756685, 6484.286728459866, 6506.674666266667, 6541.0188471729625, 6442.194725659293, 6454.515911306671, 6498.642574658439, 6508.866869537783, 6512.641804700787, 6269.811905642838, 6507.34926507355, 6521.576097553644, 6527.216733991856, 6534.705938232791, 6249.375062493714, 6255.5907030669305, 6258.968705156445, 6286.528510361833, 6298.71655775482, 6135.815925522242, 6198.876022479615, 6226.533010024357, 6243.96878015607, 6262.495001999237, 6357.682115894279, 6490.058941453369, 6493.545451818327, 6499.350064993652, 6519.250286216956, 4274.764887931194, 4294.549072347483, 4338.479382473997, 4345.913081738411, 4353.825846966086, 6181.81454556364, 6248.656323902047, 6304.432601065926, 6312.779052733133, 6324.272708638381, 6001.639901605918, 6045.727942242522, 6063.242094738158, 6084.908726369196, 6088.4824789893355, 5978.641281523122, 6024.668643224665, 6092.939070609237, 6108.6945652716295, 6109.151234722274, 6000.729967151401, 6032.276126864629, 6064.4541991221, 6219.440250377488, 6227.813165605039, 6366.0, 6380.170577825039, 6381.457576106083, 6386.93613063882, 6414.166158399378, 6004.669743164168, 6234.189555357956, 6237.812865614039, 6244.625322480666, 6265.0], "value": 4665.253763240965, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [776.440962506995, 819.3977426591458, 830.0869044051544, 835.2107258640583, 876.5529579914249, 12880.484780608776, 13889.583312500616, 14980.0, 15021.849781502167, 15049.62375940602, 13195.60413187606, 13472.393742281596, 13531.864681353183, 13583.93208033961, 13584.524541641045, 672.7880717573948, 800.0519384529351, 832.4339449174558, 833.204289903141, 833.5873742497442, 797.0515087046425, 808.3169721585251, 814.1004190369645, 820.4543978254453, 820.7783898347443, 830.0744669693279, 852.1350828908662, 852.5183271451641, 855.0893298636963, 858.0432817408607, 822.0792712162387, 840.1304649687575, 844.5059640110543, 844.7001314533375, 845.0577605969362, 615.5906322295668, 621.8507558186049, 626.764963138823, 626.9937300626981, 629.5750368501289, 14305.78541321881, 14336.56990290293, 14347.856521434756, 14389.856101438956, 14408.423663053465, 14279.0, 14319.140851548837, 14320.283985800668, 14354.282285885663, 14366.066205696701, 10657.733556661067, 10666.520006599721, 10781.299215551042, 10804.837927431096, 11014.559417623286, 3804.410316400962, 3839.6352346527037, 3944.6252606002386, 3974.3641017437362, 4033.858814941463, 51928.22107668388, 52163.73918130423, 53266.0, 53733.0, 54006.18990715143, 10339.224558158168, 10423.5830566778, 10434.791304174027, 10617.628383006711, 10636.149108071335, 17768.91115544414, 17772.200250988735, 17802.0, 17826.643467130583, 18234.544136396697, 8028.839423211503, 8072.757817265491, 8113.310368618615, 8115.756527304072, 8159.632816523271, 4714.5992590630185, 4724.291356296583, 4732.621390288768, 4759.571638552547, 4802.303665968415, 3175.4601717708047, 3295.1597342677464, 3301.884434044845, 3307.470804671289, 3309.8014119152926, 595.4611076975344, 607.1166452811149, 608.7230310208845, 619.3249358199585, 623.0685125736961, 631.4537924695105, 761.147514783435, 763.4770182425057, 777.4480119115378, 798.8601994650912, 8267.751967440987, 8447.577621118919, 8506.447080939843, 8586.613602387908, 8745.256653184551, 750.2834792772888, 758.6586036283584, 768.0859776865512, 783.0916137280727, 783.50247592779, 4030.496187976503, 4116.9794151029055, 4122.958770412258, 4133.731307465006, 4168.73301461982, 56781.0, 56970.715146424, 57059.0, 57450.42549574451, 57948.0, 51065.234021489705, 51528.0, 52384.21423678648, 52975.47024529782, 52982.205266921024, 46290.53709462862, 47173.29240061402, 47406.76296618495, 47556.2866556995, 47673.0, 7697.846043078995, 7952.0, 7979.122296547491, 8064.677412903418, 8131.105578386255, 32102.35795284128, 32194.839025804722, 32348.514772277966, 32471.512927306583, 33034.83482582572, 40145.59854401419, 41789.0, 43132.68673132662, 43241.567584325014, 43609.781951090044, 11311.0, 11494.655160345203, 11610.419479026184, 11773.0, 12037.939810300892, 12174.57388991381, 13710.24593647359, 13958.58124256274, 14140.717185656024, 14195.148291102567, 12177.0, 12210.816837747263, 12214.206076604993, 12268.0, 12702.983761298889, 12542.1847579907, 12851.0, 12887.677808054874, 13040.804387934379, 13366.599002029954, 11097.944510277719, 11350.716232094264, 11584.420778961186, 12068.034557235576, 12770.744585108432, 9779.462129582942, 9828.803423931624, 10011.749706257111, 10058.446785426579, 10348.53431595595, 10089.949550252202, 10258.743531411774, 10292.0, 10323.690289291333, 10349.9482502587], "value": 6584.621288407645, "unit": "score"}], "name": "dromaeo_css", "value": 6905.600718125271, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 112.0, 112.0, 111.0, 126.0, 114.0, 112.0, 112.0, 111.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 131.0, 156.0, 184.0, 135.0, 155.0, 147.0, 127.0, 181.0, 129.0], "value": 149.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 161.0, 163.0, 165.0, 174.0, 167.0, 165.0, 165.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 156.0, 77.0, 77.0, 75.0, 75.0, 167.0, 77.0], "value": 93.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 93.0, 160.0, 96.0, 97.0, 94.0, 151.0, 92.0, 92.0, 155.0], "value": 112.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 120.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 55.0, 58.0, 57.0, 56.0, 78.0, 55.0, 55.0], "value": 58.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 64.0, 64.0, 66.0, 64.0, 64.0, 65.0, 64.0, 66.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 79.0, 80.0, 89.0, 81.0, 80.0, 81.0, 82.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 128.0, 130.0, 127.0, 138.0, 129.0, 129.0, 139.0, 160.0, 128.0], "value": 134.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 162.0, 164.0, 166.0, 164.0, 165.0, 166.0, 162.0, 161.0], "value": 164.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 69.0, 70.0, 65.0, 75.0, 69.0, 68.0, 66.0, 67.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1564.6, "alertThreshold": 2.0}]} 10:29:00 INFO - Return code: 0 10:29:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:29:00 ERROR - # TBPL SUCCESS # 10:29:00 INFO - Running post-action listener: _resource_record_post_action 10:29:00 INFO - Running post-run listener: _resource_record_post_run 10:29:01 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 12288; Write bytes: 538660864; Read time: 236; Write time: 407544 10:29:01 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 243712000; Read time: 184; Write time: 235004 10:29:01 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 8192; Write bytes: 294948864; Read time: 52; Write time: 172540 10:29:01 INFO - Running post-run listener: _upload_blobber_files 10:29:01 INFO - Blob upload gear active. 10:29:01 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 10:29:01 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 10:29:01 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'] 10:29:01 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 10:29:01 INFO - (blobuploader) - INFO - Open directory for files ... 10:29:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:29:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:29:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:29:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:29:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:29:02 INFO - (blobuploader) - INFO - Done attempting. 10:29:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:29:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:29:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:29:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:29:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:29:03 INFO - (blobuploader) - INFO - Done attempting. 10:29:03 INFO - (blobuploader) - INFO - Iteration through files over. 10:29:03 INFO - Return code: 0 10:29:03 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 10:29:03 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 10:29:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c94fdf60a6fb4b43de092e3e4eebaf8409105d5bf386cc2f87537c857ceb5f76ffb65910ffe6e1716da8bb152f5e7da083724dec160416a0d315320d24d1cb1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8632535d5f1cf2b65c27d4e7306d7a9c74a752d54f152e55cd48d31fdfdfb893b106115f1690fd4256eb6244f2a9eca66eec9253288b3ef6d34504326926511c"} 10:29:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 10:29:03 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 10:29:03 INFO - Contents: 10:29:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c94fdf60a6fb4b43de092e3e4eebaf8409105d5bf386cc2f87537c857ceb5f76ffb65910ffe6e1716da8bb152f5e7da083724dec160416a0d315320d24d1cb1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8632535d5f1cf2b65c27d4e7306d7a9c74a752d54f152e55cd48d31fdfdfb893b106115f1690fd4256eb6244f2a9eca66eec9253288b3ef6d34504326926511c"} 10:29:03 INFO - Running post-run listener: copy_logs_to_upload_dir 10:29:03 INFO - Copying logs to upload dir... 10:29:03 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 10:29:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.610658 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-04-12 10:29:02.635223) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 10:29:02.638625) ========= 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=ed14279e38b05397cf4aa391000001a4-1460479458.685719-1679285492 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c94fdf60a6fb4b43de092e3e4eebaf8409105d5bf386cc2f87537c857ceb5f76ffb65910ffe6e1716da8bb152f5e7da083724dec160416a0d315320d24d1cb1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8632535d5f1cf2b65c27d4e7306d7a9c74a752d54f152e55cd48d31fdfdfb893b106115f1690fd4256eb6244f2a9eca66eec9253288b3ef6d34504326926511c"} build_url:https://queue.taskcluster.net/v1/task/dVfcuBxiSVKhneL51Qu2pA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011240 build_url: 'https://queue.taskcluster.net/v1/task/dVfcuBxiSVKhneL51Qu2pA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c94fdf60a6fb4b43de092e3e4eebaf8409105d5bf386cc2f87537c857ceb5f76ffb65910ffe6e1716da8bb152f5e7da083724dec160416a0d315320d24d1cb1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8632535d5f1cf2b65c27d4e7306d7a9c74a752d54f152e55cd48d31fdfdfb893b106115f1690fd4256eb6244f2a9eca66eec9253288b3ef6d34504326926511c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 10:29:02.662968) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 10:29:02.663277) ========= 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=ed14279e38b05397cf4aa391000001a4-1460479458.685719-1679285492 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-04-12 10:29:02.744848) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 10:29:02.745142) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 10:29:02.745431) ========= ========= Total master_lag: 0.27 =========