builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-001 starttime: 1457989264.94 results: success (0) buildid: 20160314030215 builduid: 9efc9d1c5b354769812f314f2a289271 revision: f0c0480732d36153e8839c7f17394d45f679f87d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-14 14:01:04.935443) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-14 14:01:04.935902) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 14:01:04.936204) ========= 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=8887e36bb8e381bfd44124ac000001a8-1457989263.730473-1420477093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006370 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 14:01:04.962047) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 14:01:04.962370) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 14:01:04.976841) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 14:01:04.977255) ========= 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=8887e36bb8e381bfd44124ac000001a8-1457989263.730473-1420477093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004521 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 14:01:05.025898) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-14 14:01:05.026957) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-14 14:01:05.027347) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 14:01:05.027625) ========= 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=8887e36bb8e381bfd44124ac000001a8-1457989263.730473-1420477093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-14 14:01:05-- 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% 215M=0s 2016-03-14 14:01:05 (215 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089251 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 14:01:05.129286) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 14:01:05.129602) ========= 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=8887e36bb8e381bfd44124ac000001a8-1457989263.730473-1420477093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022350 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 14:01:05.179302) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 14:01:05.179656) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f0c0480732d36153e8839c7f17394d45f679f87d --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 f0c0480732d36153e8839c7f17394d45f679f87d --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=8887e36bb8e381bfd44124ac000001a8-1457989263.730473-1420477093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-14 14:01:05,343 truncating revision to first 12 chars 2016-03-14 14:01:05,343 Setting DEBUG logging. 2016-03-14 14:01:05,344 attempt 1/10 2016-03-14 14:01:05,344 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f0c0480732d3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-14 14:01:05,611 unpacking tar archive at: mozilla-central-f0c0480732d3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.564361 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 14:01:05.756918) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-14 14:01:05.757288) ========= echo f0c0480732d36153e8839c7f17394d45f679f87d in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f0c0480732d36153e8839c7f17394d45f679f87d'] 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=8887e36bb8e381bfd44124ac000001a8-1457989263.730473-1420477093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False f0c0480732d36153e8839c7f17394d45f679f87d program finished with exit code 0 elapsedTime=0.004645 script_repo_revision: 'f0c0480732d36153e8839c7f17394d45f679f87d' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-14 14:01:05.808019) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-14 14:01:05.808347) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-14 14:01:05.818496) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-03-14 14:01:05.818880) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1457989263.730473-1420477093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:01:06 INFO - MultiFileLogger online at 20160314 14:01:06 in /builds/slave/test-pgo 14:01:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 14:01:06 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:01:06 INFO - {'append_to_log': False, 14:01:06 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:01:06 INFO - 'blob_upload_branch': 'Firefox', 14:01:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:01:06 INFO - 'branch': 'Firefox', 14:01:06 INFO - 'buildbot_json_path': 'buildprops.json', 14:01:06 INFO - 'config_files': ('talos/linux_config.py',), 14:01:06 INFO - 'default_actions': ('clobber', 14:01:06 INFO - 'read-buildbot-config', 14:01:06 INFO - 'download-and-extract', 14:01:06 INFO - 'populate-webroot', 14:01:06 INFO - 'create-virtualenv', 14:01:06 INFO - 'install', 14:01:06 INFO - 'run-tests'), 14:01:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:01:06 INFO - 'download_minidump_stackwalk': True, 14:01:06 INFO - 'download_symbols': 'ondemand', 14:01:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:01:06 INFO - 'tooltool.py': '/tools/tooltool.py', 14:01:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:01:06 INFO - '/tools/misc-python/virtualenv.py')}, 14:01:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:01:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:01:06 INFO - 'installer_path': 'installer.exe', 14:01:06 INFO - 'log_level': 'info', 14:01:06 INFO - 'log_name': 'talos', 14:01:06 INFO - 'log_to_console': True, 14:01:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:01:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:01:06 INFO - 'opt_config_files': (), 14:01:06 INFO - 'pip_index': False, 14:01:06 INFO - 'sps_profile': False, 14:01:06 INFO - 'sps_profile_interval': 0, 14:01:06 INFO - 'suite': 'dromaeojs', 14:01:06 INFO - 'system_bits': '32', 14:01:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:01:06 INFO - 'title': 'talos-linux64-ix-001', 14:01:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:01:06 INFO - 'use_talos_json': True, 14:01:06 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:01:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:01:06 INFO - 'work_dir': 'build'} 14:01:06 INFO - ##### 14:01:06 INFO - ##### Running clobber step. 14:01:06 INFO - ##### 14:01:06 INFO - Running pre-action listener: _resource_record_pre_action 14:01:06 INFO - Running main action method: clobber 14:01:06 INFO - rmtree: /builds/slave/test-pgo/build 14:01:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:01:06 INFO - Running post-action listener: _resource_record_post_action 14:01:06 INFO - ##### 14:01:06 INFO - ##### Running read-buildbot-config step. 14:01:06 INFO - ##### 14:01:06 INFO - Running pre-action listener: _resource_record_pre_action 14:01:06 INFO - Running main action method: read_buildbot_config 14:01:06 INFO - Using buildbot properties: 14:01:06 INFO - { 14:01:06 INFO - "project": "", 14:01:06 INFO - "product": "firefox", 14:01:06 INFO - "script_repo_revision": "production", 14:01:06 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 14:01:06 INFO - "repository": "", 14:01:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 14:01:06 INFO - "buildid": "20160314030215", 14:01:06 INFO - "stage_platform": "linux64-pgo", 14:01:06 INFO - "basedir": "/builds/slave/test-pgo", 14:01:06 INFO - "nightly_build": "True", 14:01:06 INFO - "buildnumber": 223, 14:01:06 INFO - "slavename": "talos-linux64-ix-001", 14:01:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:01:06 INFO - "platform": "ubuntu64_hw", 14:01:06 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 14:01:06 INFO - "branch": "mozilla-central", 14:01:06 INFO - "repo_path": "mozilla-central", 14:01:06 INFO - "revision": "f0c0480732d36153e8839c7f17394d45f679f87d", 14:01:06 INFO - "pgo_build": "True", 14:01:06 INFO - "builduid": "9efc9d1c5b354769812f314f2a289271", 14:01:06 INFO - "slavebuilddir": "test" 14:01:06 INFO - } 14:01:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/fE5gHnILRAaRLG5cEaMoyQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 14:01:06 INFO - Running post-action listener: _resource_record_post_action 14:01:06 INFO - ##### 14:01:06 INFO - ##### Running download-and-extract step. 14:01:06 INFO - ##### 14:01:06 INFO - Running pre-action listener: _resource_record_pre_action 14:01:06 INFO - Running main action method: download_and_extract 14:01:06 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:06 INFO - https://queue.taskcluster.net/v1/task/fE5gHnILRAaRLG5cEaMoyQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:01:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fE5gHnILRAaRLG5cEaMoyQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:01:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fE5gHnILRAaRLG5cEaMoyQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:01:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fE5gHnILRAaRLG5cEaMoyQ/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 14:01:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fE5gHnILRAaRLG5cEaMoyQ/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 14:01:07 INFO - Downloaded 1361 bytes. 14:01:07 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:01:07 INFO - Using the following test package requirements: 14:01:07 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:01:07 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:01:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:01:07 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:01:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:01:07 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:01:07 INFO - u'jsshell-linux-x86_64.zip'], 14:01:07 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:01:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:01:07 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:01:07 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:01:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:01:07 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:01:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:01:07 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:01:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:01:07 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:01:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:01:07 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:01: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')]} 14:01:07 INFO - https://queue.taskcluster.net/v1/task/fE5gHnILRAaRLG5cEaMoyQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:01:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fE5gHnILRAaRLG5cEaMoyQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:01:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fE5gHnILRAaRLG5cEaMoyQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:01:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fE5gHnILRAaRLG5cEaMoyQ/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 14:01:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fE5gHnILRAaRLG5cEaMoyQ/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 14:01:08 INFO - Downloaded 23558553 bytes. 14:01:08 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'] 14:01:08 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 14:01:09 INFO - Return code: 0 14:01:09 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 14:01:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:09 INFO - https://queue.taskcluster.net/v1/task/fE5gHnILRAaRLG5cEaMoyQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:01:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fE5gHnILRAaRLG5cEaMoyQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:01:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fE5gHnILRAaRLG5cEaMoyQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:01:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fE5gHnILRAaRLG5cEaMoyQ/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 14:01:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fE5gHnILRAaRLG5cEaMoyQ/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 14:01:10 INFO - Downloaded 23558553 bytes. 14:01:10 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'] 14:01:10 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 14:01:12 INFO - Return code: 0 14:01:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:12 INFO - https://queue.taskcluster.net/v1/task/fE5gHnILRAaRLG5cEaMoyQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:01:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fE5gHnILRAaRLG5cEaMoyQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:01:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fE5gHnILRAaRLG5cEaMoyQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:01:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fE5gHnILRAaRLG5cEaMoyQ/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 14:01:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fE5gHnILRAaRLG5cEaMoyQ/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 14:01:13 INFO - Downloaded 10845263 bytes. 14:01:13 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'] 14:01:13 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 14:01:13 INFO - Return code: 0 14:01:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:13 INFO - https://queue.taskcluster.net/v1/task/fE5gHnILRAaRLG5cEaMoyQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:01:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fE5gHnILRAaRLG5cEaMoyQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:01:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fE5gHnILRAaRLG5cEaMoyQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:01:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fE5gHnILRAaRLG5cEaMoyQ/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 14:01:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fE5gHnILRAaRLG5cEaMoyQ/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 14:01:14 INFO - Downloaded 57665201 bytes. 14:01:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fE5gHnILRAaRLG5cEaMoyQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:01:14 INFO - mkdir: /builds/slave/test-pgo/properties 14:01:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:01:14 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:01:14 INFO - Contents: 14:01:14 INFO - build_url:https://queue.taskcluster.net/v1/task/fE5gHnILRAaRLG5cEaMoyQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:01:15 INFO - Running post-action listener: _resource_record_post_action 14:01:15 INFO - Running post-action listener: set_extra_try_arguments 14:01:15 INFO - ##### 14:01:15 INFO - ##### Running populate-webroot step. 14:01:15 INFO - ##### 14:01:15 INFO - Running pre-action listener: _resource_record_pre_action 14:01:15 INFO - Running main action method: populate_webroot 14:01:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:01:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:01:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:01:15 INFO - '--tppagecycles', 14:01:15 INFO - '7'], 14:01:15 INFO - 'tests': ['tsvgm']}}, 14:01:15 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:01:15 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:01:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:01:15 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:01:15 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:01:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:01:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:01:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:15 INFO - 'talos_options': ['--e10s'], 14:01:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:01:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:15 INFO - 'tests': ['damp', 'tps']}, 14:01:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:15 INFO - 'talos_options': ['--e10s'], 14:01:15 INFO - 'tests': ['damp', 'tps']}, 14:01:15 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:01:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:01:15 INFO - 'other': {'tests': ['a11yr', 14:01:15 INFO - 'ts_paint', 14:01:15 INFO - 'tpaint', 14:01:15 INFO - 'sessionrestore', 14:01:15 INFO - 'sessionrestore_no_auto_restore', 14:01:15 INFO - 'tabpaint']}, 14:01:15 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:01:15 INFO - 'tests': ['a11yr', 14:01:15 INFO - 'ts_paint', 14:01:15 INFO - 'tpaint', 14:01:15 INFO - 'sessionrestore', 14:01:15 INFO - 'sessionrestore_no_auto_restore', 14:01:15 INFO - 'tabpaint']}, 14:01:15 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:01:15 INFO - 'tests': ['a11yr', 14:01:15 INFO - 'ts_paint', 14:01:15 INFO - 'tpaint', 14:01:15 INFO - 'sessionrestore', 14:01:15 INFO - 'sessionrestore_no_auto_restore', 14:01:15 INFO - 'tabpaint']}, 14:01:15 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:01:15 INFO - 'tests': ['a11yr', 14:01:15 INFO - 'ts_paint', 14:01:15 INFO - 'tpaint', 14:01:15 INFO - 'sessionrestore', 14:01:15 INFO - 'sessionrestore_no_auto_restore', 14:01:15 INFO - 'tabpaint']}, 14:01:15 INFO - 'other_l64': {'tests': ['a11yr', 14:01:15 INFO - 'ts_paint', 14:01:15 INFO - 'tpaint', 14:01:15 INFO - 'sessionrestore', 14:01:15 INFO - 'sessionrestore_no_auto_restore', 14:01:15 INFO - 'tabpaint']}, 14:01:15 INFO - 'other_nol64': {'tests': ['a11yr', 14:01:15 INFO - 'ts_paint', 14:01:15 INFO - 'tpaint', 14:01:15 INFO - 'sessionrestore', 14:01:15 INFO - 'sessionrestore_no_auto_restore', 14:01:15 INFO - 'tabpaint']}, 14:01:15 INFO - 'svgr': {'tests': ['tsvgx', 14:01:15 INFO - 'tsvgr_opacity', 14:01:15 INFO - 'tart', 14:01:15 INFO - 'tscrollx', 14:01:15 INFO - 'cart']}, 14:01:15 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:01:15 INFO - 'tests': ['tsvgx', 14:01:15 INFO - 'tsvgr_opacity', 14:01:15 INFO - 'tart', 14:01:15 INFO - 'tscrollx', 14:01:15 INFO - 'cart']}, 14:01:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:15 INFO - 'tests': ['tp5o']}, 14:01:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:15 INFO - 'talos_options': ['--e10s'], 14:01:15 INFO - 'tests': ['tp5o']}, 14:01:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:15 INFO - 'talos_options': ['--xperf_path', 14:01:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:01:15 INFO - 'tests': ['tp5n']}, 14:01:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:15 INFO - 'talos_options': ['--e10s', 14:01:15 INFO - '--xperf_path', 14:01:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:01:15 INFO - 'tests': ['tp5n']}}, 14:01:15 INFO - 'talos.zip': {'path': '', 14:01:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:01:15 INFO - Running post-action listener: _resource_record_post_action 14:01:15 INFO - ##### 14:01:15 INFO - ##### Running create-virtualenv step. 14:01:15 INFO - ##### 14:01:15 INFO - Running pre-action listener: _resource_record_pre_action 14:01:15 INFO - Running main action method: create_virtualenv 14:01:15 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:01:15 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 14:01:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:01:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:01:15 INFO - Using real prefix '/usr' 14:01:15 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:01:16 INFO - Installing distribute.............................................................................................................................................................................................done. 14:01:18 INFO - Installing pip.................done. 14:01:18 INFO - Return code: 0 14:01:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:01:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:18 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 0x7fa487364f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a076d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a96920>, '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 0x2a97820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a97cb0>, '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': '8887e36bb8e381bfd44124ac000001a8-1457989263.730473-1420477093', '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 14:01:18 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 14:01:18 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 14:01:18 INFO - Using env: {'DISPLAY': ':0', 14:01:18 INFO - 'HOME': '/home/cltbld', 14:01:18 INFO - 'LANG': 'en_US.UTF-8', 14:01:18 INFO - 'LANGUAGE': 'en_US:en', 14:01:18 INFO - 'LOGNAME': 'cltbld', 14:01:18 INFO - 'MAIL': '/var/mail/cltbld', 14:01:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:18 INFO - 'MOZ_NO_REMOTE': '1', 14:01:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:18 INFO - 'NO_EM_RESTART': '1', 14:01:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:18 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:18 INFO - 'SHELL': '/bin/bash', 14:01:18 INFO - 'SHLVL': '1', 14:01:18 INFO - 'TERM': 'linux', 14:01:18 INFO - 'TMOUT': '86400', 14:01:18 INFO - 'USER': 'cltbld', 14:01:18 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1457989263.730473-1420477093', 14:01:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:18 INFO - '_': '/tools/buildbot/bin/python'} 14:01:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:18 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 14:01:18 INFO - Cleaning up... 14:01:18 INFO - Return code: 0 14:01:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:01:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:18 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 0x7fa487364f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a076d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a96920>, '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 0x2a97820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a97cb0>, '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': '8887e36bb8e381bfd44124ac000001a8-1457989263.730473-1420477093', '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 14:01:18 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 14:01:18 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 14:01:18 INFO - Using env: {'DISPLAY': ':0', 14:01:18 INFO - 'HOME': '/home/cltbld', 14:01:18 INFO - 'LANG': 'en_US.UTF-8', 14:01:18 INFO - 'LANGUAGE': 'en_US:en', 14:01:18 INFO - 'LOGNAME': 'cltbld', 14:01:18 INFO - 'MAIL': '/var/mail/cltbld', 14:01:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:18 INFO - 'MOZ_NO_REMOTE': '1', 14:01:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:18 INFO - 'NO_EM_RESTART': '1', 14:01:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:18 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:18 INFO - 'SHELL': '/bin/bash', 14:01:18 INFO - 'SHLVL': '1', 14:01:18 INFO - 'TERM': 'linux', 14:01:18 INFO - 'TMOUT': '86400', 14:01:18 INFO - 'USER': 'cltbld', 14:01:18 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1457989263.730473-1420477093', 14:01:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:18 INFO - '_': '/tools/buildbot/bin/python'} 14:01:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:18 INFO - Downloading/unpacking psutil>=0.7.1 14:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:01:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:01:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:01:20 INFO - Installing collected packages: psutil 14:01:20 INFO - Running setup.py install for psutil 14:01:20 INFO - building 'psutil._psutil_linux' extension 14:01:20 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 14:01:20 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 14:01:20 INFO - building 'psutil._psutil_posix' extension 14:01:20 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 14:01:20 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 14:01:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:01:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:01:21 INFO - Successfully installed psutil 14:01:21 INFO - Cleaning up... 14:01:21 INFO - Return code: 0 14:01:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:01: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')]} 14:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01: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')]} 14:01:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa487364f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a076d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a96920>, '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 0x2a97820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a97cb0>, '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': '8887e36bb8e381bfd44124ac000001a8-1457989263.730473-1420477093', '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 14:01:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 14:01:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:01:21 INFO - Using env: {'DISPLAY': ':0', 14:01:21 INFO - 'HOME': '/home/cltbld', 14:01:21 INFO - 'LANG': 'en_US.UTF-8', 14:01:21 INFO - 'LANGUAGE': 'en_US:en', 14:01:21 INFO - 'LOGNAME': 'cltbld', 14:01:21 INFO - 'MAIL': '/var/mail/cltbld', 14:01:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:21 INFO - 'MOZ_NO_REMOTE': '1', 14:01:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:21 INFO - 'NO_EM_RESTART': '1', 14:01:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:21 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:21 INFO - 'SHELL': '/bin/bash', 14:01:21 INFO - 'SHLVL': '1', 14:01:21 INFO - 'TERM': 'linux', 14:01:21 INFO - 'TMOUT': '86400', 14:01:21 INFO - 'USER': 'cltbld', 14:01:21 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1457989263.730473-1420477093', 14:01:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:21 INFO - '_': '/tools/buildbot/bin/python'} 14:01:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:01:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:01:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:01:23 INFO - Installing collected packages: mozsystemmonitor 14:01:23 INFO - Running setup.py install for mozsystemmonitor 14:01:23 INFO - Successfully installed mozsystemmonitor 14:01:23 INFO - Cleaning up... 14:01:23 INFO - Return code: 0 14:01:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:01:23 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')]} 14:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:23 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')]} 14:01:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:23 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 0x7fa487364f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a076d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a96920>, '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 0x2a97820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a97cb0>, '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': '8887e36bb8e381bfd44124ac000001a8-1457989263.730473-1420477093', '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 14:01:23 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 14:01:23 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 14:01:23 INFO - Using env: {'DISPLAY': ':0', 14:01:23 INFO - 'HOME': '/home/cltbld', 14:01:23 INFO - 'LANG': 'en_US.UTF-8', 14:01:23 INFO - 'LANGUAGE': 'en_US:en', 14:01:23 INFO - 'LOGNAME': 'cltbld', 14:01:23 INFO - 'MAIL': '/var/mail/cltbld', 14:01:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:23 INFO - 'MOZ_NO_REMOTE': '1', 14:01:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:23 INFO - 'NO_EM_RESTART': '1', 14:01:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:23 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:23 INFO - 'SHELL': '/bin/bash', 14:01:23 INFO - 'SHLVL': '1', 14:01:23 INFO - 'TERM': 'linux', 14:01:23 INFO - 'TMOUT': '86400', 14:01:23 INFO - 'USER': 'cltbld', 14:01:23 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1457989263.730473-1420477093', 14:01:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:23 INFO - '_': '/tools/buildbot/bin/python'} 14:01:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:23 INFO - Downloading/unpacking blobuploader==1.2.4 14:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:25 INFO - Downloading blobuploader-1.2.4.tar.gz 14:01:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:01:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:01:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:26 INFO - Downloading docopt-0.6.1.tar.gz 14:01:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:01:26 INFO - Installing collected packages: blobuploader, requests, docopt 14:01:26 INFO - Running setup.py install for blobuploader 14:01:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:01:26 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:01:26 INFO - Running setup.py install for requests 14:01:26 INFO - Running setup.py install for docopt 14:01:26 INFO - Successfully installed blobuploader requests docopt 14:01:26 INFO - Cleaning up... 14:01:26 INFO - Return code: 0 14:01:26 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:01:26 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')]} 14:01:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:26 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')]} 14:01:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:26 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 0x7fa487364f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a076d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a96920>, '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 0x2a97820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a97cb0>, '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': '8887e36bb8e381bfd44124ac000001a8-1457989263.730473-1420477093', '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 14:01:26 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 14:01:26 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 14:01:26 INFO - Using env: {'DISPLAY': ':0', 14:01:26 INFO - 'HOME': '/home/cltbld', 14:01:26 INFO - 'LANG': 'en_US.UTF-8', 14:01:26 INFO - 'LANGUAGE': 'en_US:en', 14:01:26 INFO - 'LOGNAME': 'cltbld', 14:01:26 INFO - 'MAIL': '/var/mail/cltbld', 14:01:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:26 INFO - 'MOZ_NO_REMOTE': '1', 14:01:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:26 INFO - 'NO_EM_RESTART': '1', 14:01:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:26 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:26 INFO - 'SHELL': '/bin/bash', 14:01:26 INFO - 'SHLVL': '1', 14:01:26 INFO - 'TERM': 'linux', 14:01:26 INFO - 'TMOUT': '86400', 14:01:26 INFO - 'USER': 'cltbld', 14:01:26 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1457989263.730473-1420477093', 14:01:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:26 INFO - '_': '/tools/buildbot/bin/python'} 14:01:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:01:26 INFO - Running setup.py (path:/tmp/pip-M2LCsu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:01:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:01:26 INFO - Running setup.py (path:/tmp/pip-2psiip-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:01:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:01:27 INFO - Running setup.py (path:/tmp/pip-6NEQ7O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:01:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:01:27 INFO - Running setup.py (path:/tmp/pip-bQ8NyP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:01:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:01:27 INFO - Running setup.py (path:/tmp/pip-CEK04m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:01:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:01:27 INFO - Running setup.py (path:/tmp/pip-q4yaQb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:01:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:01:27 INFO - Running setup.py (path:/tmp/pip-o0Mqzv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:01:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:01:27 INFO - Running setup.py (path:/tmp/pip-ZdpRFg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:01:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:01:27 INFO - Running setup.py (path:/tmp/pip-tfcpel-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:01:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:01:27 INFO - Running setup.py (path:/tmp/pip-cpBwGk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:01:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:01:27 INFO - Running setup.py (path:/tmp/pip-Eq9W4r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:01:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:01:27 INFO - Running setup.py (path:/tmp/pip-tHChXR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:01:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:01:27 INFO - Running setup.py (path:/tmp/pip-EhTZ9H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:01:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:01:27 INFO - Running setup.py (path:/tmp/pip-GNLD67-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:01:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:01:27 INFO - Running setup.py (path:/tmp/pip-dkdC10-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:01:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:01:27 INFO - Running setup.py (path:/tmp/pip-W89DMS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:01:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:01:28 INFO - Running setup.py (path:/tmp/pip-_sMnvL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:01:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:01:28 INFO - Running setup.py install for manifestparser 14:01:28 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:01:28 INFO - Running setup.py install for mozcrash 14:01:28 INFO - Running setup.py install for mozdebug 14:01:28 INFO - Running setup.py install for mozdevice 14:01:28 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:01:28 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:01:28 INFO - Running setup.py install for mozfile 14:01:28 INFO - Running setup.py install for mozhttpd 14:01:28 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:01:28 INFO - Running setup.py install for mozinfo 14:01:28 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:01:28 INFO - Running setup.py install for mozInstall 14:01:28 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:01:28 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:01:28 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:01:28 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:01:28 INFO - Running setup.py install for mozleak 14:01:28 INFO - Running setup.py install for mozlog 14:01:29 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:01:29 INFO - Running setup.py install for moznetwork 14:01:29 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:01:29 INFO - Running setup.py install for mozprocess 14:01:29 INFO - Running setup.py install for mozprofile 14:01:29 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:01:29 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:01:29 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:01:29 INFO - Running setup.py install for mozrunner 14:01:29 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:01:29 INFO - Running setup.py install for mozscreenshot 14:01:29 INFO - Running setup.py install for moztest 14:01:29 INFO - Running setup.py install for mozversion 14:01:29 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:01:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:01:29 INFO - Cleaning up... 14:01:29 INFO - Return code: 0 14:01:29 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:01:29 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')]} 14:01:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:29 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')]} 14:01:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:29 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 0x7fa487364f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a076d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a96920>, '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 0x2a97820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a97cb0>, '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': '8887e36bb8e381bfd44124ac000001a8-1457989263.730473-1420477093', '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 14:01:29 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 14:01:29 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 14:01:29 INFO - Using env: {'DISPLAY': ':0', 14:01:29 INFO - 'HOME': '/home/cltbld', 14:01:29 INFO - 'LANG': 'en_US.UTF-8', 14:01:29 INFO - 'LANGUAGE': 'en_US:en', 14:01:29 INFO - 'LOGNAME': 'cltbld', 14:01:29 INFO - 'MAIL': '/var/mail/cltbld', 14:01:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:29 INFO - 'MOZ_NO_REMOTE': '1', 14:01:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:29 INFO - 'NO_EM_RESTART': '1', 14:01:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:29 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:29 INFO - 'SHELL': '/bin/bash', 14:01:29 INFO - 'SHLVL': '1', 14:01:29 INFO - 'TERM': 'linux', 14:01:29 INFO - 'TMOUT': '86400', 14:01:29 INFO - 'USER': 'cltbld', 14:01:29 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1457989263.730473-1420477093', 14:01:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:29 INFO - '_': '/tools/buildbot/bin/python'} 14:01:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:01:30 INFO - Running setup.py (path:/tmp/pip-0kMqcF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:01:30 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)) 14:01:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:01:30 INFO - Running setup.py (path:/tmp/pip-pfFaHc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:01:30 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)) 14:01:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:01:30 INFO - Running setup.py (path:/tmp/pip-Qk7QQB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:01:30 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)) 14:01:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:01:30 INFO - Running setup.py (path:/tmp/pip-Q1ORcO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:01:30 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)) 14:01:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:01:30 INFO - Running setup.py (path:/tmp/pip-tD__d8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:01:30 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)) 14:01:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:01:30 INFO - Running setup.py (path:/tmp/pip-MNX4gx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:01:30 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)) 14:01:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:01:30 INFO - Running setup.py (path:/tmp/pip-13fh5u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:01:30 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)) 14:01:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:01:30 INFO - Running setup.py (path:/tmp/pip-iVPE6O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:01:30 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)) 14:01:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:01:30 INFO - Running setup.py (path:/tmp/pip-PVSRzH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:01:30 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)) 14:01:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:01:30 INFO - Running setup.py (path:/tmp/pip-exzlvI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:01:30 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)) 14:01:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:01:30 INFO - Running setup.py (path:/tmp/pip-OJx5RN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:01:30 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)) 14:01:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:01:30 INFO - Running setup.py (path:/tmp/pip-iIUcjP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:01:30 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)) 14:01:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:01:30 INFO - Running setup.py (path:/tmp/pip-X6yIOc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:01:31 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)) 14:01:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:01:31 INFO - Running setup.py (path:/tmp/pip-7jy8jK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:01:31 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)) 14:01:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:01:31 INFO - Running setup.py (path:/tmp/pip-bzqh9s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:01:31 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)) 14:01:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:01:31 INFO - Running setup.py (path:/tmp/pip-WT3Au_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:01:31 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)) 14:01:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:01:31 INFO - Running setup.py (path:/tmp/pip-68h0Z_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:01:31 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)) 14:01:31 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)) 14:01:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:01:31 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)) 14:01:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:01:31 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)) 14:01:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:33 INFO - Downloading blessings-1.6.tar.gz 14:01:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:01:33 INFO - Installing collected packages: blessings 14:01:33 INFO - Running setup.py install for blessings 14:01:33 INFO - Successfully installed blessings 14:01:33 INFO - Cleaning up... 14:01:33 INFO - Return code: 0 14:01:33 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:01:33 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:01:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:01:33 INFO - Reading from file tmpfile_stdout 14:01:33 INFO - Current package versions: 14:01:33 INFO - argparse == 1.2.1 14:01:33 INFO - blessings == 1.6 14:01:33 INFO - blobuploader == 1.2.4 14:01:33 INFO - docopt == 0.6.1 14:01:33 INFO - manifestparser == 1.1 14:01:33 INFO - mozInstall == 1.12 14:01:33 INFO - mozcrash == 0.17 14:01:33 INFO - mozdebug == 0.1 14:01:33 INFO - mozdevice == 0.48 14:01:33 INFO - mozfile == 1.2 14:01:33 INFO - mozhttpd == 0.7 14:01:33 INFO - mozinfo == 0.9 14:01:33 INFO - mozleak == 0.1 14:01:33 INFO - mozlog == 3.1 14:01:33 INFO - moznetwork == 0.27 14:01:33 INFO - mozprocess == 0.22 14:01:33 INFO - mozprofile == 0.28 14:01:33 INFO - mozrunner == 6.11 14:01:33 INFO - mozscreenshot == 0.1 14:01:33 INFO - mozsystemmonitor == 0.0 14:01:33 INFO - moztest == 0.7 14:01:33 INFO - mozversion == 1.4 14:01:33 INFO - psutil == 3.1.1 14:01:33 INFO - requests == 1.2.3 14:01:33 INFO - wsgiref == 0.1.2 14:01:33 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:01:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:33 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 0x7fa487364f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a076d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a96920>, '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 0x2a97820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a97cb0>, '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': '8887e36bb8e381bfd44124ac000001a8-1457989263.730473-1420477093', '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 14:01:33 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 14:01:33 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 14:01:33 INFO - Using env: {'DISPLAY': ':0', 14:01:33 INFO - 'HOME': '/home/cltbld', 14:01:33 INFO - 'LANG': 'en_US.UTF-8', 14:01:33 INFO - 'LANGUAGE': 'en_US:en', 14:01:33 INFO - 'LOGNAME': 'cltbld', 14:01:33 INFO - 'MAIL': '/var/mail/cltbld', 14:01:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:33 INFO - 'MOZ_NO_REMOTE': '1', 14:01:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:33 INFO - 'NO_EM_RESTART': '1', 14:01:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:33 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:33 INFO - 'SHELL': '/bin/bash', 14:01:33 INFO - 'SHLVL': '1', 14:01:33 INFO - 'TERM': 'linux', 14:01:33 INFO - 'TMOUT': '86400', 14:01:33 INFO - 'USER': 'cltbld', 14:01:33 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1457989263.730473-1420477093', 14:01:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:33 INFO - '_': '/tools/buildbot/bin/python'} 14:01:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:33 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)) 14:01:33 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)) 14:01:33 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)) 14:01:33 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)) 14:01:33 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)) 14:01:33 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)) 14:01:33 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)) 14:01:33 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)) 14:01:33 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)) 14:01:33 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)) 14:01:33 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)) 14:01:33 INFO - Cleaning up... 14:01:33 INFO - Return code: 0 14:01:33 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:01:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:33 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa487364f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a076d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a96920>, '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 0x2a97820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a97cb0>, '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': '8887e36bb8e381bfd44124ac000001a8-1457989263.730473-1420477093', '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 14:01:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 14:01:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:01:33 INFO - Using env: {'DISPLAY': ':0', 14:01:33 INFO - 'HOME': '/home/cltbld', 14:01:33 INFO - 'LANG': 'en_US.UTF-8', 14:01:33 INFO - 'LANGUAGE': 'en_US:en', 14:01:33 INFO - 'LOGNAME': 'cltbld', 14:01:33 INFO - 'MAIL': '/var/mail/cltbld', 14:01:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:33 INFO - 'MOZ_NO_REMOTE': '1', 14:01:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:33 INFO - 'NO_EM_RESTART': '1', 14:01:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:33 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:33 INFO - 'SHELL': '/bin/bash', 14:01:33 INFO - 'SHLVL': '1', 14:01:33 INFO - 'TERM': 'linux', 14:01:33 INFO - 'TMOUT': '86400', 14:01:33 INFO - 'USER': 'cltbld', 14:01:33 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1457989263.730473-1420477093', 14:01:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:33 INFO - '_': '/tools/buildbot/bin/python'} 14:01:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:34 INFO - Downloading/unpacking jsonschema 14:01:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:01:35 INFO - Downloading/unpacking functools32 (from jsonschema) 14:01:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:36 INFO - Downloading functools32-3.2.3-2.tar.gz 14:01:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:01:36 INFO - warning: no files found matching '*.txt' 14:01:36 INFO - no previously-included directories found matching 'build' 14:01:36 INFO - no previously-included directories found matching 'dist' 14:01:36 INFO - no previously-included directories found matching '.git*' 14:01:36 INFO - Installing collected packages: jsonschema, functools32 14:01:36 INFO - Running setup.py install for functools32 14:01:36 INFO - warning: no files found matching '*.txt' 14:01:36 INFO - no previously-included directories found matching 'build' 14:01:36 INFO - no previously-included directories found matching 'dist' 14:01:36 INFO - no previously-included directories found matching '.git*' 14:01:36 INFO - Successfully installed jsonschema functools32 14:01:36 INFO - Cleaning up... 14:01:36 INFO - Return code: 0 14:01:36 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:01:36 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')]} 14:01:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:36 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')]} 14:01:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:36 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 0x7fa487364f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x293a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a076d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a96920>, '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 0x2a97820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a97cb0>, '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': '8887e36bb8e381bfd44124ac000001a8-1457989263.730473-1420477093', '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 14:01:36 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 14:01:36 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 14:01:36 INFO - Using env: {'DISPLAY': ':0', 14:01:36 INFO - 'HOME': '/home/cltbld', 14:01:36 INFO - 'LANG': 'en_US.UTF-8', 14:01:36 INFO - 'LANGUAGE': 'en_US:en', 14:01:36 INFO - 'LOGNAME': 'cltbld', 14:01:36 INFO - 'MAIL': '/var/mail/cltbld', 14:01:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:36 INFO - 'MOZ_NO_REMOTE': '1', 14:01:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:36 INFO - 'NO_EM_RESTART': '1', 14:01:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:36 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:36 INFO - 'SHELL': '/bin/bash', 14:01:36 INFO - 'SHLVL': '1', 14:01:36 INFO - 'TERM': 'linux', 14:01:36 INFO - 'TMOUT': '86400', 14:01:36 INFO - 'USER': 'cltbld', 14:01:36 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1457989263.730473-1420477093', 14:01:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:36 INFO - '_': '/tools/buildbot/bin/python'} 14:01:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:36 INFO - Downloading/unpacking flake8 14:01:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:01:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:01:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:01:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:01:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:01:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:01:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:01:39 INFO - no previously-included directories found matching 'docs/_build' 14:01:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:01:39 INFO - Running setup.py install for pep8 14:01:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:01:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:01:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:01:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:01:39 INFO - no previously-included directories found matching 'docs/_build' 14:01:39 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:01:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:01:39 INFO - Cleaning up... 14:01:39 INFO - Return code: 0 14:01:39 INFO - Running post-action listener: _resource_record_post_action 14:01:39 INFO - Running post-action listener: _start_resource_monitoring 14:01:39 INFO - Starting resource monitoring. 14:01:39 INFO - ##### 14:01:39 INFO - ##### Running install step. 14:01:39 INFO - ##### 14:01:39 INFO - Running pre-action listener: _resource_record_pre_action 14:01:39 INFO - Running main action method: install 14:01:39 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:01:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:01:39 INFO - Reading from file tmpfile_stdout 14:01:39 INFO - Detecting whether we're running mozinstall >=1.0... 14:01:39 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:01:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:01:39 INFO - Reading from file tmpfile_stdout 14:01:39 INFO - Output received: 14:01:39 INFO - Usage: mozinstall [options] installer 14:01:39 INFO - Options: 14:01:39 INFO - -h, --help show this help message and exit 14:01:39 INFO - -d DEST, --destination=DEST 14:01:39 INFO - Directory to install application into. [default: 14:01:39 INFO - "/builds/slave/test-pgo"] 14:01:39 INFO - --app=APP Application being installed. [default: firefox] 14:01:39 INFO - mkdir: /builds/slave/test-pgo/build/application 14:01:39 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'] 14:01:39 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 14:01:56 INFO - Reading from file tmpfile_stdout 14:01:56 INFO - Output received: 14:01:56 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:01:56 INFO - Running post-action listener: _resource_record_post_action 14:01:56 INFO - ##### 14:01:56 INFO - ##### Running run-tests step. 14:01:56 INFO - ##### 14:01:56 INFO - Running pre-action listener: _resource_record_pre_action 14:01:56 INFO - Running main action method: run_tests 14:01:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:01:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:01:56 INFO - Python 2.7.3 14:01:56 INFO - Return code: 0 14:01:56 INFO - grabbing minidump binary from tooltool 14:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:56 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 0x2a96920>, '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 0x2a97820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a97cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:01:56 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 14:01:56 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 14:01:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:01:56 INFO - Return code: 0 14:01:56 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:01:56 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:01:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:01:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:01:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:01:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:01:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:01:57 INFO - Return code: 0 14:01:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fE5gHnILRAaRLG5cEaMoyQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 14:01:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fE5gHnILRAaRLG5cEaMoyQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 14:01:57 INFO - Using env: {'DISPLAY': ':0', 14:01:57 INFO - 'HOME': '/home/cltbld', 14:01:57 INFO - 'LANG': 'en_US.UTF-8', 14:01:57 INFO - 'LANGUAGE': 'en_US:en', 14:01:57 INFO - 'LOGNAME': 'cltbld', 14:01:57 INFO - 'MAIL': '/var/mail/cltbld', 14:01:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:01:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:57 INFO - 'MOZ_NO_REMOTE': '1', 14:01:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:01:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:57 INFO - 'NO_EM_RESTART': '1', 14:01:57 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:57 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:57 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:01:57 INFO - 'SHELL': '/bin/bash', 14:01:57 INFO - 'SHLVL': '1', 14:01:57 INFO - 'TERM': 'linux', 14:01:57 INFO - 'TMOUT': '86400', 14:01:57 INFO - 'USER': 'cltbld', 14:01:57 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1457989263.730473-1420477093', 14:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:57 INFO - '_': '/tools/buildbot/bin/python'} 14:01:57 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fE5gHnILRAaRLG5cEaMoyQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:01:57 INFO - mozversion application_buildid: 20160314030215 14:01:57 INFO - mozversion application_changeset: f0c0480732d36153e8839c7f17394d45f679f87d 14:01:57 INFO - mozversion application_display_name: Nightly 14:01:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:01:57 INFO - mozversion application_name: Firefox 14:01:57 INFO - mozversion application_remotingname: firefox 14:01:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:01:57 INFO - mozversion application_vendor: Mozilla 14:01:57 INFO - mozversion application_version: 48.0a1 14:01:57 INFO - mozversion platform_buildid: 20160314030215 14:01:57 INFO - mozversion platform_changeset: f0c0480732d36153e8839c7f17394d45f679f87d 14:01:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:01:57 INFO - mozversion platform_version: 48.0a1 14:01:57 INFO - using testdate: 1457989317 14:01:57 INFO - actual date: 1457989317 14:01:57 INFO - starting webserver on 'localhost:36218' 14:01:57 INFO - SUITE-START | Running 2 tests 14:01:57 INFO - TEST-START | dromaeo_css 14:01:57 INFO - operating with platform_type : linux_ 14:01:57 INFO - Initialising browser for dromaeo_css test... 14:01:57 INFO - TEST-INFO | started process 13483 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpo8iK8W/profile http://localhost:36218/getInfo.html) 14:02:01 INFO - PROCESS | 13483 | __metrics Screen width/height:1600/1200 14:02:01 INFO - PROCESS | 13483 | colorDepth:24 14:02:01 INFO - PROCESS | 13483 | Browser inner width/height: 1024/697 14:02:01 INFO - PROCESS | 13483 | __metrics 14:02:02 ERROR - PROCESS | 13483 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:02:02 INFO - PROCESS | 13483 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 14:02:03 INFO - TEST-INFO | 13483: exit 0 14:02:03 INFO - Browser initialized. 14:02:03 INFO - Running cycle 1/1 for dromaeo_css test... 14:02:03 INFO - TEST-INFO | started process 13577 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpo8iK8W/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:02:15 INFO - PROCESS | 13577 | RSS: Main: 152010752 14:02:15 INFO - PROCESS | 13577 | 14:03:06 INFO - PROCESS | 13577 | 1457989386821 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] 14:05:13 INFO - PROCESS | 13577 | Cycle 1(1): loaded http://localhost:36218/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36218/tests/dromaeo/cssquery-ext.html) 14:05:14 INFO - PROCESS | 13577 | RSS: Main: 262631424 14:05:14 INFO - PROCESS | 13577 | 14:08:16 INFO - PROCESS | 13577 | Cycle 1(1): loaded http://localhost:36218/tests/dromaeo/cssquery-ext.html (next: http://localhost:36218/tests/dromaeo/cssquery-jquery.html) 14:08:17 INFO - PROCESS | 13577 | RSS: Main: 238116864 14:08:17 INFO - PROCESS | 13577 | 14:11:18 INFO - PROCESS | 13577 | Cycle 1(1): loaded http://localhost:36218/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36218/tests/dromaeo/cssquery-mootools.html) 14:11:19 INFO - PROCESS | 13577 | RSS: Main: 239165440 14:11:19 INFO - PROCESS | 13577 | 14:14:21 INFO - PROCESS | 13577 | Cycle 1(1): loaded http://localhost:36218/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36218/tests/dromaeo/cssquery-prototype.html) 14:14:21 INFO - PROCESS | 13577 | RSS: Main: 221032448 14:14:21 INFO - PROCESS | 13577 | 14:17:24 INFO - PROCESS | 13577 | Cycle 1(1): loaded http://localhost:36218/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36218/tests/dromaeo/cssquery-yui.html) 14:17:24 INFO - PROCESS | 13577 | RSS: Main: 223580160 14:17:24 INFO - PROCESS | 13577 | 14:20:27 INFO - PROCESS | 13577 | Cycle 1(1): loaded http://localhost:36218/tests/dromaeo/cssquery-yui.html (next: http://localhost:36218/tests/dromaeo/cssquery-dojo.html) 14:20:27 INFO - PROCESS | 13577 | RSS: Main: 252506112 14:20:27 INFO - PROCESS | 13577 | 14:20:27 INFO - PROCESS | 13577 | __start_tp_report 14:20:27 INFO - PROCESS | 13577 | _x_x_mozilla_page_load 14:20:27 INFO - PROCESS | 13577 | _x_x_mozilla_page_load_details 14:20:27 INFO - PROCESS | 13577 | |i|pagename|runs| 14:20:27 INFO - PROCESS | 13577 | |0;dojo.html;3017.3361860390714;3062.938741225174;3105.223694076481;3112.750979921605;3129.436701393749;5267.920981185285;5313.415524292324;5316;5344.545713614348;5346.812861549846;5396.271503347047;5416.91874621881;5422.8373148805595;5424.430434804348;5497.038018346783;4862.708237505743;4893.09477746618;4974.950250497503;5015.172496538067;5052.898942021157;4834.274858771178;4862.367892174012;4966.130927087764;4977.601791856643;4981.676191047589;4869.904271538893;4881.243407271879;4881.877953051202;4927.679700819435;4928.482509336522;4902.142125128088;4921.409430868319;4926.876828079291;4933.333999910002;4969.602431805447;4775.116603428377;4844.878878028042;4887.218045112765;4932.087563800708;4963.57809586182;5310.468953104697;5324.840254792362;5336.386315573681;5340.198970154469;5345.786168553253;5741.138829175616;5752.137179423078;5753.741081651336;5754.367019627837;5793.594448388614;5704.372519022904;5760.567957403169;5766.452187042266;5801.564882633819;5851.561132915049;5394.973025134888;5397.298351214356;5400.594955378362;5403.108487099624;5408.323959505062;5778.219940308089;5916.112583112482;5917.260342457193;5920.585559010828;5921.141434491975;5626.943730562723;5664.773409063591;5670.659760414388;5685.914711279334;5721.084626459747;5764.7117644117625;5773.8556536086935;5776.913346299809;5777.7977770777825;5781.392953739881;5567.66594004361;5711.485966263056;5743.4543718346695;5753.137029445533;5755.9424405756245;5747.913781293284;5769.740361683735;5771.192033115367;5772.220750198753;5818.6217895836635;4349.021470169187;4355.760433176206;4375.868723938287;4385.956140438555;4427.070315233837;3867;3878.864239751595;3946.625070618287;3950.802459876995;3953.2686453006286;5456.399796022434;5470.890582188334;5474.616776825584;5476.972615136979;5508.091164957817;5805.477507024388;5814.825555233349;5816.214811000461;5817.825465235965;5822.912656310159;5281.9207711884355;5419;5452.40023597404;5472;5510.421405752339;4766.880827979328;4772.212584923449;4774.689645173053;4787.01866117452;4810.855674329776;5869.090291004901;5873.794417195378;5883.941160588425;5888.911666325009;5902.822915312548;5661.377248502744;5736.225609542658;5747.48272655463;5801.593888427769;5851.970740146272;5964.284285885721;5970.373110823301;5980.073088671263;5980.611260268069;6016.969915150396;5691.3170419549915;5697.601167918206;5698.230738850202;5699.287589051369;5705.771769129355;5530.778768849362;5743.56923230751;5758.1650660654805;5820.30156381237;5835;5664.915026274527;5685.403032681675;5689.374168841507;5701.914471282851;5707.229524014205;5657.745401457027;5660.094384898396;5663.150527420919;5667.40492248308;5671.234383358194;5468.425815289337;5575.470330318613;5657.773689052392;5668.178114173505;5678.4605462480995;5665.971670141623;5670.092785154356;5683.062294721325;5686.914696279477;5688.630239034615;5552.583556233218;5559.777608895761;5565.693886836263;5568.9443105568425;5627.577931655224 14:20:27 INFO - PROCESS | 13577 | |1;ext.html;562.7730403098112;568.6843801690062;592.7658574862928;598.4314900844199;614.7817524778701;38605.420918686206;39195.80402097993;39287.41068883962;39294.80352598237;39338.8033059835;42692.57307426925;43145.35281970773;43287.917802054966;43293.56706432935;43316;8562.18659227374;8673.479591224546;8717.607707653138;8742.781430464258;8745.868811967794;8592.957035214815;8645.351598630097;8701.347398945072;8702.47785132894;8707.216350528452;8965.103489651048;9035.638574457014;9036.819263614723;9037.051109633492;9037.502937338477;8847.73456796297;8899.777505562348;8902.599383027778;8911.554422278925;8917.509536975464;8831.293496520262;8952.283817294667;8954.23888969432;8955.955220223923;8956.193942545202;42338;42872.35691464599;42934.78532607317;42938.78530607358;43040.78479607582;3704.9814750926344;3879.9030024249337;4071.4503542021744;4168.791560421997;4414.911701765979;32592;32774.836125819456;33276;33366.6663333366;33416.6658333416;4173.436586060903;4303.160883627694;4310.4396428464415;4357.498887627931;4358.193734159191;304426;305903;305912;306514;306936;48907;64056.35943640504;64429;64533.35466645368;64533.67733161398;48765.75617121892;48825;49215.753921230884;49220.507794922305;49266.75366623144;14479.49321773754;14673.559793206221;14703.338349774285;14704.117752934859;14711.19088450124;11505.13711471643;11564.479598418091;11596.18826682141;11687.941560292144;11697.532098715956;16331.26509307084;16397.344106235618;16740.41408550695;16897.91551042237;16926.153692315336;6517.73929042833;6627.10534077903;6640.169978752656;6678.465722742169;6704.899426508607;1071.4535586850607;1109.2290857853714;1111.4664960818852;1119.3284029582348;1179.3926128044063;33776.49335259973;33781.49327760086;33878.66121338804;33885.830570846985;34344.65655343414;1101.564881871656;1114.242315225638;1202.3627477436971;1214.7084699672191;1247.4885297028175;17144.914275428542;17375.565610859576;17435.56411089733;17481.444458328126;17660.823391766175;200568;200967;201529;201899;202128;58082.70958645264;58788;58848.70575647095;58878.705606471696;58992;1321.6894029902965;1342.6710455938357;1405.1077565745825;1420.3963315590834;1423.395057100728;29411;30728;31699.841500792347;32345.19137021499;33219.33561328808;47551.28673069976;59155;60041.099383510154;60094.69952650209;60127.69936150291;370279;370516;373537;373801;374467;40241.19517609573;46286.7685661583;47716.7614161927;47765.283520746525;47947;44467.33299000453;44832.775836120614;44980.550194498945;45749.54250457453;46134.30798538092;38954.6104538951;39793.20413591654;41058.79470602628;41184.97037574085;42570;40384.19231615293;40507;41012;41462;41643.16713665771;42111.578884210765;42650.573494265904;43033.354499683155;43124.78437607792;43164.8417579126;35461.82269088638;36899.26201476009;37151.442728358554;37418.625813742605;37701.24597507979;28591.571126433537;28696.426071478036;28892.42215155643;28901.855490722413;28998.710012900447 14:20:27 INFO - PROCESS | 13577 | |2;jquery.html;377.901745546158;378.21142917018017;378.458803910408;383.73522269633935;385.1930206217973;17213.569660758487;18396.540086497844;19121.52196195094;19509.707354389695;19547.706784398244;10560.524776385062;10754.99999999998;10796.622118225863;10814.621488247913;10819.891801081987;4942.283368911506;5031.0692521883475;5198.3761948566225;5199.662021968579;5200.7399630018535;5096.8277296221895;5115.488451154892;5126.897462050757;5147.099257629919;5189.091908915943;5090.160123579605;5111.769970351324;5113.5909127269915;5140.460251673577;5163.044836705203;5030.195168772997;5145.151050076733;5171.172612382038;5177.30106435632;5186.0665080285535;5017.8243761468175;5023.79904803811;5024.824131155392;5030.320906677625;5031.899362012776;17480;21304.680429793567;22017.449563760874;22272.220472283556;22321.10715571375;2230.3643461613524;2242.6748121522287;2424.066734307287;2485.8508489490687;2899.884004639833;9267.30495212855;9521.571529281198;9664.806703865883;9868.703938881845;10133.543990520444;1886.9339573114876;1919.7408349872867;1944.9416517504499;1956.1686283329527;2002.98998505008;74783;75318;75704;76751.61624191844;77193;10882.782344353227;11144.777104457866;11237.101031917427;11328.376939268255;11357.886421135683;14924.253787310809;14962.326695298738;14984.850151498564;15004.474843380429;15007.099574025375;7785.610719464117;7896.802579935547;7969.800754981172;8057.274845263954;8092;7788.688452461838;7791.610419479003;7894.763157105296;7935.2064793520185;7937.325327347125;4438.28987362027;4601.631869450436;4813.302071199656;4883.316335713003;4957.578605818474;1888.3107665702194;1911.4265720283859;1921.6156768646326;1935.9322423715103;1956.178405069874;967.56943160293;1037.061459379263;1081.1729027294127;1096.6545538155456;1103.5420300575172;18262;18576.907115464335;19019.80980190208;19109.904450477658;19233.711494327596;1031.654395777408;1034.1623285139062;1049.9895001050045;1063.6436793674206;1131.479519421059;10414.114800242065;10590.682279531626;10819.459027048617;10829.458527073615;11066.336019838835;443420;501493;508098;522193;525115;83939;86092.23847019122;86802.56598717092;87553.56223218843;88531;1101.8898110189077;1119.776044791045;1126.9943650281696;1128.5767837061103;1129.2829053551054;17238.655226895644;17308.048057356464;17318.65362692714;17455.912720436318;17628.823711762718;37774.62225377711;38810.80594597009;39703.60296397115;41105.79447102865;41242;57082.42917570771;57370.13944790748;57557.71221143867;57558;57760.42239577718;7948.960255198687;7952.284294413531;8214.815221569295;8222.753317400488;8272.04871439768;9454.480003599592;11050.834237486284;12379.195352302071;12696.428660710475;13130.212187268795;11303.773924521627;11495.77008459843;11515.193936424705;11596.5361385547;11666.183367164216;11287.322760634388;11319.434028298718;11379.715507112389;11453.770924581295;11491.770164596828;11677.649670509898;11781.469833857669;11814.704632384259;11939.701507462383;11987.940060299643;7938.56337901421;8138.552379619177;8171.344313098148;8227.71203007892;8278.213569710868;10708.839367409339;11724.648260552198;11741.354225517336;11790.882091179321;11921.642350729491 14:20:27 INFO - PROCESS | 13577 | |3;mootools.html;1428.0931608428657;1562.8515291047352;1567.6316065724552;1791.0954967741288;1919.5872887329222;7469.290417410344;7992.880106798395;8149.633266503007;8174.6321415536295;8181.631826567804;7920.366370690345;8132;8158.959205203966;8165.755027349174;8168.305694016016;1975.2987689370211;2052.138101997165;2345.5074434368717;2360.3509035015336;2388.9641655375185;2392.162743039931;2401.435662619283;2402.723686776017;2403.170906037423;2403.9038438462526;2315.22439982606;2336.0538981712434;2365.3849999000213;2366.6686663866985;2369.9052037918464;2334.2063698342645;2341.812654987597;2355.693759811222;2407.5064611754547;2407.65089062085;2351.6707660927314;2367.9289621311386;2387.152560840894;2394.2697477269426;2405.783479486837;8308.958455207685;8311.210435008665;8313.792155196108;8330.208630180123;8359.874601880976;5166.560842328407;5280.9207861882105;5282.841514754564;5290.470952904717;5291;3449.810260435675;3484.4250698634696;3501.38725723;3597.1546686528645;3648.1609229877276;1166.9533218671243;1197.3953153657346;1223;1228.6498347970876;1230.0958795285458;11805.468753906094;11811.704707382385;11816.05471562273;11822.231554948901;11852.466639001179;4623.329617205486;4726.574608285271;4754.881127971828;4770.737609431515;4783.521647835189;9955.950220248997;9966.451845148586;9972.850407243897;9989.30074894765;10001.2999090063;5242.7640756166065;5245.160774276097;5247.842564723064;5248.553872920845;5252.711100889412;4145.751254924714;4664.137134630104;4784.210605250095;4784.617230621542;4786.832460863922;4005.098852758106;4006.7595944242858;4033.596640335943;4080.8775736727353;4106.774127422961;1249.5439164704817;1253.7993920972601;1262.3246563088703;1262.482382223284;1291.9547815826402;1283.9935800320939;1428.3014551567062;1436.6552027513321;1467.33236377448;1469.6840179361275;8164.836703265902;8169.71406000799;8177.223163799429;8210.055843578066;8229.547374894319;498.1307667833306;498.9925151122736;505.5430607248768;509.11668255576546;509.1598861877931;6251.937480625226;6279.7488100476385;6293.748250069946;6309.589876658094;6321.241451025906;10089.58745775592;10303.3817970922;10396.844047339297;10438;10488.68533943983;9660;10165.745856353651;10277.075063244343;10296.330738501973;10309.948450257702;7906.723264685824;7923.841523169504;7978.922845415911;8120.14738452454;8122.675092996332;7922.445428819928;7941.642626081724;8035.718749843727;8044.3564514839845;8084.434089613671;9106.180443759828;9108.863367049633;9111.043340449158;9159.86260206084;9172.266218702354;9330.580123894306;9377.85933211016;9570.56932438028;9575;9581.712548623553;6615.834604134935;7102.502824802421;7310.268973102648;7317.12194536659;7414.147373051952;7991.64037618297;7993.320567751806;8007.479513831815;8042.3968202383885;8090.474119182234;7141.392981596622;7302.6713797878165;7348.191698913222;7434.925650743423;7478;7021.824454388681;7128.643567821485;7152.356287934111;7240.6017669026605;7458.92541074604;7479.588622625808;7489;7531.962340188264;7532.811679708051;7541;6993.125859267591;7026.016357709823;7070.858582828418;7076.221615622175;7086.929130708627;7098.36114749675;7107.182673992557;7136.0723105995885;7137.10786151731;7161.355478007004 14:20:27 INFO - PROCESS | 13577 | |4;prototype.html;344.0641455241743;344.88273986844473;346.45087536255033;347.50133558343765;354.4806857953098;5987.790427335039;5988.40115988401;5999.5500337474705;6021.578489505737;6075.392460753934;6010.489108425778;6022.0966854971775;6030.155778191057;6032.366601506834;6033.1855199548045;4375.781210939456;4517.570830771071;4594.839180628679;4653.767311634405;4679.181143299926;4656.883577910562;4656.930146047812;4668.836590719326;4674.626029917616;4686.343911852344;4550.2264615015365;4597.586217240448;4605.585497305242;4608.193566125931;4644.326572646964;4349.151915376503;4511.007578332761;4564.041551274237;4609.446866376023;4610.95389046112;4032.3749818778138;4041.595840415964;4056.9391459128137;4059.0664147246002;4064.8170832312617;5689.800856970028;5755.395683453261;5760.0783874579865;5761.366249712528;5768.625039372428;5399.19012148177;5399.568034557226;5401.78392864285;5406.648567843117;5411.053065713484;6330.430261276507;6339.207599050119;6343.048542718583;6348.0477928310665;6353.30113687494;4411.228035093878;4547.272436410159;4565.908681826378;4574.748388838612;4588.977055114703;6593.439557637606;6640.136782218281;6655.800325990228;6669;6670.199576050905;4674.158651442705;4678.95321046792;4679.438467383936;4682.906341873211;4695.694779839368;4753.714777113384;4754;4758.357621721023;4759.690620109682;4763.95236047642;5405.945940540623;5408.3509978802795;5410.729463526808;5419.241306217133;5419.674819510842;6302.464290535356;6396.84007899797;6419.550631455753;6432.260290066609;6502.674866256668;1647.8022637283602;1663.2931004323357;1670.381958675298;1673.9832601673827;1675.5643532681347;1046.3042077018697;1136.0797753819434;1136.9602063927723;1154.7979103656826;1164.4585267850491;6037.1246169305205;6090.543209259324;6094.512439004869;6106.72519736613;6121.173641558422;6501.47988160946;6509.707063182168;6513.967430162819;6523.967380163069;6524.412802847766;6075.605085669417;6079.787207447718;6082.635041897501;6085.1785009023215;6094.055421409688;3461.9826900865332;3480.3387356402204;3489.7382696297877;3494.4408894576745;3495.265994141208;6611.834704132339;6689.933100669028;6758.526903116833;6782.660866956632;6785;6621.404073633396;6644.60132392058;6657.300983396771;6658.1011563438315;6669.199696036507;6718.193816742022;6723.562968407038;6764.0530325754435;6777.186737591521;6778.389944904884;6499.7400103995315;6508.8047358579315;6509.381608747351;6519.511036672174;6523.24982627004;6308.52686048539;6446.709898054505;6448.484121270193;6537.640429776217;6553.705083271169;6840.41856442208;6865.725370985105;6877.4841886857685;6885.380315771605;6891.862162756817;4462.866114016585;4491.528389519184;4495.865124046284;4503.54964503547;4508.346289787897;6557.606543607399;6561.40947314744;6564.606123632598;6570.342965703391;6574.539782215199;6229.626222426669;6395.296517382991;6403.775867844603;6423.582467139621;6424.871502570016;6365.013422919455;6403.96798016007;6404.199475065617;6408.359164083741;6417.2299324081405;6309.810705678837;6310.242770867525;6313.715882785194;6319.304876463677;6320.273168585672;6434.8391290218115;6454.19322584677;6472.967635161794;6507.28419873823;6528.934710653023;6009.669468179117;6019.668918209541;6088.908666370096;6270.341614130633;6304.275008373912 14:20:27 INFO - PROCESS | 13577 | |5;yui.html;890.5903284489136;897.8383890899636;897.9146981036802;908.7410088124885;924.3113880159283;13922.930385348072;14063.789043164348;14069.4372225111;14096.859031409684;14114.29428528572;13338.733225335487;13405.530806421753;13416.93291533541;13481.595552133427;13603;702.1048163591436;833.4749108061912;860.3977215948829;866.774638593967;871.5947084605657;859.6776208921655;861.8793368928355;862.469581207556;862.9137086291352;863.1972265792841;897.5960817632059;909.9499527525984;916.8349697054527;917.1745429113785;917.47703808829;739.5267029101379;878.3149143667981;891.5007595746371;894.9731508054768;897.1028971028971;654.1790053482896;655.207199288861;656.3272645538314;657.7171816119067;659.2122413715612;14609.634759131;14668;14686.55940321792;14689.412423503047;14704.338304776204;13943.233122178277;14282.785758213635;14466.782998255034;14530.709385812224;14653.41386344545;11689.941550292195;11761.94119029408;11837.230580012272;11849.585264515701;11881.40592970348;3891.8443262269475;3892.2799282132614;3902.3366027775346;3907.179492306619;3936.252112098692;55664.443355566735;55816;55998.44001559973;56632.7525435594;56702.14946775802;10560.260781745204;10638.255322127532;10766.138708903269;10926.890731092746;11394.430278486043;18829.717554236697;18843.52891177704;18894.244230230637;18924.33764818252;18933.62132757337;8248.092709801916;8373.790655233668;8375.706850260334;8491.448055876348;8597.312215022783;4760.904781904412;4799.904001920012;4821.156297647897;4834.226523756182;4840.782164802522;3522.119470132467;3525.3301872644115;3528.7177025837873;3535.5580552430947;3540.6282340354405;620.9627422354673;630.1209812311799;636.1030946365602;637.6970938804031;661.3783043938682;803.5741057239673;806.5361369115037;809.4697972827807;814.678202110175;828.9088200297963;9743.415395076318;9763.85354219673;9776.266779991529;9825.459599722084;10373;599.4754589733983;636.7262077306802;763.1948294549193;768.3161985832613;788.6569342336102;4560.247559152703;4694.554017368345;4711.599514041276;4759.666823322404;4809.374781278411;61932;63143.684281578295;63284.36715632877;64349;64718;56003.43996559982;56887.43112568904;57076;57154.428455715744;57490;47869.5213047865;48426.03147937021;49442.75278623584;51869.221961670606;51891.48108518942;9216.124468175512;9225.953870230605;9360.297977651568;9415.057095024893;9429.15137637616;39479.80260098681;39516.40725389179;39746;39954;40558.94481443396;46014;46705.76647116743;49898;50123;50629.49370506248;11245.381504017358;11360.431978400882;11432.14258930567;11497.195196336175;11626.825597615873;12083.335416552174;12138.635840924786;12338;12349.814752778895;12351.3824308786;11569.19015668895;11659.650210493699;12215.816762748389;12389.814152787536;12590.24458532491;12034.458449369624;12179.817302740643;12239.265644061385;12586.748265034465;12594.496220151092;11751.353675547927;11817.881821181678;11934.761304774029;12172.14794964344;12198.14612977083;10417.16662667;10503.369797812156;10620.893791062299;10723.678289651323;10804.837927430937;10597;10646;10672.30630009047;10674.146068314361;10748.462576870968 14:20:27 INFO - PROCESS | 13577 | __end_tp_report 14:20:27 INFO - PROCESS | 13577 | __start_cc_report 14:20:27 INFO - PROCESS | 13577 | _x_x_mozilla_cycle_collect,849 14:20:27 INFO - PROCESS | 13577 | __end_cc_report 14:20:27 INFO - PROCESS | 13577 | __startTimestamp1457990427469__endTimestamp 14:20:27 INFO - PROCESS | 13577 | 14:20:27 INFO - PROCESS | 13577 | ------- Summary: start ------- 14:20:27 INFO - PROCESS | 13577 | Number of tests: 6 14:20:27 INFO - PROCESS | 13577 | 14:20:27 INFO - PROCESS | 13577 | [#0] dojo.html Cycles:165 Average:5351.44 Median:5575.47 stddev:617.03 (11.1%) stddev-sans-first:591.13 14:20:27 INFO - PROCESS | 13577 | Values: 3017.3 3062.9 3105.2 3112.8 3129.4 5267.9 5313.4 5316.0 5344.5 5346.8 5396.3 5416.9 5422.8 5424.4 5497.0 4862.7 4893.1 4975.0 5015.2 5052.9 4834.3 4862.4 4966.1 4977.6 4981.7 4869.9 4881.2 4881.9 4927.7 4928.5 4902.1 4921.4 4926.9 4933.3 4969.6 4775.1 4844.9 4887.2 4932.1 4963.6 5310.5 5324.8 5336.4 5340.2 5345.8 5741.1 5752.1 5753.7 5754.4 5793.6 5704.4 5760.6 5766.5 5801.6 5851.6 5395.0 5397.3 5400.6 5403.1 5408.3 5778.2 5916.1 5917.3 5920.6 5921.1 5626.9 5664.8 5670.7 5685.9 5721.1 5764.7 5773.9 5776.9 5777.8 5781.4 5567.7 5711.5 5743.5 5753.1 5755.9 5747.9 5769.7 5771.2 5772.2 5818.6 4349.0 4355.8 4375.9 4386.0 4427.1 3867.0 3878.9 3946.6 3950.8 3953.3 5456.4 5470.9 5474.6 5477.0 5508.1 5805.5 5814.8 5816.2 5817.8 5822.9 5281.9 5419.0 5452.4 5472.0 5510.4 4766.9 4772.2 4774.7 4787.0 4810.9 5869.1 5873.8 5883.9 5888.9 5902.8 5661.4 5736.2 5747.5 5801.6 5852.0 5964.3 5970.4 5980.1 5980.6 6017.0 5691.3 5697.6 5698.2 5699.3 5705.8 5530.8 5743.6 5758.2 5820.3 5835.0 5664.9 5685.4 5689.4 5701.9 5707.2 5657.7 5660.1 5663.2 5667.4 5671.2 5468.4 5575.5 5657.8 5668.2 5678.5 5666.0 5670.1 5683.1 5686.9 5688.6 5552.6 5559.8 5565.7 5568.9 5627.6 14:20:27 INFO - PROCESS | 13577 | 14:20:27 INFO - PROCESS | 13577 | [#1] ext.html Cycles:180 Average:48201.36 Median:41323.49 stddev:79044.73 (191.3%) stddev-sans-first:79185.54 14:20:27 INFO - PROCESS | 13577 | Values: 562.8 568.7 592.8 598.4 614.8 38605.4 39195.8 39287.4 39294.8 39338.8 42692.6 43145.4 43287.9 43293.6 43316.0 8562.2 8673.5 8717.6 8742.8 8745.9 8593.0 8645.4 8701.3 8702.5 8707.2 8965.1 9035.6 9036.8 9037.1 9037.5 8847.7 8899.8 8902.6 8911.6 8917.5 8831.3 8952.3 8954.2 8956.0 8956.2 42338.0 42872.4 42934.8 42938.8 43040.8 3705.0 3879.9 4071.5 4168.8 4414.9 32592.0 32774.8 33276.0 33366.7 33416.7 4173.4 4303.2 4310.4 4357.5 4358.2 304426.0 305903.0 305912.0 306514.0 306936.0 48907.0 64056.4 64429.0 64533.4 64533.7 48765.8 48825.0 49215.8 49220.5 49266.8 14479.5 14673.6 14703.3 14704.1 14711.2 11505.1 11564.5 11596.2 11687.9 11697.5 16331.3 16397.3 16740.4 16897.9 16926.2 6517.7 6627.1 6640.2 6678.5 6704.9 1071.5 1109.2 1111.5 1119.3 1179.4 33776.5 33781.5 33878.7 33885.8 34344.7 1101.6 1114.2 1202.4 1214.7 1247.5 17144.9 17375.6 17435.6 17481.4 17660.8 200568.0 200967.0 201529.0 201899.0 202128.0 58082.7 58788.0 58848.7 58878.7 58992.0 1321.7 1342.7 1405.1 1420.4 1423.4 29411.0 30728.0 31699.8 32345.2 33219.3 47551.3 59155.0 60041.1 60094.7 60127.7 370279.0 370516.0 373537.0 373801.0 374467.0 40241.2 46286.8 47716.8 47765.3 47947.0 44467.3 44832.8 44980.6 45749.5 46134.3 38954.6 39793.2 41058.8 41185.0 42570.0 40384.2 40507.0 41012.0 41462.0 41643.2 42111.6 42650.6 43033.4 43124.8 43164.8 35461.8 36899.3 37151.4 37418.6 37701.2 28591.6 28696.4 28892.4 28901.9 28998.7 14:20:27 INFO - PROCESS | 13577 | 14:20:27 INFO - PROCESS | 13577 | [#2] jquery.html Cycles:180 Average:28433.24 Median:2333.37 stddev:82425.80 (3532.5%) stddev-sans-first:82630.10 14:20:27 INFO - PROCESS | 13577 | Values: 377.9 378.2 378.5 383.7 385.2 17213.6 18396.5 19121.5 19509.7 19547.7 10560.5 10755.0 10796.6 10814.6 10819.9 4942.3 5031.1 5198.4 5199.7 5200.7 5096.8 5115.5 5126.9 5147.1 5189.1 5090.2 5111.8 5113.6 5140.5 5163.0 5030.2 5145.2 5171.2 5177.3 5186.1 5017.8 5023.8 5024.8 5030.3 5031.9 17480.0 21304.7 22017.4 22272.2 22321.1 2230.4 2242.7 2424.1 2485.9 2899.9 9267.3 9521.6 9664.8 9868.7 10133.5 1886.9 1919.7 1944.9 1956.2 2003.0 74783.0 75318.0 75704.0 76751.6 77193.0 10882.8 11144.8 11237.1 11328.4 11357.9 14924.3 14962.3 14984.9 15004.5 15007.1 7785.6 7896.8 7969.8 8057.3 8092.0 7788.7 7791.6 7894.8 7935.2 7937.3 4438.3 4601.6 4813.3 4883.3 4957.6 1888.3 1911.4 1921.6 1935.9 1956.2 967.6 1037.1 1081.2 1096.7 1103.5 18262.0 18576.9 19019.8 19109.9 19233.7 1031.7 1034.2 1050.0 1063.6 1131.5 10414.1 10590.7 10819.5 10829.5 11066.3 443420.0 501493.0 508098.0 522193.0 525115.0 83939.0 86092.2 86802.6 87553.6 88531.0 1101.9 1119.8 1127.0 1128.6 1129.3 17238.7 17308.0 17318.7 17455.9 17628.8 37774.6 38810.8 39703.6 41105.8 41242.0 57082.4 57370.1 57557.7 57558.0 57760.4 7949.0 7952.3 8214.8 8222.8 8272.0 9454.5 11050.8 12379.2 12696.4 13130.2 11303.8 11495.8 11515.2 11596.5 11666.2 11287.3 11319.4 11379.7 11453.8 11491.8 11677.6 11781.5 11814.7 11939.7 11987.9 7938.6 8138.6 8171.3 8227.7 8278.2 10708.8 11724.6 11741.4 11790.9 11921.6 14:20:27 INFO - PROCESS | 13577 | 14:20:27 INFO - PROCESS | 13577 | [#3] mootools.html Cycles:180 Average:5902.01 Median:5266.82 stddev:3102.85 (58.9%) stddev-sans-first:3093.33 14:20:27 INFO - PROCESS | 13577 | Values: 1428.1 1562.9 1567.6 1791.1 1919.6 7469.3 7992.9 8149.6 8174.6 8181.6 7920.4 8132.0 8159.0 8165.8 8168.3 1975.3 2052.1 2345.5 2360.4 2389.0 2392.2 2401.4 2402.7 2403.2 2403.9 2315.2 2336.1 2365.4 2366.7 2369.9 2334.2 2341.8 2355.7 2407.5 2407.7 2351.7 2367.9 2387.2 2394.3 2405.8 8309.0 8311.2 8313.8 8330.2 8359.9 5166.6 5280.9 5282.8 5290.5 5291.0 3449.8 3484.4 3501.4 3597.2 3648.2 1167.0 1197.4 1223.0 1228.6 1230.1 11805.5 11811.7 11816.1 11822.2 11852.5 4623.3 4726.6 4754.9 4770.7 4783.5 9956.0 9966.5 9972.9 9989.3 10001.3 5242.8 5245.2 5247.8 5248.6 5252.7 4145.8 4664.1 4784.2 4784.6 4786.8 4005.1 4006.8 4033.6 4080.9 4106.8 1249.5 1253.8 1262.3 1262.5 1292.0 1284.0 1428.3 1436.7 1467.3 1469.7 8164.8 8169.7 8177.2 8210.1 8229.5 498.1 499.0 505.5 509.1 509.2 6251.9 6279.7 6293.7 6309.6 6321.2 10089.6 10303.4 10396.8 10438.0 10488.7 9660.0 10165.7 10277.1 10296.3 10309.9 7906.7 7923.8 7978.9 8120.1 8122.7 7922.4 7941.6 8035.7 8044.4 8084.4 9106.2 9108.9 9111.0 9159.9 9172.3 9330.6 9377.9 9570.6 9575.0 9581.7 6615.8 7102.5 7310.3 7317.1 7414.1 7991.6 7993.3 8007.5 8042.4 8090.5 7141.4 7302.7 7348.2 7434.9 7478.0 7021.8 7128.6 7152.4 7240.6 7458.9 7479.6 7489.0 7532.0 7532.8 7541.0 6993.1 7026.0 7070.9 7076.2 7086.9 7098.4 7107.2 7136.1 7137.1 7161.4 14:20:27 INFO - PROCESS | 13577 | 14:20:27 INFO - PROCESS | 13577 | [#4] prototype.html Cycles:180 Average:5345.73 Median:6035.16 stddev:1588.83 (26.3%) stddev-sans-first:1548.30 14:20:27 INFO - PROCESS | 13577 | Values: 344.1 344.9 346.5 347.5 354.5 5987.8 5988.4 5999.6 6021.6 6075.4 6010.5 6022.1 6030.2 6032.4 6033.2 4375.8 4517.6 4594.8 4653.8 4679.2 4656.9 4656.9 4668.8 4674.6 4686.3 4550.2 4597.6 4605.6 4608.2 4644.3 4349.2 4511.0 4564.0 4609.4 4611.0 4032.4 4041.6 4056.9 4059.1 4064.8 5689.8 5755.4 5760.1 5761.4 5768.6 5399.2 5399.6 5401.8 5406.6 5411.1 6330.4 6339.2 6343.0 6348.0 6353.3 4411.2 4547.3 4565.9 4574.7 4589.0 6593.4 6640.1 6655.8 6669.0 6670.2 4674.2 4679.0 4679.4 4682.9 4695.7 4753.7 4754.0 4758.4 4759.7 4764.0 5405.9 5408.4 5410.7 5419.2 5419.7 6302.5 6396.8 6419.6 6432.3 6502.7 1647.8 1663.3 1670.4 1674.0 1675.6 1046.3 1136.1 1137.0 1154.8 1164.5 6037.1 6090.5 6094.5 6106.7 6121.2 6501.5 6509.7 6514.0 6524.0 6524.4 6075.6 6079.8 6082.6 6085.2 6094.1 3462.0 3480.3 3489.7 3494.4 3495.3 6611.8 6689.9 6758.5 6782.7 6785.0 6621.4 6644.6 6657.3 6658.1 6669.2 6718.2 6723.6 6764.1 6777.2 6778.4 6499.7 6508.8 6509.4 6519.5 6523.2 6308.5 6446.7 6448.5 6537.6 6553.7 6840.4 6865.7 6877.5 6885.4 6891.9 4462.9 4491.5 4495.9 4503.5 4508.3 6557.6 6561.4 6564.6 6570.3 6574.5 6229.6 6395.3 6403.8 6423.6 6424.9 6365.0 6404.0 6404.2 6408.4 6417.2 6309.8 6310.2 6313.7 6319.3 6320.3 6434.8 6454.2 6473.0 6507.3 6528.9 6009.7 6019.7 6088.9 6270.3 6304.3 14:20:27 INFO - PROCESS | 13577 | 14:20:27 INFO - PROCESS | 13577 | [#5] yui.html Cycles:180 Average:15172.91 Median:4735.63 stddev:17758.77 (375.0%) stddev-sans-first:17776.20 14:20:27 INFO - PROCESS | 13577 | Values: 890.6 897.8 897.9 908.7 924.3 13922.9 14063.8 14069.4 14096.9 14114.3 13338.7 13405.5 13416.9 13481.6 13603.0 702.1 833.5 860.4 866.8 871.6 859.7 861.9 862.5 862.9 863.2 897.6 909.9 916.8 917.2 917.5 739.5 878.3 891.5 895.0 897.1 654.2 655.2 656.3 657.7 659.2 14609.6 14668.0 14686.6 14689.4 14704.3 13943.2 14282.8 14466.8 14530.7 14653.4 11689.9 11761.9 11837.2 11849.6 11881.4 3891.8 3892.3 3902.3 3907.2 3936.3 55664.4 55816.0 55998.4 56632.8 56702.1 10560.3 10638.3 10766.1 10926.9 11394.4 18829.7 18843.5 18894.2 18924.3 18933.6 8248.1 8373.8 8375.7 8491.4 8597.3 4760.9 4799.9 4821.2 4834.2 4840.8 3522.1 3525.3 3528.7 3535.6 3540.6 621.0 630.1 636.1 637.7 661.4 803.6 806.5 809.5 814.7 828.9 9743.4 9763.9 9776.3 9825.5 10373.0 599.5 636.7 763.2 768.3 788.7 4560.2 4694.6 4711.6 4759.7 4809.4 61932.0 63143.7 63284.4 64349.0 64718.0 56003.4 56887.4 57076.0 57154.4 57490.0 47869.5 48426.0 49442.8 51869.2 51891.5 9216.1 9226.0 9360.3 9415.1 9429.2 39479.8 39516.4 39746.0 39954.0 40558.9 46014.0 46705.8 49898.0 50123.0 50629.5 11245.4 11360.4 11432.1 11497.2 11626.8 12083.3 12138.6 12338.0 12349.8 12351.4 11569.2 11659.7 12215.8 12389.8 12590.2 12034.5 12179.8 12239.3 12586.7 12594.5 11751.4 11817.9 11934.8 12172.1 12198.1 10417.2 10503.4 10620.9 10723.7 10804.8 10597.0 10646.0 10672.3 10674.1 10748.5 14:20:27 INFO - PROCESS | 13577 | -------- Summary: end -------- 14:20:27 INFO - PROCESS | 13577 | 14:20:28 INFO - TEST-INFO | 13577: exit 0 14:20:28 INFO - TEST-OK | dromaeo_css | took 1110761ms 14:20:28 INFO - TEST-START | kraken 14:20:28 INFO - operating with platform_type : linux_ 14:20:28 INFO - Initialising browser for kraken test... 14:20:28 INFO - TEST-INFO | started process 13763 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpF7Gbcf/profile http://localhost:36218/getInfo.html) 14:20:32 INFO - PROCESS | 13763 | __metrics Screen width/height:1600/1200 14:20:32 INFO - PROCESS | 13763 | colorDepth:24 14:20:32 INFO - PROCESS | 13763 | Browser inner width/height: 1024/697 14:20:32 INFO - PROCESS | 13763 | __metrics 14:20:33 ERROR - PROCESS | 13763 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:20:34 INFO - TEST-INFO | 13763: exit 0 14:20:34 INFO - Browser initialized. 14:20:34 INFO - Running cycle 1/1 for kraken test... 14:20:34 INFO - TEST-INFO | started process 13844 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpF7Gbcf/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:20:45 INFO - PROCESS | 13844 | RSS: Main: 153260032 14:20:45 INFO - PROCESS | 13844 | 14:20:48 INFO - PROCESS | 13844 | Cycle 1(1): loaded http://localhost:36218/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36218/tests/kraken/driver.html?testName=audio-beat-detection) 14:20:49 INFO - PROCESS | 13844 | RSS: Main: 194605056 14:20:49 INFO - PROCESS | 13844 | 14:20:51 INFO - PROCESS | 13844 | Cycle 1(1): loaded http://localhost:36218/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36218/tests/kraken/driver.html?testName=audio-dft) 14:20:52 INFO - PROCESS | 13844 | RSS: Main: 185044992 14:20:52 INFO - PROCESS | 13844 | 14:20:57 INFO - PROCESS | 13844 | Cycle 1(1): loaded http://localhost:36218/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36218/tests/kraken/driver.html?testName=audio-fft) 14:20:58 INFO - PROCESS | 13844 | RSS: Main: 172007424 14:20:58 INFO - PROCESS | 13844 | 14:21:00 INFO - PROCESS | 13844 | Cycle 1(1): loaded http://localhost:36218/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36218/tests/kraken/driver.html?testName=audio-oscillator) 14:21:00 INFO - PROCESS | 13844 | RSS: Main: 174907392 14:21:00 INFO - PROCESS | 13844 | 14:21:02 INFO - PROCESS | 13844 | Cycle 1(1): loaded http://localhost:36218/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36218/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:21:03 INFO - PROCESS | 13844 | RSS: Main: 173256704 14:21:03 INFO - PROCESS | 13844 | 14:21:06 INFO - PROCESS | 13844 | Cycle 1(1): loaded http://localhost:36218/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36218/tests/kraken/driver.html?testName=imaging-darkroom) 14:21:07 INFO - PROCESS | 13844 | RSS: Main: 174387200 14:21:07 INFO - PROCESS | 13844 | 14:21:11 INFO - PROCESS | 13844 | Cycle 1(1): loaded http://localhost:36218/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36218/tests/kraken/driver.html?testName=imaging-desaturate) 14:21:11 INFO - PROCESS | 13844 | RSS: Main: 172937216 14:21:11 INFO - PROCESS | 13844 | 14:21:14 INFO - PROCESS | 13844 | Cycle 1(1): loaded http://localhost:36218/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36218/tests/kraken/driver.html?testName=json-parse-financial) 14:21:15 INFO - PROCESS | 13844 | RSS: Main: 174379008 14:21:15 INFO - PROCESS | 13844 | 14:21:16 INFO - PROCESS | 13844 | Cycle 1(1): loaded http://localhost:36218/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36218/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:21:17 INFO - PROCESS | 13844 | RSS: Main: 187707392 14:21:17 INFO - PROCESS | 13844 | 14:21:19 INFO - PROCESS | 13844 | Cycle 1(1): loaded http://localhost:36218/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36218/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:21:19 INFO - PROCESS | 13844 | RSS: Main: 183840768 14:21:19 INFO - PROCESS | 13844 | 14:21:21 INFO - PROCESS | 13844 | Cycle 1(1): loaded http://localhost:36218/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36218/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:21:22 INFO - PROCESS | 13844 | RSS: Main: 193589248 14:21:22 INFO - PROCESS | 13844 | 14:21:24 INFO - PROCESS | 13844 | Cycle 1(1): loaded http://localhost:36218/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36218/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:21:25 INFO - PROCESS | 13844 | RSS: Main: 199135232 14:21:25 INFO - PROCESS | 13844 | 14:21:27 INFO - PROCESS | 13844 | Cycle 1(1): loaded http://localhost:36218/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36218/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:21:28 INFO - PROCESS | 13844 | RSS: Main: 200445952 14:21:28 INFO - PROCESS | 13844 | 14:21:30 INFO - PROCESS | 13844 | Cycle 1(1): loaded http://localhost:36218/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36218/tests/kraken/driver.html?testName=ai-astar) 14:21:30 INFO - PROCESS | 13844 | RSS: Main: 259645440 14:21:30 INFO - PROCESS | 13844 | 14:21:30 INFO - PROCESS | 13844 | __start_tp_report 14:21:30 INFO - PROCESS | 13844 | _x_x_mozilla_page_load 14:21:30 INFO - PROCESS | 13844 | _x_x_mozilla_page_load_details 14:21:30 INFO - PROCESS | 13844 | |i|pagename|runs| 14:21:30 INFO - PROCESS | 13844 | |0;ai-astar;109;109;104;108;108;109;98;108;108;109 14:21:30 INFO - PROCESS | 13844 | |1;audio-beat-detection;157;125;148;173;125;150;152;127;170;133 14:21:30 INFO - PROCESS | 13844 | |2;audio-dft;378;376;378;377;378;377;376;377;376;377 14:21:30 INFO - PROCESS | 13844 | |3;audio-fft;73;74;73;161;73;73;73;74;160;73 14:21:30 INFO - PROCESS | 13844 | |4;audio-oscillator;93;93;149;93;94;93;142;93;93;142 14:21:30 INFO - PROCESS | 13844 | |5;imaging-gaussian-blur;116;117;116;116;116;117;117;117;117;117 14:21:30 INFO - PROCESS | 13844 | |6;imaging-darkroom;193;193;193;192;193;192;193;193;193;193 14:21:30 INFO - PROCESS | 13844 | |7;imaging-desaturate;96;95;96;96;95;95;96;95;95;95 14:21:30 INFO - PROCESS | 13844 | |8;json-parse-financial;56;57;58;56;57;56;57;57;59;56 14:21:30 INFO - PROCESS | 13844 | |9;json-stringify-tinderbox;58;60;60;59;65;61;59;60;58;60 14:21:30 INFO - PROCESS | 13844 | |10;stanford-crypto-aes;85;78;79;79;86;78;78;80;90;79 14:21:30 INFO - PROCESS | 13844 | |11;stanford-crypto-ccm;112;109;122;108;117;110;108;109;116;113 14:21:30 INFO - PROCESS | 13844 | |12;stanford-crypto-pbkdf2;139;144;142;144;145;134;145;143;140;142 14:21:30 INFO - PROCESS | 13844 | |13;stanford-crypto-sha256-iterative;65;63;67;64;64;63;62;65;64;63 14:21:30 INFO - PROCESS | 13844 | __end_tp_report 14:21:30 INFO - PROCESS | 13844 | __start_cc_report 14:21:30 INFO - PROCESS | 13844 | _x_x_mozilla_cycle_collect,1029 14:21:30 INFO - PROCESS | 13844 | __end_cc_report 14:21:30 INFO - PROCESS | 13844 | __startTimestamp1457990490306__endTimestamp 14:21:30 INFO - PROCESS | 13844 | 14:21:30 INFO - PROCESS | 13844 | ------- Summary: start ------- 14:21:30 INFO - PROCESS | 13844 | Number of tests: 14 14:21:30 INFO - PROCESS | 13844 | 14:21:30 INFO - PROCESS | 13844 | [#0] ai-astar Cycles:10 Average:107.00 Median:109.00 stddev:3.50 (3.2%) stddev-sans-first:3.63 14:21:30 INFO - PROCESS | 13844 | Values: 109.0 109.0 104.0 108.0 108.0 109.0 98.0 108.0 108.0 109.0 14:21:30 INFO - PROCESS | 13844 | 14:21:30 INFO - PROCESS | 13844 | [#1] audio-beat-detection Cycles:10 Average:146.00 Median:151.00 stddev:17.93 (11.9%) stddev-sans-first:18.57 14:21:30 INFO - PROCESS | 13844 | Values: 157.0 125.0 148.0 173.0 125.0 150.0 152.0 127.0 170.0 133.0 14:21:30 INFO - PROCESS | 13844 | 14:21:30 INFO - PROCESS | 13844 | [#2] audio-dft Cycles:10 Average:377.00 Median:377.00 stddev:0.82 (0.2%) stddev-sans-first:0.78 14:21:30 INFO - PROCESS | 13844 | Values: 378.0 376.0 378.0 377.0 378.0 377.0 376.0 377.0 376.0 377.0 14:21:30 INFO - PROCESS | 13844 | 14:21:30 INFO - PROCESS | 13844 | [#3] audio-fft Cycles:10 Average:90.70 Median:73.00 stddev:36.79 (50.4%) stddev-sans-first:38.46 14:21:30 INFO - PROCESS | 13844 | Values: 73.0 74.0 73.0 161.0 73.0 73.0 73.0 74.0 160.0 73.0 14:21:30 INFO - PROCESS | 13844 | 14:21:30 INFO - PROCESS | 13844 | [#4] audio-oscillator Cycles:10 Average:108.50 Median:93.00 stddev:24.80 (26.7%) stddev-sans-first:25.67 14:21:30 INFO - PROCESS | 13844 | Values: 93.0 93.0 149.0 93.0 94.0 93.0 142.0 93.0 93.0 142.0 14:21:30 INFO - PROCESS | 13844 | 14:21:30 INFO - PROCESS | 13844 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 14:21:30 INFO - PROCESS | 13844 | Values: 116.0 117.0 116.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 14:21:30 INFO - PROCESS | 13844 | 14:21:30 INFO - PROCESS | 13844 | [#6] imaging-darkroom Cycles:10 Average:192.80 Median:193.00 stddev:0.42 (0.2%) stddev-sans-first:0.44 14:21:30 INFO - PROCESS | 13844 | Values: 193.0 193.0 193.0 192.0 193.0 192.0 193.0 193.0 193.0 193.0 14:21:30 INFO - PROCESS | 13844 | 14:21:30 INFO - PROCESS | 13844 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 14:21:30 INFO - PROCESS | 13844 | Values: 96.0 95.0 96.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 14:21:30 INFO - PROCESS | 13844 | 14:21:30 INFO - PROCESS | 13844 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:57.00 stddev:0.99 (1.7%) stddev-sans-first:1.00 14:21:30 INFO - PROCESS | 13844 | Values: 56.0 57.0 58.0 56.0 57.0 56.0 57.0 57.0 59.0 56.0 14:21:30 INFO - PROCESS | 13844 | 14:21:30 INFO - PROCESS | 13844 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:2.00 (3.3%) stddev-sans-first:1.99 14:21:30 INFO - PROCESS | 13844 | Values: 58.0 60.0 60.0 59.0 65.0 61.0 59.0 60.0 58.0 60.0 14:21:30 INFO - PROCESS | 13844 | 14:21:30 INFO - PROCESS | 13844 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:79.50 stddev:4.24 (5.3%) stddev-sans-first:4.27 14:21:30 INFO - PROCESS | 13844 | Values: 85.0 78.0 79.0 79.0 86.0 78.0 78.0 80.0 90.0 79.0 14:21:30 INFO - PROCESS | 13844 | 14:21:30 INFO - PROCESS | 13844 | [#11] stanford-crypto-ccm Cycles:10 Average:112.40 Median:112.50 stddev:4.65 (4.1%) stddev-sans-first:4.93 14:21:30 INFO - PROCESS | 13844 | Values: 112.0 109.0 122.0 108.0 117.0 110.0 108.0 109.0 116.0 113.0 14:21:30 INFO - PROCESS | 13844 | 14:21:30 INFO - PROCESS | 13844 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.80 Median:143.50 stddev:3.39 (2.4%) stddev-sans-first:3.44 14:21:30 INFO - PROCESS | 13844 | Values: 139.0 144.0 142.0 144.0 145.0 134.0 145.0 143.0 140.0 142.0 14:21:30 INFO - PROCESS | 13844 | 14:21:30 INFO - PROCESS | 13844 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.00 stddev:1.41 (2.2%) stddev-sans-first:1.45 14:21:30 INFO - PROCESS | 13844 | Values: 65.0 63.0 67.0 64.0 64.0 63.0 62.0 65.0 64.0 63.0 14:21:30 INFO - PROCESS | 13844 | -------- Summary: end -------- 14:21:30 INFO - PROCESS | 13844 | 14:21:31 INFO - TEST-INFO | 13844: exit 0 14:21:31 INFO - TEST-OK | kraken | took 63129ms 14:21:31 INFO - SUITE-END | took 1173s 14:21:31 INFO - Completed test suite (00:19:34) 14:21:31 INFO - javascript benchmark 14:21:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3017.3361860390714, 3062.938741225174, 3105.223694076481, 3112.750979921605, 3129.436701393749, 5267.920981185285, 5313.415524292324, 5316.0, 5344.545713614348, 5346.812861549846, 5396.271503347047, 5416.91874621881, 5422.8373148805595, 5424.430434804348, 5497.038018346783, 4862.708237505743, 4893.09477746618, 4974.950250497503, 5015.172496538067, 5052.898942021157, 4834.274858771178, 4862.367892174012, 4966.130927087764, 4977.601791856643, 4981.676191047589, 4869.904271538893, 4881.243407271879, 4881.877953051202, 4927.679700819435, 4928.482509336522, 4902.142125128088, 4921.409430868319, 4926.876828079291, 4933.333999910002, 4969.602431805447, 4775.116603428377, 4844.878878028042, 4887.218045112765, 4932.087563800708, 4963.57809586182, 5310.468953104697, 5324.840254792362, 5336.386315573681, 5340.198970154469, 5345.786168553253, 5741.138829175616, 5752.137179423078, 5753.741081651336, 5754.367019627837, 5793.594448388614, 5704.372519022904, 5760.567957403169, 5766.452187042266, 5801.564882633819, 5851.561132915049, 5394.973025134888, 5397.298351214356, 5400.594955378362, 5403.108487099624, 5408.323959505062, 5778.219940308089, 5916.112583112482, 5917.260342457193, 5920.585559010828, 5921.141434491975, 5626.943730562723, 5664.773409063591, 5670.659760414388, 5685.914711279334, 5721.084626459747, 5764.7117644117625, 5773.8556536086935, 5776.913346299809, 5777.7977770777825, 5781.392953739881, 5567.66594004361, 5711.485966263056, 5743.4543718346695, 5753.137029445533, 5755.9424405756245, 5747.913781293284, 5769.740361683735, 5771.192033115367, 5772.220750198753, 5818.6217895836635, 4349.021470169187, 4355.760433176206, 4375.868723938287, 4385.956140438555, 4427.070315233837, 3867.0, 3878.864239751595, 3946.625070618287, 3950.802459876995, 3953.2686453006286, 5456.399796022434, 5470.890582188334, 5474.616776825584, 5476.972615136979, 5508.091164957817, 5805.477507024388, 5814.825555233349, 5816.214811000461, 5817.825465235965, 5822.912656310159, 5281.9207711884355, 5419.0, 5452.40023597404, 5472.0, 5510.421405752339, 4766.880827979328, 4772.212584923449, 4774.689645173053, 4787.01866117452, 4810.855674329776, 5869.090291004901, 5873.794417195378, 5883.941160588425, 5888.911666325009, 5902.822915312548, 5661.377248502744, 5736.225609542658, 5747.48272655463, 5801.593888427769, 5851.970740146272, 5964.284285885721, 5970.373110823301, 5980.073088671263, 5980.611260268069, 6016.969915150396, 5691.3170419549915, 5697.601167918206, 5698.230738850202, 5699.287589051369, 5705.771769129355, 5530.778768849362, 5743.56923230751, 5758.1650660654805, 5820.30156381237, 5835.0, 5664.915026274527, 5685.403032681675, 5689.374168841507, 5701.914471282851, 5707.229524014205, 5657.745401457027, 5660.094384898396, 5663.150527420919, 5667.40492248308, 5671.234383358194, 5468.425815289337, 5575.470330318613, 5657.773689052392, 5668.178114173505, 5678.4605462480995, 5665.971670141623, 5670.092785154356, 5683.062294721325, 5686.914696279477, 5688.630239034615, 5552.583556233218, 5559.777608895761, 5565.693886836263, 5568.9443105568425, 5627.577931655224], "unit": "score", "name": "dojo.html", "value": 5308.891776241083}, {"lowerIsBetter": false, "replicates": [562.7730403098112, 568.6843801690062, 592.7658574862928, 598.4314900844199, 614.7817524778701, 38605.420918686206, 39195.80402097993, 39287.41068883962, 39294.80352598237, 39338.8033059835, 42692.57307426925, 43145.35281970773, 43287.917802054966, 43293.56706432935, 43316.0, 8562.18659227374, 8673.479591224546, 8717.607707653138, 8742.781430464258, 8745.868811967794, 8592.957035214815, 8645.351598630097, 8701.347398945072, 8702.47785132894, 8707.216350528452, 8965.103489651048, 9035.638574457014, 9036.819263614723, 9037.051109633492, 9037.502937338477, 8847.73456796297, 8899.777505562348, 8902.599383027778, 8911.554422278925, 8917.509536975464, 8831.293496520262, 8952.283817294667, 8954.23888969432, 8955.955220223923, 8956.193942545202, 42338.0, 42872.35691464599, 42934.78532607317, 42938.78530607358, 43040.78479607582, 3704.9814750926344, 3879.9030024249337, 4071.4503542021744, 4168.791560421997, 4414.911701765979, 32592.0, 32774.836125819456, 33276.0, 33366.6663333366, 33416.6658333416, 4173.436586060903, 4303.160883627694, 4310.4396428464415, 4357.498887627931, 4358.193734159191, 304426.0, 305903.0, 305912.0, 306514.0, 306936.0, 48907.0, 64056.35943640504, 64429.0, 64533.35466645368, 64533.67733161398, 48765.75617121892, 48825.0, 49215.753921230884, 49220.507794922305, 49266.75366623144, 14479.49321773754, 14673.559793206221, 14703.338349774285, 14704.117752934859, 14711.19088450124, 11505.13711471643, 11564.479598418091, 11596.18826682141, 11687.941560292144, 11697.532098715956, 16331.26509307084, 16397.344106235618, 16740.41408550695, 16897.91551042237, 16926.153692315336, 6517.73929042833, 6627.10534077903, 6640.169978752656, 6678.465722742169, 6704.899426508607, 1071.4535586850607, 1109.2290857853714, 1111.4664960818852, 1119.3284029582348, 1179.3926128044063, 33776.49335259973, 33781.49327760086, 33878.66121338804, 33885.830570846985, 34344.65655343414, 1101.564881871656, 1114.242315225638, 1202.3627477436971, 1214.7084699672191, 1247.4885297028175, 17144.914275428542, 17375.565610859576, 17435.56411089733, 17481.444458328126, 17660.823391766175, 200568.0, 200967.0, 201529.0, 201899.0, 202128.0, 58082.70958645264, 58788.0, 58848.70575647095, 58878.705606471696, 58992.0, 1321.6894029902965, 1342.6710455938357, 1405.1077565745825, 1420.3963315590834, 1423.395057100728, 29411.0, 30728.0, 31699.841500792347, 32345.19137021499, 33219.33561328808, 47551.28673069976, 59155.0, 60041.099383510154, 60094.69952650209, 60127.69936150291, 370279.0, 370516.0, 373537.0, 373801.0, 374467.0, 40241.19517609573, 46286.7685661583, 47716.7614161927, 47765.283520746525, 47947.0, 44467.33299000453, 44832.775836120614, 44980.550194498945, 45749.54250457453, 46134.30798538092, 38954.6104538951, 39793.20413591654, 41058.79470602628, 41184.97037574085, 42570.0, 40384.19231615293, 40507.0, 41012.0, 41462.0, 41643.16713665771, 42111.578884210765, 42650.573494265904, 43033.354499683155, 43124.78437607792, 43164.8417579126, 35461.82269088638, 36899.26201476009, 37151.442728358554, 37418.625813742605, 37701.24597507979, 28591.571126433537, 28696.426071478036, 28892.42215155643, 28901.855490722413, 28998.710012900447], "unit": "score", "name": "ext.html", "value": 19563.803945691856}, {"lowerIsBetter": false, "replicates": [377.901745546158, 378.21142917018017, 378.458803910408, 383.73522269633935, 385.1930206217973, 17213.569660758487, 18396.540086497844, 19121.52196195094, 19509.707354389695, 19547.706784398244, 10560.524776385062, 10754.99999999998, 10796.622118225863, 10814.621488247913, 10819.891801081987, 4942.283368911506, 5031.0692521883475, 5198.3761948566225, 5199.662021968579, 5200.7399630018535, 5096.8277296221895, 5115.488451154892, 5126.897462050757, 5147.099257629919, 5189.091908915943, 5090.160123579605, 5111.769970351324, 5113.5909127269915, 5140.460251673577, 5163.044836705203, 5030.195168772997, 5145.151050076733, 5171.172612382038, 5177.30106435632, 5186.0665080285535, 5017.8243761468175, 5023.79904803811, 5024.824131155392, 5030.320906677625, 5031.899362012776, 17480.0, 21304.680429793567, 22017.449563760874, 22272.220472283556, 22321.10715571375, 2230.3643461613524, 2242.6748121522287, 2424.066734307287, 2485.8508489490687, 2899.884004639833, 9267.30495212855, 9521.571529281198, 9664.806703865883, 9868.703938881845, 10133.543990520444, 1886.9339573114876, 1919.7408349872867, 1944.9416517504499, 1956.1686283329527, 2002.98998505008, 74783.0, 75318.0, 75704.0, 76751.61624191844, 77193.0, 10882.782344353227, 11144.777104457866, 11237.101031917427, 11328.376939268255, 11357.886421135683, 14924.253787310809, 14962.326695298738, 14984.850151498564, 15004.474843380429, 15007.099574025375, 7785.610719464117, 7896.802579935547, 7969.800754981172, 8057.274845263954, 8092.0, 7788.688452461838, 7791.610419479003, 7894.763157105296, 7935.2064793520185, 7937.325327347125, 4438.28987362027, 4601.631869450436, 4813.302071199656, 4883.316335713003, 4957.578605818474, 1888.3107665702194, 1911.4265720283859, 1921.6156768646326, 1935.9322423715103, 1956.178405069874, 967.56943160293, 1037.061459379263, 1081.1729027294127, 1096.6545538155456, 1103.5420300575172, 18262.0, 18576.907115464335, 19019.80980190208, 19109.904450477658, 19233.711494327596, 1031.654395777408, 1034.1623285139062, 1049.9895001050045, 1063.6436793674206, 1131.479519421059, 10414.114800242065, 10590.682279531626, 10819.459027048617, 10829.458527073615, 11066.336019838835, 443420.0, 501493.0, 508098.0, 522193.0, 525115.0, 83939.0, 86092.23847019122, 86802.56598717092, 87553.56223218843, 88531.0, 1101.8898110189077, 1119.776044791045, 1126.9943650281696, 1128.5767837061103, 1129.2829053551054, 17238.655226895644, 17308.048057356464, 17318.65362692714, 17455.912720436318, 17628.823711762718, 37774.62225377711, 38810.80594597009, 39703.60296397115, 41105.79447102865, 41242.0, 57082.42917570771, 57370.13944790748, 57557.71221143867, 57558.0, 57760.42239577718, 7948.960255198687, 7952.284294413531, 8214.815221569295, 8222.753317400488, 8272.04871439768, 9454.480003599592, 11050.834237486284, 12379.195352302071, 12696.428660710475, 13130.212187268795, 11303.773924521627, 11495.77008459843, 11515.193936424705, 11596.5361385547, 11666.183367164216, 11287.322760634388, 11319.434028298718, 11379.715507112389, 11453.770924581295, 11491.770164596828, 11677.649670509898, 11781.469833857669, 11814.704632384259, 11939.701507462383, 11987.940060299643, 7938.56337901421, 8138.552379619177, 8171.344313098148, 8227.71203007892, 8278.213569710868, 10708.839367409339, 11724.648260552198, 11741.354225517336, 11790.882091179321, 11921.642350729491], "unit": "score", "name": "jquery.html", "value": 8836.3361061434}, {"lowerIsBetter": false, "replicates": [1428.0931608428657, 1562.8515291047352, 1567.6316065724552, 1791.0954967741288, 1919.5872887329222, 7469.290417410344, 7992.880106798395, 8149.633266503007, 8174.6321415536295, 8181.631826567804, 7920.366370690345, 8132.0, 8158.959205203966, 8165.755027349174, 8168.305694016016, 1975.2987689370211, 2052.138101997165, 2345.5074434368717, 2360.3509035015336, 2388.9641655375185, 2392.162743039931, 2401.435662619283, 2402.723686776017, 2403.170906037423, 2403.9038438462526, 2315.22439982606, 2336.0538981712434, 2365.3849999000213, 2366.6686663866985, 2369.9052037918464, 2334.2063698342645, 2341.812654987597, 2355.693759811222, 2407.5064611754547, 2407.65089062085, 2351.6707660927314, 2367.9289621311386, 2387.152560840894, 2394.2697477269426, 2405.783479486837, 8308.958455207685, 8311.210435008665, 8313.792155196108, 8330.208630180123, 8359.874601880976, 5166.560842328407, 5280.9207861882105, 5282.841514754564, 5290.470952904717, 5291.0, 3449.810260435675, 3484.4250698634696, 3501.38725723, 3597.1546686528645, 3648.1609229877276, 1166.9533218671243, 1197.3953153657346, 1223.0, 1228.6498347970876, 1230.0958795285458, 11805.468753906094, 11811.704707382385, 11816.05471562273, 11822.231554948901, 11852.466639001179, 4623.329617205486, 4726.574608285271, 4754.881127971828, 4770.737609431515, 4783.521647835189, 9955.950220248997, 9966.451845148586, 9972.850407243897, 9989.30074894765, 10001.2999090063, 5242.7640756166065, 5245.160774276097, 5247.842564723064, 5248.553872920845, 5252.711100889412, 4145.751254924714, 4664.137134630104, 4784.210605250095, 4784.617230621542, 4786.832460863922, 4005.098852758106, 4006.7595944242858, 4033.596640335943, 4080.8775736727353, 4106.774127422961, 1249.5439164704817, 1253.7993920972601, 1262.3246563088703, 1262.482382223284, 1291.9547815826402, 1283.9935800320939, 1428.3014551567062, 1436.6552027513321, 1467.33236377448, 1469.6840179361275, 8164.836703265902, 8169.71406000799, 8177.223163799429, 8210.055843578066, 8229.547374894319, 498.1307667833306, 498.9925151122736, 505.5430607248768, 509.11668255576546, 509.1598861877931, 6251.937480625226, 6279.7488100476385, 6293.748250069946, 6309.589876658094, 6321.241451025906, 10089.58745775592, 10303.3817970922, 10396.844047339297, 10438.0, 10488.68533943983, 9660.0, 10165.745856353651, 10277.075063244343, 10296.330738501973, 10309.948450257702, 7906.723264685824, 7923.841523169504, 7978.922845415911, 8120.14738452454, 8122.675092996332, 7922.445428819928, 7941.642626081724, 8035.718749843727, 8044.3564514839845, 8084.434089613671, 9106.180443759828, 9108.863367049633, 9111.043340449158, 9159.86260206084, 9172.266218702354, 9330.580123894306, 9377.85933211016, 9570.56932438028, 9575.0, 9581.712548623553, 6615.834604134935, 7102.502824802421, 7310.268973102648, 7317.12194536659, 7414.147373051952, 7991.64037618297, 7993.320567751806, 8007.479513831815, 8042.3968202383885, 8090.474119182234, 7141.392981596622, 7302.6713797878165, 7348.191698913222, 7434.925650743423, 7478.0, 7021.824454388681, 7128.643567821485, 7152.356287934111, 7240.6017669026605, 7458.92541074604, 7479.588622625808, 7489.0, 7531.962340188264, 7532.811679708051, 7541.0, 6993.125859267591, 7026.016357709823, 7070.858582828418, 7076.221615622175, 7086.929130708627, 7098.36114749675, 7107.182673992557, 7136.0723105995885, 7137.10786151731, 7161.355478007004], "unit": "score", "name": "mootools.html", "value": 4757.758757053918}, {"lowerIsBetter": false, "replicates": [344.0641455241743, 344.88273986844473, 346.45087536255033, 347.50133558343765, 354.4806857953098, 5987.790427335039, 5988.40115988401, 5999.5500337474705, 6021.578489505737, 6075.392460753934, 6010.489108425778, 6022.0966854971775, 6030.155778191057, 6032.366601506834, 6033.1855199548045, 4375.781210939456, 4517.570830771071, 4594.839180628679, 4653.767311634405, 4679.181143299926, 4656.883577910562, 4656.930146047812, 4668.836590719326, 4674.626029917616, 4686.343911852344, 4550.2264615015365, 4597.586217240448, 4605.585497305242, 4608.193566125931, 4644.326572646964, 4349.151915376503, 4511.007578332761, 4564.041551274237, 4609.446866376023, 4610.95389046112, 4032.3749818778138, 4041.595840415964, 4056.9391459128137, 4059.0664147246002, 4064.8170832312617, 5689.800856970028, 5755.395683453261, 5760.0783874579865, 5761.366249712528, 5768.625039372428, 5399.19012148177, 5399.568034557226, 5401.78392864285, 5406.648567843117, 5411.053065713484, 6330.430261276507, 6339.207599050119, 6343.048542718583, 6348.0477928310665, 6353.30113687494, 4411.228035093878, 4547.272436410159, 4565.908681826378, 4574.748388838612, 4588.977055114703, 6593.439557637606, 6640.136782218281, 6655.800325990228, 6669.0, 6670.199576050905, 4674.158651442705, 4678.95321046792, 4679.438467383936, 4682.906341873211, 4695.694779839368, 4753.714777113384, 4754.0, 4758.357621721023, 4759.690620109682, 4763.95236047642, 5405.945940540623, 5408.3509978802795, 5410.729463526808, 5419.241306217133, 5419.674819510842, 6302.464290535356, 6396.84007899797, 6419.550631455753, 6432.260290066609, 6502.674866256668, 1647.8022637283602, 1663.2931004323357, 1670.381958675298, 1673.9832601673827, 1675.5643532681347, 1046.3042077018697, 1136.0797753819434, 1136.9602063927723, 1154.7979103656826, 1164.4585267850491, 6037.1246169305205, 6090.543209259324, 6094.512439004869, 6106.72519736613, 6121.173641558422, 6501.47988160946, 6509.707063182168, 6513.967430162819, 6523.967380163069, 6524.412802847766, 6075.605085669417, 6079.787207447718, 6082.635041897501, 6085.1785009023215, 6094.055421409688, 3461.9826900865332, 3480.3387356402204, 3489.7382696297877, 3494.4408894576745, 3495.265994141208, 6611.834704132339, 6689.933100669028, 6758.526903116833, 6782.660866956632, 6785.0, 6621.404073633396, 6644.60132392058, 6657.300983396771, 6658.1011563438315, 6669.199696036507, 6718.193816742022, 6723.562968407038, 6764.0530325754435, 6777.186737591521, 6778.389944904884, 6499.7400103995315, 6508.8047358579315, 6509.381608747351, 6519.511036672174, 6523.24982627004, 6308.52686048539, 6446.709898054505, 6448.484121270193, 6537.640429776217, 6553.705083271169, 6840.41856442208, 6865.725370985105, 6877.4841886857685, 6885.380315771605, 6891.862162756817, 4462.866114016585, 4491.528389519184, 4495.865124046284, 4503.54964503547, 4508.346289787897, 6557.606543607399, 6561.40947314744, 6564.606123632598, 6570.342965703391, 6574.539782215199, 6229.626222426669, 6395.296517382991, 6403.775867844603, 6423.582467139621, 6424.871502570016, 6365.013422919455, 6403.96798016007, 6404.199475065617, 6408.359164083741, 6417.2299324081405, 6309.810705678837, 6310.242770867525, 6313.715882785194, 6319.304876463677, 6320.273168585672, 6434.8391290218115, 6454.19322584677, 6472.967635161794, 6507.28419873823, 6528.934710653023, 6009.669468179117, 6019.668918209541, 6088.908666370096, 6270.341614130633, 6304.275008373912], "unit": "score", "name": "prototype.html", "value": 4835.057296270545}, {"lowerIsBetter": false, "replicates": [890.5903284489136, 897.8383890899636, 897.9146981036802, 908.7410088124885, 924.3113880159283, 13922.930385348072, 14063.789043164348, 14069.4372225111, 14096.859031409684, 14114.29428528572, 13338.733225335487, 13405.530806421753, 13416.93291533541, 13481.595552133427, 13603.0, 702.1048163591436, 833.4749108061912, 860.3977215948829, 866.774638593967, 871.5947084605657, 859.6776208921655, 861.8793368928355, 862.469581207556, 862.9137086291352, 863.1972265792841, 897.5960817632059, 909.9499527525984, 916.8349697054527, 917.1745429113785, 917.47703808829, 739.5267029101379, 878.3149143667981, 891.5007595746371, 894.9731508054768, 897.1028971028971, 654.1790053482896, 655.207199288861, 656.3272645538314, 657.7171816119067, 659.2122413715612, 14609.634759131, 14668.0, 14686.55940321792, 14689.412423503047, 14704.338304776204, 13943.233122178277, 14282.785758213635, 14466.782998255034, 14530.709385812224, 14653.41386344545, 11689.941550292195, 11761.94119029408, 11837.230580012272, 11849.585264515701, 11881.40592970348, 3891.8443262269475, 3892.2799282132614, 3902.3366027775346, 3907.179492306619, 3936.252112098692, 55664.443355566735, 55816.0, 55998.44001559973, 56632.7525435594, 56702.14946775802, 10560.260781745204, 10638.255322127532, 10766.138708903269, 10926.890731092746, 11394.430278486043, 18829.717554236697, 18843.52891177704, 18894.244230230637, 18924.33764818252, 18933.62132757337, 8248.092709801916, 8373.790655233668, 8375.706850260334, 8491.448055876348, 8597.312215022783, 4760.904781904412, 4799.904001920012, 4821.156297647897, 4834.226523756182, 4840.782164802522, 3522.119470132467, 3525.3301872644115, 3528.7177025837873, 3535.5580552430947, 3540.6282340354405, 620.9627422354673, 630.1209812311799, 636.1030946365602, 637.6970938804031, 661.3783043938682, 803.5741057239673, 806.5361369115037, 809.4697972827807, 814.678202110175, 828.9088200297963, 9743.415395076318, 9763.85354219673, 9776.266779991529, 9825.459599722084, 10373.0, 599.4754589733983, 636.7262077306802, 763.1948294549193, 768.3161985832613, 788.6569342336102, 4560.247559152703, 4694.554017368345, 4711.599514041276, 4759.666823322404, 4809.374781278411, 61932.0, 63143.684281578295, 63284.36715632877, 64349.0, 64718.0, 56003.43996559982, 56887.43112568904, 57076.0, 57154.428455715744, 57490.0, 47869.5213047865, 48426.03147937021, 49442.75278623584, 51869.221961670606, 51891.48108518942, 9216.124468175512, 9225.953870230605, 9360.297977651568, 9415.057095024893, 9429.15137637616, 39479.80260098681, 39516.40725389179, 39746.0, 39954.0, 40558.94481443396, 46014.0, 46705.76647116743, 49898.0, 50123.0, 50629.49370506248, 11245.381504017358, 11360.431978400882, 11432.14258930567, 11497.195196336175, 11626.825597615873, 12083.335416552174, 12138.635840924786, 12338.0, 12349.814752778895, 12351.3824308786, 11569.19015668895, 11659.650210493699, 12215.816762748389, 12389.814152787536, 12590.24458532491, 12034.458449369624, 12179.817302740643, 12239.265644061385, 12586.748265034465, 12594.496220151092, 11751.353675547927, 11817.881821181678, 11934.761304774029, 12172.14794964344, 12198.14612977083, 10417.16662667, 10503.369797812156, 10620.893791062299, 10723.678289651323, 10804.837927430937, 10597.0, 10646.0, 10672.30630009047, 10674.146068314361, 10748.462576870968], "unit": "score", "name": "yui.html", "value": 6902.993707277369}], "name": "dromaeo_css", "value": 7254.399699130645}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 109.0, 104.0, 108.0, 108.0, 109.0, 98.0, 108.0, 108.0, 109.0], "unit": "score", "name": "ai-astar", "value": 107.0}, {"lowerIsBetter": true, "replicates": [157.0, 125.0, 148.0, 173.0, 125.0, 150.0, 152.0, 127.0, 170.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 146.0}, {"lowerIsBetter": true, "replicates": [378.0, 376.0, 378.0, 377.0, 378.0, 377.0, 376.0, 377.0, 376.0, 377.0], "unit": "score", "name": "audio-dft", "value": 377.0}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 73.0, 161.0, 73.0, 73.0, 73.0, 74.0, 160.0, 73.0], "unit": "score", "name": "audio-fft", "value": 90.7}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 149.0, 93.0, 94.0, 93.0, 142.0, 93.0, 93.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 108.5}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.6}, {"lowerIsBetter": true, "replicates": [193.0, 193.0, 193.0, 192.0, 193.0, 192.0, 193.0, 193.0, 193.0, 193.0], "unit": "score", "name": "imaging-darkroom", "value": 192.8}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 58.0, 56.0, 57.0, 56.0, 57.0, 57.0, 59.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 56.9}, {"lowerIsBetter": true, "replicates": [58.0, 60.0, 60.0, 59.0, 65.0, 61.0, 59.0, 60.0, 58.0, 60.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 60.0}, {"lowerIsBetter": true, "replicates": [85.0, 78.0, 79.0, 79.0, 86.0, 78.0, 78.0, 80.0, 90.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.2}, {"lowerIsBetter": true, "replicates": [112.0, 109.0, 122.0, 108.0, 117.0, 110.0, 108.0, 109.0, 116.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 112.4}, {"lowerIsBetter": true, "replicates": [139.0, 144.0, 142.0, 144.0, 145.0, 134.0, 145.0, 143.0, 140.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.8}, {"lowerIsBetter": true, "replicates": [65.0, 63.0, 67.0, 64.0, 64.0, 63.0, 62.0, 65.0, 64.0, 63.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 64.0}], "name": "kraken", "value": 1750.3000000000004}]} 14:21:31 INFO - Return code: 0 14:21:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:21:31 ERROR - # TBPL SUCCESS # 14:21:31 INFO - Running post-action listener: _resource_record_post_action 14:21:31 INFO - Running post-run listener: _resource_record_post_run 14:21:32 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8192; Write bytes: 534548480; Read time: 52; Write time: 511492 14:21:32 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 243105792; Read time: 36; Write time: 283988 14:21:32 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291319808; Read time: 16; Write time: 227488 14:21:32 INFO - Running post-run listener: _upload_blobber_files 14:21:32 INFO - Blob upload gear active. 14:21:32 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:21:32 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 14:21:32 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'] 14:21:32 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 14:21:33 INFO - (blobuploader) - INFO - Open directory for files ... 14:21:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 14:21:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:21:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:21:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:21:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:21:33 INFO - (blobuploader) - INFO - Done attempting. 14:21:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:21:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:21:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:21:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:21:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:21:34 INFO - (blobuploader) - INFO - Done attempting. 14:21:34 INFO - (blobuploader) - INFO - Iteration through files over. 14:21:34 INFO - Return code: 0 14:21:34 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:21:34 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:21:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5393efa02420f5c136afda2e75dd5ab10bd34691850c094b73358936bd5ad5f6d1d9c68145899a6b93139a233cdacefee0daa3c1f4938fd98736489cbd43e4b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffbfb48193e6a8f52cbf64aaa5eef4512f2791433171010a9cee053f82b0558e136a008a3f3e951a62cc256cc96ebe8fa1a6e73607af076c58b0897a8c26a6c2"} 14:21:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:21:34 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:21:34 INFO - Contents: 14:21:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5393efa02420f5c136afda2e75dd5ab10bd34691850c094b73358936bd5ad5f6d1d9c68145899a6b93139a233cdacefee0daa3c1f4938fd98736489cbd43e4b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffbfb48193e6a8f52cbf64aaa5eef4512f2791433171010a9cee053f82b0558e136a008a3f3e951a62cc256cc96ebe8fa1a6e73607af076c58b0897a8c26a6c2"} 14:21:34 INFO - Running post-run listener: copy_logs_to_upload_dir 14:21:34 INFO - Copying logs to upload dir... 14:21:34 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 14:21:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.848560 ========= master_lag: 2.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-03-14 14:21:36.755248) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-14 14:21:36.758621) ========= 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=8887e36bb8e381bfd44124ac000001a8-1457989263.730473-1420477093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5393efa02420f5c136afda2e75dd5ab10bd34691850c094b73358936bd5ad5f6d1d9c68145899a6b93139a233cdacefee0daa3c1f4938fd98736489cbd43e4b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffbfb48193e6a8f52cbf64aaa5eef4512f2791433171010a9cee053f82b0558e136a008a3f3e951a62cc256cc96ebe8fa1a6e73607af076c58b0897a8c26a6c2"} build_url:https://queue.taskcluster.net/v1/task/fE5gHnILRAaRLG5cEaMoyQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009949 build_url: 'https://queue.taskcluster.net/v1/task/fE5gHnILRAaRLG5cEaMoyQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5393efa02420f5c136afda2e75dd5ab10bd34691850c094b73358936bd5ad5f6d1d9c68145899a6b93139a233cdacefee0daa3c1f4938fd98736489cbd43e4b4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffbfb48193e6a8f52cbf64aaa5eef4512f2791433171010a9cee053f82b0558e136a008a3f3e951a62cc256cc96ebe8fa1a6e73607af076c58b0897a8c26a6c2"}' ========= master_lag: 0.15 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-14 14:21:36.914269) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 14:21:36.914594) ========= 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=8887e36bb8e381bfd44124ac000001a8-1457989263.730473-1420477093 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 -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 14:21:36.964078) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-14 14:21:36.964405) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-14 14:21:36.964694) ========= ========= Total master_lag: 2.44 =========