builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1458239529.86 results: success (0) buildid: 20160317080800 builduid: 87d81d3ee28b4d0a85a79e270a596e3b revision: 3e04659fdf6a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-17 11:32:09.862265) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-17 11:32:09.862808) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-17 11:32:09.863234) ========= 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=836cfdc75598d54cb747368e000001a9-1458239529.393178-1658050876 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006268 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-17 11:32:09.886457) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-17 11:32:09.886832) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-17 11:32:09.900262) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 11:32:09.900734) ========= 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=836cfdc75598d54cb747368e000001a9-1458239529.393178-1658050876 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004553 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 11:32:09.950924) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-17 11:32:09.951286) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-17 11:32:09.951707) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 11:32:09.952021) ========= 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=836cfdc75598d54cb747368e000001a9-1458239529.393178-1658050876 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-17 11:32:10-- 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% 114M=0s 2016-03-17 11:32:10 (114 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.143762 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 11:32:10.108965) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 11:32:10.109360) ========= 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=836cfdc75598d54cb747368e000001a9-1458239529.393178-1658050876 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022283 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 11:32:10.159545) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-17 11:32:10.159969) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3e04659fdf6a --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 3e04659fdf6a --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=836cfdc75598d54cb747368e000001a9-1458239529.393178-1658050876 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-17 11:32:10,461 Setting DEBUG logging. 2016-03-17 11:32:10,461 attempt 1/10 2016-03-17 11:32:10,461 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3e04659fdf6a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-17 11:32:11,596 unpacking tar archive at: mozilla-central-3e04659fdf6a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.431306 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-17 11:32:11.604843) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-17 11:32:11.605277) ========= echo '3e04659fdf6a ' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3e04659fdf6a '] 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=836cfdc75598d54cb747368e000001a9-1458239529.393178-1658050876 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 3e04659fdf6a program finished with exit code 0 elapsedTime=0.003479 script_repo_revision: '3e04659fdf6a' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-17 11:32:11.654479) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-17 11:32:11.654834) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-17 11:32:11.665021) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-03-17 11:32:11.665351) ========= /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=836cfdc75598d54cb747368e000001a9-1458239529.393178-1658050876 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:32:12 INFO - MultiFileLogger online at 20160317 11:32:12 in /builds/slave/test-pgo 11:32:12 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 11:32:12 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:32:12 INFO - {'append_to_log': False, 11:32:12 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:32:12 INFO - 'blob_upload_branch': 'Firefox', 11:32:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:32:12 INFO - 'branch': 'Firefox', 11:32:12 INFO - 'buildbot_json_path': 'buildprops.json', 11:32:12 INFO - 'config_files': ('talos/linux_config.py',), 11:32:12 INFO - 'default_actions': ('clobber', 11:32:12 INFO - 'read-buildbot-config', 11:32:12 INFO - 'download-and-extract', 11:32:12 INFO - 'populate-webroot', 11:32:12 INFO - 'create-virtualenv', 11:32:12 INFO - 'install', 11:32:12 INFO - 'run-tests'), 11:32:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:32:12 INFO - 'download_minidump_stackwalk': True, 11:32:12 INFO - 'download_symbols': 'ondemand', 11:32:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:32:12 INFO - 'tooltool.py': '/tools/tooltool.py', 11:32:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:32:12 INFO - '/tools/misc-python/virtualenv.py')}, 11:32:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:32:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:32:12 INFO - 'installer_path': 'installer.exe', 11:32:12 INFO - 'log_level': 'info', 11:32:12 INFO - 'log_name': 'talos', 11:32:12 INFO - 'log_to_console': True, 11:32:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:32:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:32:12 INFO - 'opt_config_files': (), 11:32:12 INFO - 'pip_index': False, 11:32:12 INFO - 'sps_profile': False, 11:32:12 INFO - 'sps_profile_interval': 0, 11:32:12 INFO - 'suite': 'dromaeojs', 11:32:12 INFO - 'system_bits': '32', 11:32:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:32:12 INFO - 'title': 'talos-linux64-ix-028', 11:32:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:32:12 INFO - 'use_talos_json': True, 11:32:12 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:32:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:32:12 INFO - 'work_dir': 'build'} 11:32:12 INFO - ##### 11:32:12 INFO - ##### Running clobber step. 11:32:12 INFO - ##### 11:32:12 INFO - Running pre-action listener: _resource_record_pre_action 11:32:12 INFO - Running main action method: clobber 11:32:12 INFO - rmtree: /builds/slave/test-pgo/build 11:32:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:32:12 INFO - Running post-action listener: _resource_record_post_action 11:32:12 INFO - ##### 11:32:12 INFO - ##### Running read-buildbot-config step. 11:32:12 INFO - ##### 11:32:12 INFO - Running pre-action listener: _resource_record_pre_action 11:32:12 INFO - Running main action method: read_buildbot_config 11:32:12 INFO - Using buildbot properties: 11:32:12 INFO - { 11:32:12 INFO - "project": "", 11:32:12 INFO - "product": "firefox", 11:32:12 INFO - "script_repo_revision": "production", 11:32:12 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 11:32:12 INFO - "repository": "", 11:32:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 11:32:12 INFO - "buildid": "20160317080800", 11:32:12 INFO - "stage_platform": "linux64-pgo", 11:32:12 INFO - "basedir": "/builds/slave/test-pgo", 11:32:12 INFO - "nightly_build": "True", 11:32:12 INFO - "buildnumber": 229, 11:32:12 INFO - "slavename": "talos-linux64-ix-028", 11:32:12 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:32:12 INFO - "platform": "ubuntu64_hw", 11:32:12 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 11:32:12 INFO - "branch": "mozilla-central", 11:32:12 INFO - "repo_path": "mozilla-central", 11:32:12 INFO - "revision": "3e04659fdf6a ", 11:32:12 INFO - "pgo_build": "True", 11:32:12 INFO - "builduid": "87d81d3ee28b4d0a85a79e270a596e3b", 11:32:12 INFO - "slavebuilddir": "test" 11:32:12 INFO - } 11:32:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZPfR0fZhQgiaEuI0ey0yYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 11:32:12 INFO - Running post-action listener: _resource_record_post_action 11:32:12 INFO - ##### 11:32:12 INFO - ##### Running download-and-extract step. 11:32:12 INFO - ##### 11:32:12 INFO - Running pre-action listener: _resource_record_pre_action 11:32:12 INFO - Running main action method: download_and_extract 11:32:12 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:32: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')]} 11:32:12 INFO - https://queue.taskcluster.net/v1/task/ZPfR0fZhQgiaEuI0ey0yYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:32:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPfR0fZhQgiaEuI0ey0yYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:32:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPfR0fZhQgiaEuI0ey0yYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:32:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPfR0fZhQgiaEuI0ey0yYg/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 11:32:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPfR0fZhQgiaEuI0ey0yYg/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 11:32:13 INFO - Downloaded 1361 bytes. 11:32:13 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:32:13 INFO - Using the following test package requirements: 11:32:13 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:32:13 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:32:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:32:13 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:32:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:32:13 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:32:13 INFO - u'jsshell-linux-x86_64.zip'], 11:32:13 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:32:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:32:13 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:32:13 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:32:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:32:13 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:32:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:32:13 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:32:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:32:13 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:32:13 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:32:13 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:32: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')]} 11:32:13 INFO - https://queue.taskcluster.net/v1/task/ZPfR0fZhQgiaEuI0ey0yYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:32:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPfR0fZhQgiaEuI0ey0yYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:32:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPfR0fZhQgiaEuI0ey0yYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:32:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPfR0fZhQgiaEuI0ey0yYg/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 11:32:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPfR0fZhQgiaEuI0ey0yYg/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 11:32:14 INFO - Downloaded 23578569 bytes. 11:32:14 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'] 11:32:14 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 11:32:15 INFO - Return code: 0 11:32:15 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 11:32:15 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')]} 11:32:15 INFO - https://queue.taskcluster.net/v1/task/ZPfR0fZhQgiaEuI0ey0yYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:32:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPfR0fZhQgiaEuI0ey0yYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:32:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPfR0fZhQgiaEuI0ey0yYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:32:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPfR0fZhQgiaEuI0ey0yYg/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 11:32:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPfR0fZhQgiaEuI0ey0yYg/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 11:32:17 INFO - Downloaded 23578569 bytes. 11:32:17 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'] 11:32:17 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 11:32:18 INFO - Return code: 0 11:32: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')]} 11:32:18 INFO - https://queue.taskcluster.net/v1/task/ZPfR0fZhQgiaEuI0ey0yYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:32:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPfR0fZhQgiaEuI0ey0yYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:32:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPfR0fZhQgiaEuI0ey0yYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:32:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPfR0fZhQgiaEuI0ey0yYg/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 11:32:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPfR0fZhQgiaEuI0ey0yYg/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 11:32:19 INFO - Downloaded 10846565 bytes. 11:32:19 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'] 11:32:19 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 11:32:19 INFO - Return code: 0 11:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:19 INFO - https://queue.taskcluster.net/v1/task/ZPfR0fZhQgiaEuI0ey0yYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:32:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPfR0fZhQgiaEuI0ey0yYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:32:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPfR0fZhQgiaEuI0ey0yYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:32:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPfR0fZhQgiaEuI0ey0yYg/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 11:32:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPfR0fZhQgiaEuI0ey0yYg/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 11:32:21 INFO - Downloaded 57670138 bytes. 11:32:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZPfR0fZhQgiaEuI0ey0yYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:32:21 INFO - mkdir: /builds/slave/test-pgo/properties 11:32:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:32:21 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:32:21 INFO - Contents: 11:32:21 INFO - build_url:https://queue.taskcluster.net/v1/task/ZPfR0fZhQgiaEuI0ey0yYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:32:22 INFO - Running post-action listener: _resource_record_post_action 11:32:22 INFO - Running post-action listener: set_extra_try_arguments 11:32:22 INFO - ##### 11:32:22 INFO - ##### Running populate-webroot step. 11:32:22 INFO - ##### 11:32:22 INFO - Running pre-action listener: _resource_record_pre_action 11:32:22 INFO - Running main action method: populate_webroot 11:32:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:32:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:32:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:32:22 INFO - '--tppagecycles', 11:32:22 INFO - '7'], 11:32:22 INFO - 'tests': ['tsvgm']}}, 11:32:22 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:32:22 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:32:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:32:22 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:32:22 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:32:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:32:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:32:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:32:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:32:22 INFO - 'talos_options': ['--e10s'], 11:32:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:32:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:32:22 INFO - 'tests': ['damp', 'tps']}, 11:32:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:32:22 INFO - 'talos_options': ['--e10s'], 11:32:22 INFO - 'tests': ['damp', 'tps']}, 11:32:22 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:32:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:32:22 INFO - 'other': {'tests': ['a11yr', 11:32:22 INFO - 'ts_paint', 11:32:22 INFO - 'tpaint', 11:32:22 INFO - 'sessionrestore', 11:32:22 INFO - 'sessionrestore_no_auto_restore', 11:32:22 INFO - 'tabpaint']}, 11:32:22 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:32:22 INFO - 'tests': ['a11yr', 11:32:22 INFO - 'ts_paint', 11:32:22 INFO - 'tpaint', 11:32:22 INFO - 'sessionrestore', 11:32:22 INFO - 'sessionrestore_no_auto_restore', 11:32:22 INFO - 'tabpaint']}, 11:32:22 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:32:22 INFO - 'tests': ['a11yr', 11:32:22 INFO - 'ts_paint', 11:32:22 INFO - 'tpaint', 11:32:22 INFO - 'sessionrestore', 11:32:22 INFO - 'sessionrestore_no_auto_restore', 11:32:22 INFO - 'tabpaint']}, 11:32:22 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:32:22 INFO - 'tests': ['a11yr', 11:32:22 INFO - 'ts_paint', 11:32:22 INFO - 'tpaint', 11:32:22 INFO - 'sessionrestore', 11:32:22 INFO - 'sessionrestore_no_auto_restore', 11:32:22 INFO - 'tabpaint']}, 11:32:22 INFO - 'other_l64': {'tests': ['a11yr', 11:32:22 INFO - 'ts_paint', 11:32:22 INFO - 'tpaint', 11:32:22 INFO - 'sessionrestore', 11:32:22 INFO - 'sessionrestore_no_auto_restore', 11:32:22 INFO - 'tabpaint']}, 11:32:22 INFO - 'other_nol64': {'tests': ['a11yr', 11:32:22 INFO - 'ts_paint', 11:32:22 INFO - 'tpaint', 11:32:22 INFO - 'sessionrestore', 11:32:22 INFO - 'sessionrestore_no_auto_restore', 11:32:22 INFO - 'tabpaint']}, 11:32:22 INFO - 'svgr': {'tests': ['tsvgx', 11:32:22 INFO - 'tsvgr_opacity', 11:32:22 INFO - 'tart', 11:32:22 INFO - 'tscrollx', 11:32:22 INFO - 'cart']}, 11:32:22 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:32:22 INFO - 'tests': ['tsvgx', 11:32:22 INFO - 'tsvgr_opacity', 11:32:22 INFO - 'tart', 11:32:22 INFO - 'tscrollx', 11:32:22 INFO - 'cart']}, 11:32:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:32:22 INFO - 'tests': ['tp5o']}, 11:32:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:32:22 INFO - 'talos_options': ['--e10s'], 11:32:22 INFO - 'tests': ['tp5o']}, 11:32:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:32:22 INFO - 'talos_options': ['--xperf_path', 11:32:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:32:22 INFO - 'tests': ['tp5n']}, 11:32:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:32:22 INFO - 'talos_options': ['--e10s', 11:32:22 INFO - '--xperf_path', 11:32:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:32:22 INFO - 'tests': ['tp5n']}}, 11:32:22 INFO - 'talos.zip': {'path': '', 11:32:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:32:22 INFO - Running post-action listener: _resource_record_post_action 11:32:22 INFO - ##### 11:32:22 INFO - ##### Running create-virtualenv step. 11:32:22 INFO - ##### 11:32:22 INFO - Running pre-action listener: _resource_record_pre_action 11:32:22 INFO - Running main action method: create_virtualenv 11:32:22 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:32:22 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 11:32:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:32:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:32:22 INFO - Using real prefix '/usr' 11:32:22 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:32:23 INFO - Installing distribute.............................................................................................................................................................................................done. 11:32:25 INFO - Installing pip.................done. 11:32:25 INFO - Return code: 0 11:32:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f67d6281f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb76b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb21d0>, '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 0xfb5750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb5be0>, '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': '836cfdc75598d54cb747368e000001a9-1458239529.393178-1658050876', '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 11:32:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 11:32:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:32:25 INFO - Using env: {'DISPLAY': ':0', 11:32:25 INFO - 'HOME': '/home/cltbld', 11:32:25 INFO - 'LANG': 'en_US.UTF-8', 11:32:25 INFO - 'LANGUAGE': 'en_US:en', 11:32:25 INFO - 'LOGNAME': 'cltbld', 11:32:25 INFO - 'MAIL': '/var/mail/cltbld', 11:32:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:25 INFO - 'MOZ_NO_REMOTE': '1', 11:32:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:25 INFO - 'NO_EM_RESTART': '1', 11:32:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:32:25 INFO - 'PWD': '/builds/slave/test-pgo', 11:32:25 INFO - 'SHELL': '/bin/bash', 11:32:25 INFO - 'SHLVL': '1', 11:32:25 INFO - 'TERM': 'linux', 11:32:25 INFO - 'TMOUT': '86400', 11:32:25 INFO - 'USER': 'cltbld', 11:32:25 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1458239529.393178-1658050876', 11:32:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:25 INFO - '_': '/tools/buildbot/bin/python'} 11:32:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:25 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 11:32:25 INFO - Cleaning up... 11:32:25 INFO - Return code: 0 11:32:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f67d6281f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb76b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb21d0>, '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 0xfb5750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb5be0>, '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': '836cfdc75598d54cb747368e000001a9-1458239529.393178-1658050876', '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 11:32:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 11:32:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:32:25 INFO - Using env: {'DISPLAY': ':0', 11:32:25 INFO - 'HOME': '/home/cltbld', 11:32:25 INFO - 'LANG': 'en_US.UTF-8', 11:32:25 INFO - 'LANGUAGE': 'en_US:en', 11:32:25 INFO - 'LOGNAME': 'cltbld', 11:32:25 INFO - 'MAIL': '/var/mail/cltbld', 11:32:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:25 INFO - 'MOZ_NO_REMOTE': '1', 11:32:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:25 INFO - 'NO_EM_RESTART': '1', 11:32:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:32:25 INFO - 'PWD': '/builds/slave/test-pgo', 11:32:25 INFO - 'SHELL': '/bin/bash', 11:32:25 INFO - 'SHLVL': '1', 11:32:25 INFO - 'TERM': 'linux', 11:32:25 INFO - 'TMOUT': '86400', 11:32:25 INFO - 'USER': 'cltbld', 11:32:25 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1458239529.393178-1658050876', 11:32:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:25 INFO - '_': '/tools/buildbot/bin/python'} 11:32:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:25 INFO - Downloading/unpacking psutil>=0.7.1 11:32: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 11:32: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 11:32: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 11:32: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 11:32: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 11:32: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 11:32:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:32:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:32:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:32:27 INFO - Installing collected packages: psutil 11:32:27 INFO - Running setup.py install for psutil 11:32:27 INFO - building 'psutil._psutil_linux' extension 11:32:27 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 11:32:27 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 11:32:27 INFO - building 'psutil._psutil_posix' extension 11:32:27 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 11:32:27 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 11:32:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:32:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:32:27 INFO - Successfully installed psutil 11:32:27 INFO - Cleaning up... 11:32:27 INFO - Return code: 0 11:32:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:27 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f67d6281f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb76b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb21d0>, '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 0xfb5750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb5be0>, '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': '836cfdc75598d54cb747368e000001a9-1458239529.393178-1658050876', '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 11:32:28 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 11:32:28 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 11:32:28 INFO - Using env: {'DISPLAY': ':0', 11:32:28 INFO - 'HOME': '/home/cltbld', 11:32:28 INFO - 'LANG': 'en_US.UTF-8', 11:32:28 INFO - 'LANGUAGE': 'en_US:en', 11:32:28 INFO - 'LOGNAME': 'cltbld', 11:32:28 INFO - 'MAIL': '/var/mail/cltbld', 11:32:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:28 INFO - 'MOZ_NO_REMOTE': '1', 11:32:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:28 INFO - 'NO_EM_RESTART': '1', 11:32:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:32:28 INFO - 'PWD': '/builds/slave/test-pgo', 11:32:28 INFO - 'SHELL': '/bin/bash', 11:32:28 INFO - 'SHLVL': '1', 11:32:28 INFO - 'TERM': 'linux', 11:32:28 INFO - 'TMOUT': '86400', 11:32:28 INFO - 'USER': 'cltbld', 11:32:28 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1458239529.393178-1658050876', 11:32:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:28 INFO - '_': '/tools/buildbot/bin/python'} 11:32:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:28 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:32:28 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 11:32:28 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 11:32:28 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 11:32:28 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 11:32:28 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 11:32:28 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 11:32:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:32:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:32:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:32:30 INFO - Installing collected packages: mozsystemmonitor 11:32:30 INFO - Running setup.py install for mozsystemmonitor 11:32:30 INFO - Successfully installed mozsystemmonitor 11:32:30 INFO - Cleaning up... 11:32:30 INFO - Return code: 0 11:32:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:30 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 0x7f67d6281f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb76b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb21d0>, '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 0xfb5750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb5be0>, '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': '836cfdc75598d54cb747368e000001a9-1458239529.393178-1658050876', '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 11:32:30 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 11:32:30 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 11:32:30 INFO - Using env: {'DISPLAY': ':0', 11:32:30 INFO - 'HOME': '/home/cltbld', 11:32:30 INFO - 'LANG': 'en_US.UTF-8', 11:32:30 INFO - 'LANGUAGE': 'en_US:en', 11:32:30 INFO - 'LOGNAME': 'cltbld', 11:32:30 INFO - 'MAIL': '/var/mail/cltbld', 11:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:30 INFO - 'MOZ_NO_REMOTE': '1', 11:32:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:30 INFO - 'NO_EM_RESTART': '1', 11:32:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:32:30 INFO - 'PWD': '/builds/slave/test-pgo', 11:32:30 INFO - 'SHELL': '/bin/bash', 11:32:30 INFO - 'SHLVL': '1', 11:32:30 INFO - 'TERM': 'linux', 11:32:30 INFO - 'TMOUT': '86400', 11:32:30 INFO - 'USER': 'cltbld', 11:32:30 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1458239529.393178-1658050876', 11:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:30 INFO - '_': '/tools/buildbot/bin/python'} 11:32:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:30 INFO - Downloading/unpacking blobuploader==1.2.4 11:32:30 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 11:32:30 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 11:32:30 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 11:32:30 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 11:32:30 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 11:32:30 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 11:32:32 INFO - Downloading blobuploader-1.2.4.tar.gz 11:32:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:32:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:32:32 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 11:32:32 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 11:32:32 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 11:32:32 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 11:32:32 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 11:32:32 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 11:32:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:32:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:32:32 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 11:32:32 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 11:32:32 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 11:32:32 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 11:32:32 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 11:32:32 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 11:32:32 INFO - Downloading docopt-0.6.1.tar.gz 11:32:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:32:33 INFO - Installing collected packages: blobuploader, requests, docopt 11:32:33 INFO - Running setup.py install for blobuploader 11:32:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:32:33 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:32:33 INFO - Running setup.py install for requests 11:32:33 INFO - Running setup.py install for docopt 11:32:33 INFO - Successfully installed blobuploader requests docopt 11:32:33 INFO - Cleaning up... 11:32:33 INFO - Return code: 0 11:32:33 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:32: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')]} 11:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32: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')]} 11:32:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:33 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 0x7f67d6281f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb76b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb21d0>, '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 0xfb5750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb5be0>, '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': '836cfdc75598d54cb747368e000001a9-1458239529.393178-1658050876', '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 11:32:33 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 11:32:33 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 11:32:33 INFO - Using env: {'DISPLAY': ':0', 11:32:33 INFO - 'HOME': '/home/cltbld', 11:32:33 INFO - 'LANG': 'en_US.UTF-8', 11:32:33 INFO - 'LANGUAGE': 'en_US:en', 11:32:33 INFO - 'LOGNAME': 'cltbld', 11:32:33 INFO - 'MAIL': '/var/mail/cltbld', 11:32:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:33 INFO - 'MOZ_NO_REMOTE': '1', 11:32:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:33 INFO - 'NO_EM_RESTART': '1', 11:32:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:32:33 INFO - 'PWD': '/builds/slave/test-pgo', 11:32:33 INFO - 'SHELL': '/bin/bash', 11:32:33 INFO - 'SHLVL': '1', 11:32:33 INFO - 'TERM': 'linux', 11:32:33 INFO - 'TMOUT': '86400', 11:32:33 INFO - 'USER': 'cltbld', 11:32:33 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1458239529.393178-1658050876', 11:32:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:33 INFO - '_': '/tools/buildbot/bin/python'} 11:32:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:32:33 INFO - Running setup.py (path:/tmp/pip-u9DSKo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:32:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:32:33 INFO - Running setup.py (path:/tmp/pip-IvKv8y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:32:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:32:34 INFO - Running setup.py (path:/tmp/pip-hotE7r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:32:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:32:34 INFO - Running setup.py (path:/tmp/pip-ta7_k4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:32:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:32:34 INFO - Running setup.py (path:/tmp/pip-B94WOO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:32:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:32:34 INFO - Running setup.py (path:/tmp/pip-FjBTxP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:32:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:32:34 INFO - Running setup.py (path:/tmp/pip-k0NIbt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:32:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:32:34 INFO - Running setup.py (path:/tmp/pip-HTqI96-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:32:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:32:34 INFO - Running setup.py (path:/tmp/pip-y_OZtK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:32:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:32:34 INFO - Running setup.py (path:/tmp/pip-ZqnlbB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:32:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:32:34 INFO - Running setup.py (path:/tmp/pip-HpSCij-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:32:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:32:34 INFO - Running setup.py (path:/tmp/pip-D3MQIL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:32:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:32:34 INFO - Running setup.py (path:/tmp/pip-Accd9s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:32:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:32:34 INFO - Running setup.py (path:/tmp/pip-SPI3JK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:32:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:32:34 INFO - Running setup.py (path:/tmp/pip-uTKDkd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:32:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:32:34 INFO - Running setup.py (path:/tmp/pip-PGgAel-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:32:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:32:35 INFO - Running setup.py (path:/tmp/pip-NF4Uwy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:32:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:32:35 INFO - Running setup.py install for manifestparser 11:32:35 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:32:35 INFO - Running setup.py install for mozcrash 11:32:35 INFO - Running setup.py install for mozdebug 11:32:35 INFO - Running setup.py install for mozdevice 11:32:35 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:32:35 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:32:35 INFO - Running setup.py install for mozfile 11:32:35 INFO - Running setup.py install for mozhttpd 11:32:35 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:32:35 INFO - Running setup.py install for mozinfo 11:32:35 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:32:35 INFO - Running setup.py install for mozInstall 11:32:35 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:32:35 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:32:35 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:32:35 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:32:35 INFO - Running setup.py install for mozleak 11:32:36 INFO - Running setup.py install for mozlog 11:32:36 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:32:36 INFO - Running setup.py install for moznetwork 11:32:36 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:32:36 INFO - Running setup.py install for mozprocess 11:32:36 INFO - Running setup.py install for mozprofile 11:32:36 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:32:36 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:32:36 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:32:36 INFO - Running setup.py install for mozrunner 11:32:36 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:32:36 INFO - Running setup.py install for mozscreenshot 11:32:36 INFO - Running setup.py install for moztest 11:32:36 INFO - Running setup.py install for mozversion 11:32:36 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:32:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:32:36 INFO - Cleaning up... 11:32:36 INFO - Return code: 0 11:32:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:32: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')]} 11:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32: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')]} 11:32:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:36 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 0x7f67d6281f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb76b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb21d0>, '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 0xfb5750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb5be0>, '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': '836cfdc75598d54cb747368e000001a9-1458239529.393178-1658050876', '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 11:32:36 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 11:32:36 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 11:32:36 INFO - Using env: {'DISPLAY': ':0', 11:32:36 INFO - 'HOME': '/home/cltbld', 11:32:36 INFO - 'LANG': 'en_US.UTF-8', 11:32:36 INFO - 'LANGUAGE': 'en_US:en', 11:32:36 INFO - 'LOGNAME': 'cltbld', 11:32:36 INFO - 'MAIL': '/var/mail/cltbld', 11:32:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:36 INFO - 'MOZ_NO_REMOTE': '1', 11:32:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:36 INFO - 'NO_EM_RESTART': '1', 11:32:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:32:36 INFO - 'PWD': '/builds/slave/test-pgo', 11:32:36 INFO - 'SHELL': '/bin/bash', 11:32:36 INFO - 'SHLVL': '1', 11:32:36 INFO - 'TERM': 'linux', 11:32:36 INFO - 'TMOUT': '86400', 11:32:36 INFO - 'USER': 'cltbld', 11:32:36 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1458239529.393178-1658050876', 11:32:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:36 INFO - '_': '/tools/buildbot/bin/python'} 11:32:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:32:37 INFO - Running setup.py (path:/tmp/pip-5KWiOF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:32:37 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)) 11:32:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:32:37 INFO - Running setup.py (path:/tmp/pip-QthcVj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:32:37 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)) 11:32:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:32:37 INFO - Running setup.py (path:/tmp/pip-7Z1BKJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:32:37 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)) 11:32:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:32:37 INFO - Running setup.py (path:/tmp/pip-8I6Pqr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:32:37 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)) 11:32:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:32:37 INFO - Running setup.py (path:/tmp/pip-LpX6J1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:32:37 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)) 11:32:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:32:37 INFO - Running setup.py (path:/tmp/pip-J3go24-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:32:37 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)) 11:32:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:32:37 INFO - Running setup.py (path:/tmp/pip-qiHVaW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:32:37 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)) 11:32:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:32:37 INFO - Running setup.py (path:/tmp/pip-ZPWFYV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:32:37 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)) 11:32:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:32:37 INFO - Running setup.py (path:/tmp/pip-OCorSN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:32:37 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)) 11:32:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:32:37 INFO - Running setup.py (path:/tmp/pip-hzMg1d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:32:37 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)) 11:32:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:32:37 INFO - Running setup.py (path:/tmp/pip-dvGE3w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:32:37 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)) 11:32:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:32:37 INFO - Running setup.py (path:/tmp/pip-cnWBxK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:32:37 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)) 11:32:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:32:37 INFO - Running setup.py (path:/tmp/pip-eP_Ots-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:32:38 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)) 11:32:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:32:38 INFO - Running setup.py (path:/tmp/pip-kLO7gA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:32:38 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)) 11:32:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:32:38 INFO - Running setup.py (path:/tmp/pip-_ld14R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:32:38 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)) 11:32:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:32:38 INFO - Running setup.py (path:/tmp/pip-DT3CAu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:32:38 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)) 11:32:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:32:38 INFO - Running setup.py (path:/tmp/pip-7Oa9Qk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:32:38 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)) 11:32:38 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)) 11:32:38 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)) 11:32:38 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)) 11:32:38 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)) 11:32:38 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)) 11:32:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:32: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 11:32: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 11:32: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 11:32: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 11:32: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 11:32: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 11:32:40 INFO - Downloading blessings-1.6.tar.gz 11:32:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:32:40 INFO - Installing collected packages: blessings 11:32:40 INFO - Running setup.py install for blessings 11:32:40 INFO - Successfully installed blessings 11:32:40 INFO - Cleaning up... 11:32:40 INFO - Return code: 0 11:32:40 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:32:40 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:32:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:32:40 INFO - Reading from file tmpfile_stdout 11:32:40 INFO - Current package versions: 11:32:40 INFO - argparse == 1.2.1 11:32:40 INFO - blessings == 1.6 11:32:40 INFO - blobuploader == 1.2.4 11:32:40 INFO - docopt == 0.6.1 11:32:40 INFO - manifestparser == 1.1 11:32:40 INFO - mozInstall == 1.12 11:32:40 INFO - mozcrash == 0.17 11:32:40 INFO - mozdebug == 0.1 11:32:40 INFO - mozdevice == 0.48 11:32:40 INFO - mozfile == 1.2 11:32:40 INFO - mozhttpd == 0.7 11:32:40 INFO - mozinfo == 0.9 11:32:40 INFO - mozleak == 0.1 11:32:40 INFO - mozlog == 3.1 11:32:40 INFO - moznetwork == 0.27 11:32:40 INFO - mozprocess == 0.22 11:32:40 INFO - mozprofile == 0.28 11:32:40 INFO - mozrunner == 6.11 11:32:40 INFO - mozscreenshot == 0.1 11:32:40 INFO - mozsystemmonitor == 0.0 11:32:40 INFO - moztest == 0.7 11:32:40 INFO - mozversion == 1.4 11:32:40 INFO - psutil == 3.1.1 11:32:40 INFO - requests == 1.2.3 11:32:40 INFO - wsgiref == 0.1.2 11:32:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:40 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 0x7f67d6281f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb76b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb21d0>, '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 0xfb5750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb5be0>, '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': '836cfdc75598d54cb747368e000001a9-1458239529.393178-1658050876', '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 11:32:40 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 11:32:40 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 11:32:40 INFO - Using env: {'DISPLAY': ':0', 11:32:40 INFO - 'HOME': '/home/cltbld', 11:32:40 INFO - 'LANG': 'en_US.UTF-8', 11:32:40 INFO - 'LANGUAGE': 'en_US:en', 11:32:40 INFO - 'LOGNAME': 'cltbld', 11:32:40 INFO - 'MAIL': '/var/mail/cltbld', 11:32:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:40 INFO - 'MOZ_NO_REMOTE': '1', 11:32:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:40 INFO - 'NO_EM_RESTART': '1', 11:32:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:32:40 INFO - 'PWD': '/builds/slave/test-pgo', 11:32:40 INFO - 'SHELL': '/bin/bash', 11:32:40 INFO - 'SHLVL': '1', 11:32:40 INFO - 'TERM': 'linux', 11:32:40 INFO - 'TMOUT': '86400', 11:32:40 INFO - 'USER': 'cltbld', 11:32:40 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1458239529.393178-1658050876', 11:32:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:40 INFO - '_': '/tools/buildbot/bin/python'} 11:32:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:40 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)) 11:32:40 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)) 11:32:40 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)) 11:32:40 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)) 11:32:40 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)) 11:32:40 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)) 11:32:40 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)) 11:32:40 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)) 11:32:40 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)) 11:32:40 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)) 11:32:40 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)) 11:32:40 INFO - Cleaning up... 11:32:40 INFO - Return code: 0 11:32:40 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f67d6281f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb76b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb21d0>, '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 0xfb5750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb5be0>, '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': '836cfdc75598d54cb747368e000001a9-1458239529.393178-1658050876', '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 11:32:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 11:32:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:32:40 INFO - Using env: {'DISPLAY': ':0', 11:32:40 INFO - 'HOME': '/home/cltbld', 11:32:40 INFO - 'LANG': 'en_US.UTF-8', 11:32:40 INFO - 'LANGUAGE': 'en_US:en', 11:32:40 INFO - 'LOGNAME': 'cltbld', 11:32:40 INFO - 'MAIL': '/var/mail/cltbld', 11:32:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:40 INFO - 'MOZ_NO_REMOTE': '1', 11:32:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:40 INFO - 'NO_EM_RESTART': '1', 11:32:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:32:40 INFO - 'PWD': '/builds/slave/test-pgo', 11:32:40 INFO - 'SHELL': '/bin/bash', 11:32:40 INFO - 'SHLVL': '1', 11:32:40 INFO - 'TERM': 'linux', 11:32:40 INFO - 'TMOUT': '86400', 11:32:40 INFO - 'USER': 'cltbld', 11:32:40 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1458239529.393178-1658050876', 11:32:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:40 INFO - '_': '/tools/buildbot/bin/python'} 11:32:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:41 INFO - Downloading/unpacking jsonschema 11:32:41 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 11:32:41 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 11:32:41 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 11:32:41 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 11:32:41 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 11:32:41 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 11:32:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:32:42 INFO - Downloading/unpacking functools32 (from jsonschema) 11:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:43 INFO - Downloading functools32-3.2.3-2.tar.gz 11:32:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:32:43 INFO - warning: no files found matching '*.txt' 11:32:43 INFO - no previously-included directories found matching 'build' 11:32:43 INFO - no previously-included directories found matching 'dist' 11:32:43 INFO - no previously-included directories found matching '.git*' 11:32:43 INFO - Installing collected packages: jsonschema, functools32 11:32:43 INFO - Running setup.py install for functools32 11:32:43 INFO - warning: no files found matching '*.txt' 11:32:43 INFO - no previously-included directories found matching 'build' 11:32:43 INFO - no previously-included directories found matching 'dist' 11:32:43 INFO - no previously-included directories found matching '.git*' 11:32:43 INFO - Successfully installed jsonschema functools32 11:32:43 INFO - Cleaning up... 11:32:43 INFO - Return code: 0 11:32:43 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:43 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 0x7f67d6281f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb76b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb21d0>, '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 0xfb5750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb5be0>, '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': '836cfdc75598d54cb747368e000001a9-1458239529.393178-1658050876', '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 11:32:43 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 11:32:43 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 11:32:43 INFO - Using env: {'DISPLAY': ':0', 11:32:43 INFO - 'HOME': '/home/cltbld', 11:32:43 INFO - 'LANG': 'en_US.UTF-8', 11:32:43 INFO - 'LANGUAGE': 'en_US:en', 11:32:43 INFO - 'LOGNAME': 'cltbld', 11:32:43 INFO - 'MAIL': '/var/mail/cltbld', 11:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:43 INFO - 'MOZ_NO_REMOTE': '1', 11:32:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:43 INFO - 'NO_EM_RESTART': '1', 11:32:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:32:43 INFO - 'PWD': '/builds/slave/test-pgo', 11:32:43 INFO - 'SHELL': '/bin/bash', 11:32:43 INFO - 'SHLVL': '1', 11:32:43 INFO - 'TERM': 'linux', 11:32:43 INFO - 'TMOUT': '86400', 11:32:43 INFO - 'USER': 'cltbld', 11:32:43 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1458239529.393178-1658050876', 11:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:43 INFO - '_': '/tools/buildbot/bin/python'} 11:32:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:43 INFO - Downloading/unpacking flake8 11:32:43 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 11:32:43 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 11:32:43 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 11:32:43 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 11:32:43 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 11:32:43 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 11:32:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:32:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:32:45 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 11:32:45 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 11:32:45 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 11:32:45 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 11:32:45 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 11:32:45 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 11:32:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:32:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:32:45 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 11:32:45 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 11:32:45 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 11:32:45 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 11:32:45 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 11:32:45 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 11:32:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:32:45 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 11:32:45 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 11:32:45 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 11:32:45 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 11:32:45 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 11:32:45 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 11:32:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:32:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:32:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:32:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:32:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:32:46 INFO - no previously-included directories found matching 'docs/_build' 11:32:46 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:32:46 INFO - Running setup.py install for pep8 11:32:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:32:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:32:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:32:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:32:46 INFO - no previously-included directories found matching 'docs/_build' 11:32:46 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:32:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:32:46 INFO - Cleaning up... 11:32:46 INFO - Return code: 0 11:32:46 INFO - Running post-action listener: _resource_record_post_action 11:32:46 INFO - Running post-action listener: _start_resource_monitoring 11:32:46 INFO - Starting resource monitoring. 11:32:46 INFO - ##### 11:32:46 INFO - ##### Running install step. 11:32:46 INFO - ##### 11:32:46 INFO - Running pre-action listener: _resource_record_pre_action 11:32:46 INFO - Running main action method: install 11:32:46 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:32:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:32:46 INFO - Reading from file tmpfile_stdout 11:32:46 INFO - Detecting whether we're running mozinstall >=1.0... 11:32:46 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:32:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:32:46 INFO - Reading from file tmpfile_stdout 11:32:46 INFO - Output received: 11:32:46 INFO - Usage: mozinstall [options] installer 11:32:46 INFO - Options: 11:32:46 INFO - -h, --help show this help message and exit 11:32:46 INFO - -d DEST, --destination=DEST 11:32:46 INFO - Directory to install application into. [default: 11:32:46 INFO - "/builds/slave/test-pgo"] 11:32:46 INFO - --app=APP Application being installed. [default: firefox] 11:32:46 INFO - mkdir: /builds/slave/test-pgo/build/application 11:32:46 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'] 11:32:46 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 11:33:03 INFO - Reading from file tmpfile_stdout 11:33:03 INFO - Output received: 11:33:03 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:33:03 INFO - Running post-action listener: _resource_record_post_action 11:33:03 INFO - ##### 11:33:03 INFO - ##### Running run-tests step. 11:33:03 INFO - ##### 11:33:03 INFO - Running pre-action listener: _resource_record_pre_action 11:33:03 INFO - Running main action method: run_tests 11:33:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:33:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:33:03 INFO - Python 2.7.3 11:33:03 INFO - Return code: 0 11:33:03 INFO - grabbing minidump binary from tooltool 11:33:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:33:03 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 0xfb21d0>, '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 0xfb5750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb5be0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:33:03 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 11:33:03 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 11:33:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:33:03 INFO - Return code: 0 11:33:03 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:33:03 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:33:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:33:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:33:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:33:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:33:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:33:04 INFO - Return code: 0 11:33:04 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/ZPfR0fZhQgiaEuI0ey0yYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 11:33:04 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/ZPfR0fZhQgiaEuI0ey0yYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 11:33:04 INFO - Using env: {'DISPLAY': ':0', 11:33:04 INFO - 'HOME': '/home/cltbld', 11:33:04 INFO - 'LANG': 'en_US.UTF-8', 11:33:04 INFO - 'LANGUAGE': 'en_US:en', 11:33:04 INFO - 'LOGNAME': 'cltbld', 11:33:04 INFO - 'MAIL': '/var/mail/cltbld', 11:33:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:33:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:33:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:04 INFO - 'MOZ_NO_REMOTE': '1', 11:33:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:33:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:04 INFO - 'NO_EM_RESTART': '1', 11:33:04 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:33:04 INFO - 'PWD': '/builds/slave/test-pgo', 11:33:04 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:33:04 INFO - 'SHELL': '/bin/bash', 11:33:04 INFO - 'SHLVL': '1', 11:33:04 INFO - 'TERM': 'linux', 11:33:04 INFO - 'TMOUT': '86400', 11:33:04 INFO - 'USER': 'cltbld', 11:33:04 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1458239529.393178-1658050876', 11:33:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:04 INFO - '_': '/tools/buildbot/bin/python'} 11:33:04 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/ZPfR0fZhQgiaEuI0ey0yYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 11:33:04 INFO - mozversion application_buildid: 20160317080800 11:33:04 INFO - mozversion application_changeset: 3e04659fdf6aef792f7cf9840189c6c38d08d1e8 11:33:04 INFO - mozversion application_display_name: Nightly 11:33:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:33:04 INFO - mozversion application_name: Firefox 11:33:04 INFO - mozversion application_remotingname: firefox 11:33:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:33:04 INFO - mozversion application_vendor: Mozilla 11:33:04 INFO - mozversion application_version: 48.0a1 11:33:04 INFO - mozversion platform_buildid: 20160317080800 11:33:04 INFO - mozversion platform_changeset: 3e04659fdf6aef792f7cf9840189c6c38d08d1e8 11:33:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:33:04 INFO - mozversion platform_version: 48.0a1 11:33:04 INFO - using testdate: 1458239584 11:33:04 INFO - actual date: 1458239584 11:33:04 INFO - starting webserver on 'localhost:39773' 11:33:04 INFO - SUITE-START | Running 2 tests 11:33:04 INFO - TEST-START | dromaeo_css 11:33:04 INFO - operating with platform_type : linux_ 11:33:04 INFO - Initialising browser for dromaeo_css test... 11:33:04 INFO - TEST-INFO | started process 19781 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMO0N7g/profile http://localhost:39773/getInfo.html) 11:33:08 INFO - PROCESS | 19781 | __metrics Screen width/height:1600/1200 11:33:08 INFO - PROCESS | 19781 | colorDepth:24 11:33:08 INFO - PROCESS | 19781 | Browser inner width/height: 1024/697 11:33:08 INFO - PROCESS | 19781 | __metrics 11:33:09 ERROR - PROCESS | 19781 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:33:09 INFO - PROCESS | 19781 | 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. 11:33:10 INFO - TEST-INFO | 19781: exit 0 11:33:10 INFO - Browser initialized. 11:33:10 INFO - Running cycle 1/1 for dromaeo_css test... 11:33:10 INFO - TEST-INFO | started process 19878 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMO0N7g/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:33:22 INFO - PROCESS | 19878 | RSS: Main: 153059328 11:33:22 INFO - PROCESS | 19878 | 11:34:13 INFO - PROCESS | 19878 | 1458239653879 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] 11:36:20 INFO - PROCESS | 19878 | Cycle 1(1): loaded http://localhost:39773/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39773/tests/dromaeo/cssquery-ext.html) 11:36:21 INFO - PROCESS | 19878 | RSS: Main: 258109440 11:36:21 INFO - PROCESS | 19878 | 11:39:23 INFO - PROCESS | 19878 | Cycle 1(1): loaded http://localhost:39773/tests/dromaeo/cssquery-ext.html (next: http://localhost:39773/tests/dromaeo/cssquery-jquery.html) 11:39:23 INFO - PROCESS | 19878 | RSS: Main: 232869888 11:39:23 INFO - PROCESS | 19878 | 11:42:25 INFO - PROCESS | 19878 | Cycle 1(1): loaded http://localhost:39773/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39773/tests/dromaeo/cssquery-mootools.html) 11:42:26 INFO - PROCESS | 19878 | RSS: Main: 234803200 11:42:26 INFO - PROCESS | 19878 | 11:45:28 INFO - PROCESS | 19878 | Cycle 1(1): loaded http://localhost:39773/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39773/tests/dromaeo/cssquery-prototype.html) 11:45:28 INFO - PROCESS | 19878 | RSS: Main: 211566592 11:45:28 INFO - PROCESS | 19878 | 11:48:31 INFO - PROCESS | 19878 | Cycle 1(1): loaded http://localhost:39773/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39773/tests/dromaeo/cssquery-yui.html) 11:48:31 INFO - PROCESS | 19878 | RSS: Main: 220205056 11:48:31 INFO - PROCESS | 19878 | 11:51:34 INFO - PROCESS | 19878 | Cycle 1(1): loaded http://localhost:39773/tests/dromaeo/cssquery-yui.html (next: http://localhost:39773/tests/dromaeo/cssquery-dojo.html) 11:51:34 INFO - PROCESS | 19878 | RSS: Main: 266055680 11:51:34 INFO - PROCESS | 19878 | 11:51:34 INFO - PROCESS | 19878 | __start_tp_report 11:51:34 INFO - PROCESS | 19878 | _x_x_mozilla_page_load 11:51:34 INFO - PROCESS | 19878 | _x_x_mozilla_page_load_details 11:51:34 INFO - PROCESS | 19878 | |i|pagename|runs| 11:51:34 INFO - PROCESS | 19878 | |0;dojo.html;3023.3046399328155;3042.6500952390484;3073.8616762245697;3093.0720783764864;3107.720305172534;5050.949490505094;5070.619703522232;5173.844784656457;5205.973970130144;5229.163333866582;5151.793928242875;5170.121079416499;5180.533751962323;5181.715005674687;5252.894942101156;4605.055963527486;4650.697704649187;4752.07334569759;4754.310624959378;4796.47238803733;4735.526447355272;4736.597389221903;4746.952530474703;4792.664513484057;4843.830465933693;4556;4635.096156249533;4672.813087476497;4673.485916549177;4730.9763451182525;4735.242361222188;4744.833930812405;4750.691205071659;4769.260764581495;4795.712257264575;4616.215243408628;4668.719876807402;4709.505501922283;4723.220668589679;4747.715137091785;5076.289319495274;5090.898182036375;5096.770645320969;5120.257562653432;5133.486651334874;5492.780288788444;5499.50504454597;5499.50504454597;5504.559635229172;5542.889142217133;5405.432429594875;5525.972370138164;5527.917081243784;5554.166874968747;5554.416786237427;5209.6874187548865;5221.921671174898;5227.47725227478;5228.8692782680355;5252.028374750684;5653.604247702621;5669.149627555899;5671.773129074873;5673.120666296731;5681.431856814285;5352.170413585901;5366.973165134149;5368.91946620801;5430.83707488776;5433.809816656477;5490.80782172622;5539.723013849291;5552.472515111058;5556.777728890799;5566.860828479321;5540.9168862467095;5545.085060964976;5546.223528705985;5547.33431988164;5596.496315331639;5396.163594642837;5415.945840541544;5436.293281873332;5461.371942226615;5469.15228139639;4218.114196018871;4249.192653395907;4251.06476575153;4251.936220956688;4291.184674911757;3735.7198210134347;3768.811559422018;3794.2221844521805;3797.1646237827636;3842.5965273646425;5230.895382092337;5242.659227150223;5249.606279529051;5296.841094767163;5299.046171689133;5525.060739674265;5570.164475328733;5576;5587.888242235133;5595.720213989284;5079.771410286546;5128.8717782055;5237.502437268454;5251.684898906002;5252.501012403892;4761.904761904742;4764.737939413296;4779.665423420327;4801.135795556764;4826.155422800995;5685.800996965169;5693.060644993612;5693.658380497101;5693.857653558694;5740.167675687002;5382.9192562112385;5463.07127788269;5510.393856675682;5526.613137080366;5533.584981126432;5756.222909907109;5757.827265181883;5765.509931655689;5775.566832487496;5780.508656764222;5423.972880135574;5477.452254774491;5482.424345443671;5485.780568777363;5486.780528778964;5347.331583552056;5527.088030475087;5563.360213575329;5603.299587551556;5654.830355089354;5478.397376288684;5482.506574408322;5484.808031718871;5487.368952570346;5488.451154884479;5424.783008679608;5437.755301011543;5445.428230035947;5451.945480545144;5494.395616482264;5236.450172731808;5270.446603106619;5275.314209152785;5292.073887069824;5327.653702509325;5446.455354464521;5453.372862120748;5482.205080263419;5487.122060470306;5492.725363731877;5235.450277720937;5309;5371.597130215171;5372.516473517402;5424.972875135599 11:51:34 INFO - PROCESS | 19878 | |1;ext.html;551.196547665751;582.1994757208838;584.2025635008214;601.6480358989991;619.8718332634604;30864.69135308649;31374.05877823663;39694.60305396949;39745.60254397455;39927.802165935;42504.78747606265;42913.356299655454;42953;42968;42987;8604.225619694242;8798.120187981183;8800.911990880106;8801.031886492481;8807.031226565072;8636;8758.474491530496;8763.430377025474;8765;8766.956165219197;8975.057618950013;9003.864942025875;9031.819363612723;9042.728718138467;9052.140046695553;8908.910910890905;8937.687180948667;9000.459972401677;9003.5048072356;9013.504257265848;8761.912380876238;8880.55597220143;8891.911080889238;8917.375783695144;8921.241694455979;41494.1701165978;42056.36915446271;42117.36823947643;42129.789351053354;42157.36763948513;3540.168060505779;3574.0528759878393;3625.0605925829555;3651.72612054097;3744.7378683492166;32220.677793222003;32326.799460360235;32673.346533069205;32715.345693086005;33125;4003.819828107742;4109.383592461125;4110.897227569305;4117.197146556423;4148.751074935483;252675;253525.73237133882;254247;254417;254825;64979;66164;66671.66664166648;66756;67059;64599.67700161469;68069;68502.3149768496;71184.2881571188;71416.285837142;17025.829741702673;17051.147442628066;17051.72112091598;17055.8913670611;17185.39851105205;13080.411381487856;13220.933895330461;13227.272500012592;13229.140105893086;13232;18932.43202703921;20770.896145519175;21449.356519304445;22107.889460552593;22181.778182218295;8147.551884646283;8307.8338433231;8374.748757537283;8426.662933482714;8448.112948140357;932.5570354081757;990.8266053440619;994.751312171957;1069.4545781651414;1219.2257916223084;30837;31402.37195256082;31791.841040795112;32015.67984320127;32356.35287294241;1115.553778488611;1146.6617347882395;1149.574657376776;1185.875483074282;1234.6851552853964;16808.495745127664;16822;16914;16938.915305423394;16949.49151525456;387306;390566;391199;391608;391863;55548.44451555433;56995.71502142463;57016.71491642515;57097.14354284689;57149.428505715245;1223.8653748087704;1383.0595195267115;1384.5292600515672;1399.5731301952799;1419.070508816706;29758.702412976458;30308.54537181988;30582.541261880644;30745.464271608158;31128.53307200439;44584.55415445804;45097.098058039315;45294.77352613216;45362.319565205886;45404.318935215335;206288;210399;212345;212927;226681;30672.079837604906;35076.473852891715;35100.12249693778;35125;35736.821315894296;41110.794446028776;42055;48533.27200092072;49314;50165.24752128648;36490;36753.71362002317;37176.6282337184;40058.39912401258;40319.79840100898;39012.80493597514;39028.80485597554;39579;40101.1979760409;40360.39459408053;40215.597844021184;40414.1917161661;40611.593884061964;40955;41126.383104254055;33412.83293583516;34982.82508587441;35176;35747;36132.27735445329;27485;27763.305917352227;27864.442711146068;28140.29649258703;28170.15489535317 11:51:34 INFO - PROCESS | 19878 | |2;jquery.html;376.4973760030361;378.757674826569;381.1120090189857;383.5914750790408;384.571203108534;17233.310667573296;17752.023638699884;19068.141933613002;19562.21751129957;19579.314723984662;17531;17876.910615446937;18403.26386944524;18430.26278948844;18445.262189512403;5465.398806131322;5611.80358687446;5634.549236061105;5638.915416268759;5645.463680950324;4153.314703073989;5569;5955.3449120596915;6166.537509686769;6187.721552530147;6193.102000209967;6199.225096862892;6200.472959798422;6211.409916057967;6215.81352559424;5932.673702946337;6053.757849686007;6061.151438798572;6064.666443345614;6067.908981365283;3775.4903088083033;5238.266642670029;5380.058489764276;5391.757370918318;5403.621746477748;19510.219591216333;20122.39632811018;20220.19119235229;20569.794302056936;20630.5873882523;2220.134147682405;2273.8521996070367;2302.792748652629;2846.97508896797;3063.7702172337163;13223.73552528944;13263.73472530544;13277.468901244036;13456;13914.165150091027;1960.7353007343968;1971.310041485483;1984.682450807864;2014.738084049079;2016.163292233736;68589.31410685879;69323.65338173327;69789.3021069788;71568.6421567894;71987.64006179935;10449.582016719398;10529;10689.83965240522;10752.516136773864;10841;13974.510892118727;14035.298235088205;14048.929755351362;14071.226082565558;14083.929580352033;8193.631286592117;8407.663693452316;8408.411411201158;8499.745007649657;8584.442011269248;8344.457610255315;8390.202930721573;8407.789805254917;8457.957710211533;8514.276286515715;6446.806595802133;6540.444062254666;6583.736650534021;6584.374484424068;6649.867002659919;1733.1767410480172;1804.4496428589407;1807.1235450806348;1828.2226276102303;1847.6304739052243;751.48523261566;1013.9847902281472;1083.2092572422018;1083.3824719909733;1116.7822274656364;18325.266989320276;18530.536736581424;18531.536711582048;18591.34930277434;18852.717209241873;1044.5143008500932;1055.3140458701753;1060.379677888444;1079.7354648111263;1119.6864877834219;10883.727906802234;11072.003519683267;11079.5568177272;11093.611723589636;11101.222914396076;471400;474916;475180;478694;489422;65448.345516545174;76753;77497.61251193708;77661.22338776653;78441;1070.6199299248965;1086.581666058573;1106.6292791914639;1110.5724296146043;1133.4672703829187;16729.665406692042;16736.079515626272;16790.992540447125;16805.91597042007;16834.915825420794;35783;36018.09954751047;36468.63531364759;36614.8169259152;37092.629073708915;47401.28898066463;47846.76076619595;48056.27915581339;48194;48378.274325884435;8205.917940820515;8289.95855020721;8309.127541608286;8345.207205315486;8353.832923341377;11766.294022358687;12099.57651482194;12857.614271571867;12918.612441626767;13296.069275150647;10983.560657573607;11216;11358.375289359165;11871.762564748484;11887.583934562248;10588.788224235626;10662.413567253876;10884.45577721095;10983.670489885317;11280.548778048786;11229.887701122883;11589.304641721523;11748.17762756633;11756;11908.34504102248;8234.094249632415;8282.58587070632;8301.916980830356;8312.168783121639;8388.245057944814;11373.54505819758;11895.345755983504;11898.524059037542;11980.341081240615;12013.939930300643 11:51:34 INFO - PROCESS | 19878 | |3;mootools.html;1340.2963444191805;1498.1161114942186;1503.1957902522154;1687.1564217891055;1834.486343823729;7436.107667079951;7476.14024387195;7484;7484.96257518713;7501.737439189623;7269.600171990538;7428.517146385481;7481.289277518641;7487.812804679886;7499.512531685436;2041.071312552785;2272.397814579134;2294.621387471065;2320.535892821434;2335.1009861203474;2305.950792389467;2323.035940084863;2334.486412989148;2335.824813139013;2336.859788412692;2276.169198242646;2348.260298006131;2349.4948586053997;2350.4828937633692;2357.693499845018;2301.355620426283;2321.419645088728;2350.753170917046;2358.174638876397;2359.539889721505;2321.9651705224437;2324.4653729642278;2341.8829058547003;2365.219477572397;2380.2859142257253;7669.5398276103615;7703.3452156566755;7721.420893433015;7732.884006739903;7739.303462688329;4798.232282834764;4851.830185943475;4890.853274401774;4897.216445368724;4907.558319751204;3229.7739158258933;3310.519974603669;3342.2312868040485;3382.441897086978;3382.9323413531592;1067.6370034188335;1074.484247561175;1075.6504136155781;1088.2110469909333;1099.082266307634;10420;10473.685789426254;10523.526441310083;10556.049955504042;10571.471426428725;4342.305231162999;4350.60844523988;4396.054848207651;4434.667399944952;4451.486494591854;8990.865137022949;9016.684416045407;9058.54707264634;9061.95469022664;9086.273098152133;4441.133978874089;4938.950610493849;4940.357753492023;4941.43173535048;4943.456219815817;4454.28731402974;4474.217012022883;4487.282034874404;4529.818807247739;4540.545945405499;3728.981355093207;3816.31306364857;3823.0824602095295;3834.616538346199;3860.324443222481;1223.2110288863632;1246.6010876519608;1246.7007918099591;1247.089624574066;1253.9937300313622;1385.736710025092;1389.305347326337;1407.5917983784589;1420.4815242436437;1425.2303755971866;7255.056842610426;7391.186969433358;7405.481616286916;7405.925940740523;7412.1476030256135;483.41265362583925;486.3871521882383;491.63864559548705;495.74221404869985;496.22588761532126;5680.346760122557;5686.9715651421475;5699.515541178963;5733.455321744427;5757.280339957505;8956.552172391355;9364.110409511086;9473.621055157855;9474.573644186028;9483.90516094844;9259.490728010023;9280.72157835266;9355.485448300273;9377.624895004259;9415.576299066559;7079.115110611174;7266.96366518164;7268.309510596485;7280.053593032978;7401.111866575938;6911.827204319932;6914.412274956484;6960.338767817049;6968.303169682991;6993.825154371181;7815.6092195388865;8021.919780802117;8036.357091432788;8170.346372290322;8211;8204;8260.132686067876;8370.455920365157;8415.53714545706;8417.032041315328;6181.876362472815;6267.655278959701;6691.364320389555;6919.654017299215;7187.029750983759;7280.708771649075;7296.087989001375;7313.744018959311;7322.157951835394;7328;6534;6708.530402871752;6717.798466046026;6783.660816959231;6800.319968003358;6511.9348806511325;6582.868342633024;6589.505787066085;6622.10601568782;6658.866822663616;6778.932210678027;6819.420349270367;6844.691988860413;6872.45020398357;6877.9656101721175;6325.399087086719;6444;6461.224653041665;6463.870722585428;6466.127072845105;6495.0906873036865;6508.381703738138;6516.315786842503;6516.57642253252;6526.5105117117355 11:51:34 INFO - PROCESS | 19878 | |4;prototype.html;340.3805074763929;343.3236524047626;346.321210427562;347.2499401293207;353.56334926365935;5940.7326670299835;5942.732577034033;5965.492933100686;5973.372795856438;6029.668368239745;5922.733476993535;5952.761889524414;5958.5828991970575;5965.850853728659;5968.10478428236;4384;4449;4499.61753250974;4531.0258294466685;4582.633389328846;4569.657275704319;4570.314452832068;4580;4598.057398233354;4604.263317869141;4524.592786649201;4533.546645335473;4536.637069034469;4542.273236282195;4555.63554915606;4356.237658409766;4438.511763705974;4473.038296766211;4487.12501062293;4519.502854685982;3975.4434379186646;3998.10042740384;4003.15933653933;4005.379166229239;4009.959900400988;5703.08750599902;5742.97128514359;5744.368119506851;5750.166225897264;5754.251947246873;5330.413654498041;5339.919901201485;5341.786328546854;5343.064963631349;5345.33183352081;6271.027990661455;6277.246730392382;6284.340144284875;6284.968575157141;6287.779927702554;4301.698881078326;4431.645468362555;4437.667174961891;4492.07912377965;4493.326001099828;6573.441257493118;6618.073469714244;6630.038644396584;6642.202935647753;6649.069130321759;4510.616597589242;4514.525974772601;4514.6388288936805;4515.164694531522;4515.277555591089;4562.908741825145;4567.885802854888;4571.017231295287;4576.0161565263625;4576.496585375606;5283.577313814885;5290.127129023745;5296.549793267538;5300.469953004746;5300.814471493479;6225.750969961241;6315.778947736807;6367.42693157618;6380.489560835122;6380.649064301415;1543.1512668032537;1558.4155941521929;1567.7334853075004;1573.5122112145273;1577.1798664694295;1000.4397537379091;1034.4414016431194;1056.4559251985233;1073.2809017957986;1077.2513103393223;5960.344362120163;5974.1934838796205;6030.517558595389;6068.75724971005;6074.878502429927;6480.287168411471;6484.935150648527;6486.772962946275;6487.7080531376205;6506.902396464056;6068.33248342682;6068.393160683984;6068.757249709962;6078.392160783975;6078.848028799227;3463.8441270142903;3499.6675315844955;3500.8599656013985;3501.7548771585743;3511.2626348467106;6596.241432235259;6694.297098804653;6739.764108256188;6750.696218670171;6759.831004224835;6561.639109849004;6564.6389448580785;6592.340765923465;6598.274189839114;6602.537822352485;6711.6979735912;6733;6763.932360676428;6813.182418109858;6818.420434263044;6473.352664733489;6475.190601174853;6478.222613286436;6480.773172938924;6490.156279683611;6276.744651069713;6388.616682999035;6401.615903045832;6496.408379946944;6502.284748677547;6823.38589526945;6843.589384636938;6847.520673552804;6851.143607049119;6859.862802744017;4481.215787237155;4523.231050721451;4530.184566778012;4530.70550414222;4534.888952206598;6524.9673751630935;6550.934490655032;6551.377619126175;6554.132072359545;6561.934380656132;6178.382161783786;6327.367263273636;6374.936250637435;6383.5531512795515;6400;6247.687615619292;6274.372562743872;6283.7800676976085;6284.183056202664;6288.434040936338;6190.350013248724;6199.442050215503;6200.596961197508;6286.52851036165;6291.874162516816;6411.647359395278;6414.102025716496;6421.646809425526;6422.100905873275;6425.453836423956;5934.762609495745;6070.423309785563;6139.907901381573;6259.687015649109;6267.749290028531 11:51:34 INFO - PROCESS | 19878 | |5;yui.html;717.8636059148762;820.6061090676471;829.3572481326971;836.7238811192307;858.523519446707;14230.43078276869;14468.710625787478;14491.637709057279;14504.404515503285;14522.782158267635;14328.64178395538;14448.638784030405;14464.566063018126;14477.348519316629;14480.855191448083;691.0291041087255;826.4875777018242;835.0772396501869;837.5560952695081;838.4047326398264;834.6744769539854;847.525385783963;849.3757088539918;850.8085680721819;851.3529717414748;885;888.8000199955023;889.3463304471209;889.5063239901851;890.679355432044;708.1290013283639;865.9826803463895;881.8104107616894;882.32942963348;885.154677283193;642.4346575014005;643.7328508668896;644.3878315600152;645.7223393940603;646.7865604350553;13778.65553361164;13849.099808512414;13849.307534623229;13858.722825543533;13867.23730194839;13203.339833008407;13763.793543096861;14044.36800343987;14050.36773345202;14228.573142805732;11375.203735738502;11529.884701153049;11620.410566549834;11769.293842369485;11886.881131188664;3780.7353485256044;3799.9620003799882;3811.9809400953095;3845.692344612424;3937.4881265435597;50549.24176137361;50614.24078638823;50905.74547127241;51072.233916491285;51191.23213151806;10077.360648451051;10422.947885260677;10673.946630266799;10707.196960228013;10723.517441715141;18710.158042888103;18796.154173062245;18800.811991879906;18803.623927521647;18812.435626931216;7929.484583502054;7940.28537431634;8013.719519816778;8265;8355.665773369119;4673.088747694167;4681.882952926136;4753.952460475421;4779.139754844162;4835.927461088087;3284.4088064148204;3299.6205436374644;3299.785513941586;3304.553885225464;3307.5038744188564;598.7455331484102;618.0759764152531;630.4483576870239;632.9367063293726;633.24959922492;579.7874441942225;605.5004621187538;679.823245956055;755.5731011978324;768.8851165809486;9601.423914565148;9708.417494950325;9813.901860981441;9934.304598678167;9962.203023758082;691.6991108867659;706.1737766812842;748.098541257783;751.8383547537305;773.7175930785223;4866.829660961849;4884.658073934862;4889.975550122226;4894.461609222983;4943.8022479101155;60828.69585652132;62808.69443500214;63220.68389658114;66220;66465.6676716623;56338.154927676114;56495;56768.71615641978;57494.42505574974;58211.126833097536;48683;48825.75587122042;52399.21401178985;52704;53770.46229537733;9695.9030409695;10021.699349019542;10058.14505767018;10073.194144468278;10184;36832.631673683994;37827;38120.428193577674;38997;39994.800025999684;44482;45774.31338529858;46759.53240467552;46786.29820552626;46864.297035543816;11916.165868389477;11956.521739130338;11962.700932476757;12091.395430228278;12225.816612750994;13277.468901244229;13759.10565813219;13907.235102069484;14085.366158523097;14257.28713564297;12639.213410127179;12702.68243293888;12829.166104203197;12984.870151298366;13038.934805325913;12474.5010199591;12583.496660133858;12592.937035314764;13053.934730326288;13253.13854599448;12355.25868447896;12496;12832.165909215872;12863.421146048637;12983.415746291628;10393.532291047073;10509.369437833755;10665.680029599125;10691.30506517074;11356.886431135583;10250.333728307636;10514.204094588124;10626.901401426487;10949.781004380027;11287 11:51:34 INFO - PROCESS | 19878 | __end_tp_report 11:51:34 INFO - PROCESS | 19878 | __start_cc_report 11:51:34 INFO - PROCESS | 19878 | _x_x_mozilla_cycle_collect,775 11:51:34 INFO - PROCESS | 19878 | __end_cc_report 11:51:34 INFO - PROCESS | 19878 | __startTimestamp1458240694436__endTimestamp 11:51:34 INFO - PROCESS | 19878 | 11:51:34 INFO - PROCESS | 19878 | ------- Summary: start ------- 11:51:34 INFO - PROCESS | 19878 | Number of tests: 6 11:51:34 INFO - PROCESS | 19878 | 11:51:34 INFO - PROCESS | 19878 | [#0] dojo.html Cycles:165 Average:5144.86 Median:5347.33 stddev:571.90 (10.7%) stddev-sans-first:548.90 11:51:34 INFO - PROCESS | 19878 | Values: 3023.3 3042.7 3073.9 3093.1 3107.7 5050.9 5070.6 5173.8 5206.0 5229.2 5151.8 5170.1 5180.5 5181.7 5252.9 4605.1 4650.7 4752.1 4754.3 4796.5 4735.5 4736.6 4747.0 4792.7 4843.8 4556.0 4635.1 4672.8 4673.5 4731.0 4735.2 4744.8 4750.7 4769.3 4795.7 4616.2 4668.7 4709.5 4723.2 4747.7 5076.3 5090.9 5096.8 5120.3 5133.5 5492.8 5499.5 5499.5 5504.6 5542.9 5405.4 5526.0 5527.9 5554.2 5554.4 5209.7 5221.9 5227.5 5228.9 5252.0 5653.6 5669.1 5671.8 5673.1 5681.4 5352.2 5367.0 5368.9 5430.8 5433.8 5490.8 5539.7 5552.5 5556.8 5566.9 5540.9 5545.1 5546.2 5547.3 5596.5 5396.2 5415.9 5436.3 5461.4 5469.2 4218.1 4249.2 4251.1 4251.9 4291.2 3735.7 3768.8 3794.2 3797.2 3842.6 5230.9 5242.7 5249.6 5296.8 5299.0 5525.1 5570.2 5576.0 5587.9 5595.7 5079.8 5128.9 5237.5 5251.7 5252.5 4761.9 4764.7 4779.7 4801.1 4826.2 5685.8 5693.1 5693.7 5693.9 5740.2 5382.9 5463.1 5510.4 5526.6 5533.6 5756.2 5757.8 5765.5 5775.6 5780.5 5424.0 5477.5 5482.4 5485.8 5486.8 5347.3 5527.1 5563.4 5603.3 5654.8 5478.4 5482.5 5484.8 5487.4 5488.5 5424.8 5437.8 5445.4 5451.9 5494.4 5236.5 5270.4 5275.3 5292.1 5327.7 5446.5 5453.4 5482.2 5487.1 5492.7 5235.5 5309.0 5371.6 5372.5 5425.0 11:51:34 INFO - PROCESS | 19878 | 11:51:34 INFO - PROCESS | 19878 | [#1] ext.html Cycles:180 Average:47388.13 Median:39720.10 stddev:77661.62 (195.5%) stddev-sans-first:77799.86 11:51:34 INFO - PROCESS | 19878 | Values: 551.2 582.2 584.2 601.6 619.9 30864.7 31374.1 39694.6 39745.6 39927.8 42504.8 42913.4 42953.0 42968.0 42987.0 8604.2 8798.1 8800.9 8801.0 8807.0 8636.0 8758.5 8763.4 8765.0 8767.0 8975.1 9003.9 9031.8 9042.7 9052.1 8908.9 8937.7 9000.5 9003.5 9013.5 8761.9 8880.6 8891.9 8917.4 8921.2 41494.2 42056.4 42117.4 42129.8 42157.4 3540.2 3574.1 3625.1 3651.7 3744.7 32220.7 32326.8 32673.3 32715.3 33125.0 4003.8 4109.4 4110.9 4117.2 4148.8 252675.0 253525.7 254247.0 254417.0 254825.0 64979.0 66164.0 66671.7 66756.0 67059.0 64599.7 68069.0 68502.3 71184.3 71416.3 17025.8 17051.1 17051.7 17055.9 17185.4 13080.4 13220.9 13227.3 13229.1 13232.0 18932.4 20770.9 21449.4 22107.9 22181.8 8147.6 8307.8 8374.7 8426.7 8448.1 932.6 990.8 994.8 1069.5 1219.2 30837.0 31402.4 31791.8 32015.7 32356.4 1115.6 1146.7 1149.6 1185.9 1234.7 16808.5 16822.0 16914.0 16938.9 16949.5 387306.0 390566.0 391199.0 391608.0 391863.0 55548.4 56995.7 57016.7 57097.1 57149.4 1223.9 1383.1 1384.5 1399.6 1419.1 29758.7 30308.5 30582.5 30745.5 31128.5 44584.6 45097.1 45294.8 45362.3 45404.3 206288.0 210399.0 212345.0 212927.0 226681.0 30672.1 35076.5 35100.1 35125.0 35736.8 41110.8 42055.0 48533.3 49314.0 50165.2 36490.0 36753.7 37176.6 40058.4 40319.8 39012.8 39028.8 39579.0 40101.2 40360.4 40215.6 40414.2 40611.6 40955.0 41126.4 33412.8 34982.8 35176.0 35747.0 36132.3 27485.0 27763.3 27864.4 28140.3 28170.2 11:51:34 INFO - PROCESS | 19878 | 11:51:34 INFO - PROCESS | 19878 | [#2] jquery.html Cycles:180 Average:27389.06 Median:11118.18 stddev:78247.76 (703.8%) stddev-sans-first:78440.97 11:51:34 INFO - PROCESS | 19878 | Values: 376.5 378.8 381.1 383.6 384.6 17233.3 17752.0 19068.1 19562.2 19579.3 17531.0 17876.9 18403.3 18430.3 18445.3 5465.4 5611.8 5634.5 5638.9 5645.5 4153.3 5569.0 5955.3 6166.5 6187.7 6193.1 6199.2 6200.5 6211.4 6215.8 5932.7 6053.8 6061.2 6064.7 6067.9 3775.5 5238.3 5380.1 5391.8 5403.6 19510.2 20122.4 20220.2 20569.8 20630.6 2220.1 2273.9 2302.8 2847.0 3063.8 13223.7 13263.7 13277.5 13456.0 13914.2 1960.7 1971.3 1984.7 2014.7 2016.2 68589.3 69323.7 69789.3 71568.6 71987.6 10449.6 10529.0 10689.8 10752.5 10841.0 13974.5 14035.3 14048.9 14071.2 14083.9 8193.6 8407.7 8408.4 8499.7 8584.4 8344.5 8390.2 8407.8 8458.0 8514.3 6446.8 6540.4 6583.7 6584.4 6649.9 1733.2 1804.4 1807.1 1828.2 1847.6 751.5 1014.0 1083.2 1083.4 1116.8 18325.3 18530.5 18531.5 18591.3 18852.7 1044.5 1055.3 1060.4 1079.7 1119.7 10883.7 11072.0 11079.6 11093.6 11101.2 471400.0 474916.0 475180.0 478694.0 489422.0 65448.3 76753.0 77497.6 77661.2 78441.0 1070.6 1086.6 1106.6 1110.6 1133.5 16729.7 16736.1 16791.0 16805.9 16834.9 35783.0 36018.1 36468.6 36614.8 37092.6 47401.3 47846.8 48056.3 48194.0 48378.3 8205.9 8290.0 8309.1 8345.2 8353.8 11766.3 12099.6 12857.6 12918.6 13296.1 10983.6 11216.0 11358.4 11871.8 11887.6 10588.8 10662.4 10884.5 10983.7 11280.5 11229.9 11589.3 11748.2 11756.0 11908.3 8234.1 8282.6 8301.9 8312.2 8388.2 11373.5 11895.3 11898.5 11980.3 12013.9 11:51:34 INFO - PROCESS | 19878 | 11:51:34 INFO - PROCESS | 19878 | [#3] mootools.html Cycles:180 Average:5409.02 Median:6224.77 stddev:2746.86 (44.1%) stddev-sans-first:2737.54 11:51:34 INFO - PROCESS | 19878 | Values: 1340.3 1498.1 1503.2 1687.2 1834.5 7436.1 7476.1 7484.0 7485.0 7501.7 7269.6 7428.5 7481.3 7487.8 7499.5 2041.1 2272.4 2294.6 2320.5 2335.1 2306.0 2323.0 2334.5 2335.8 2336.9 2276.2 2348.3 2349.5 2350.5 2357.7 2301.4 2321.4 2350.8 2358.2 2359.5 2322.0 2324.5 2341.9 2365.2 2380.3 7669.5 7703.3 7721.4 7732.9 7739.3 4798.2 4851.8 4890.9 4897.2 4907.6 3229.8 3310.5 3342.2 3382.4 3382.9 1067.6 1074.5 1075.7 1088.2 1099.1 10420.0 10473.7 10523.5 10556.0 10571.5 4342.3 4350.6 4396.1 4434.7 4451.5 8990.9 9016.7 9058.5 9062.0 9086.3 4441.1 4939.0 4940.4 4941.4 4943.5 4454.3 4474.2 4487.3 4529.8 4540.5 3729.0 3816.3 3823.1 3834.6 3860.3 1223.2 1246.6 1246.7 1247.1 1254.0 1385.7 1389.3 1407.6 1420.5 1425.2 7255.1 7391.2 7405.5 7405.9 7412.1 483.4 486.4 491.6 495.7 496.2 5680.3 5687.0 5699.5 5733.5 5757.3 8956.6 9364.1 9473.6 9474.6 9483.9 9259.5 9280.7 9355.5 9377.6 9415.6 7079.1 7267.0 7268.3 7280.1 7401.1 6911.8 6914.4 6960.3 6968.3 6993.8 7815.6 8021.9 8036.4 8170.3 8211.0 8204.0 8260.1 8370.5 8415.5 8417.0 6181.9 6267.7 6691.4 6919.7 7187.0 7280.7 7296.1 7313.7 7322.2 7328.0 6534.0 6708.5 6717.8 6783.7 6800.3 6511.9 6582.9 6589.5 6622.1 6658.9 6778.9 6819.4 6844.7 6872.5 6878.0 6325.4 6444.0 6461.2 6463.9 6466.1 6495.1 6508.4 6516.3 6516.6 6526.5 11:51:34 INFO - PROCESS | 19878 | 11:51:34 INFO - PROCESS | 19878 | [#4] prototype.html Cycles:180 Average:5289.36 Median:5973.78 stddev:1595.59 (26.7%) stddev-sans-first:1556.23 11:51:34 INFO - PROCESS | 19878 | Values: 340.4 343.3 346.3 347.2 353.6 5940.7 5942.7 5965.5 5973.4 6029.7 5922.7 5952.8 5958.6 5965.9 5968.1 4384.0 4449.0 4499.6 4531.0 4582.6 4569.7 4570.3 4580.0 4598.1 4604.3 4524.6 4533.5 4536.6 4542.3 4555.6 4356.2 4438.5 4473.0 4487.1 4519.5 3975.4 3998.1 4003.2 4005.4 4010.0 5703.1 5743.0 5744.4 5750.2 5754.3 5330.4 5339.9 5341.8 5343.1 5345.3 6271.0 6277.2 6284.3 6285.0 6287.8 4301.7 4431.6 4437.7 4492.1 4493.3 6573.4 6618.1 6630.0 6642.2 6649.1 4510.6 4514.5 4514.6 4515.2 4515.3 4562.9 4567.9 4571.0 4576.0 4576.5 5283.6 5290.1 5296.5 5300.5 5300.8 6225.8 6315.8 6367.4 6380.5 6380.6 1543.2 1558.4 1567.7 1573.5 1577.2 1000.4 1034.4 1056.5 1073.3 1077.3 5960.3 5974.2 6030.5 6068.8 6074.9 6480.3 6484.9 6486.8 6487.7 6506.9 6068.3 6068.4 6068.8 6078.4 6078.8 3463.8 3499.7 3500.9 3501.8 3511.3 6596.2 6694.3 6739.8 6750.7 6759.8 6561.6 6564.6 6592.3 6598.3 6602.5 6711.7 6733.0 6763.9 6813.2 6818.4 6473.4 6475.2 6478.2 6480.8 6490.2 6276.7 6388.6 6401.6 6496.4 6502.3 6823.4 6843.6 6847.5 6851.1 6859.9 4481.2 4523.2 4530.2 4530.7 4534.9 6525.0 6550.9 6551.4 6554.1 6561.9 6178.4 6327.4 6374.9 6383.6 6400.0 6247.7 6274.4 6283.8 6284.2 6288.4 6190.4 6199.4 6200.6 6286.5 6291.9 6411.6 6414.1 6421.6 6422.1 6425.5 5934.8 6070.4 6139.9 6259.7 6267.7 11:51:34 INFO - PROCESS | 19878 | 11:51:34 INFO - PROCESS | 19878 | [#5] yui.html Cycles:180 Average:15065.64 Median:25223.70 stddev:17363.57 (68.8%) stddev-sans-first:17378.85 11:51:34 INFO - PROCESS | 19878 | Values: 717.9 820.6 829.4 836.7 858.5 14230.4 14468.7 14491.6 14504.4 14522.8 14328.6 14448.6 14464.6 14477.3 14480.9 691.0 826.5 835.1 837.6 838.4 834.7 847.5 849.4 850.8 851.4 885.0 888.8 889.3 889.5 890.7 708.1 866.0 881.8 882.3 885.2 642.4 643.7 644.4 645.7 646.8 13778.7 13849.1 13849.3 13858.7 13867.2 13203.3 13763.8 14044.4 14050.4 14228.6 11375.2 11529.9 11620.4 11769.3 11886.9 3780.7 3800.0 3812.0 3845.7 3937.5 50549.2 50614.2 50905.7 51072.2 51191.2 10077.4 10422.9 10673.9 10707.2 10723.5 18710.2 18796.2 18800.8 18803.6 18812.4 7929.5 7940.3 8013.7 8265.0 8355.7 4673.1 4681.9 4754.0 4779.1 4835.9 3284.4 3299.6 3299.8 3304.6 3307.5 598.7 618.1 630.4 632.9 633.2 579.8 605.5 679.8 755.6 768.9 9601.4 9708.4 9813.9 9934.3 9962.2 691.7 706.2 748.1 751.8 773.7 4866.8 4884.7 4890.0 4894.5 4943.8 60828.7 62808.7 63220.7 66220.0 66465.7 56338.2 56495.0 56768.7 57494.4 58211.1 48683.0 48825.8 52399.2 52704.0 53770.5 9695.9 10021.7 10058.1 10073.2 10184.0 36832.6 37827.0 38120.4 38997.0 39994.8 44482.0 45774.3 46759.5 46786.3 46864.3 11916.2 11956.5 11962.7 12091.4 12225.8 13277.5 13759.1 13907.2 14085.4 14257.3 12639.2 12702.7 12829.2 12984.9 13038.9 12474.5 12583.5 12592.9 13053.9 13253.1 12355.3 12496.0 12832.2 12863.4 12983.4 10393.5 10509.4 10665.7 10691.3 11356.9 10250.3 10514.2 10626.9 10949.8 11287.0 11:51:34 INFO - PROCESS | 19878 | -------- Summary: end -------- 11:51:34 INFO - PROCESS | 19878 | 11:51:35 INFO - TEST-INFO | 19878: exit 0 11:51:35 INFO - TEST-OK | dromaeo_css | took 1110878ms 11:51:35 INFO - TEST-START | kraken 11:51:35 INFO - operating with platform_type : linux_ 11:51:35 INFO - Initialising browser for kraken test... 11:51:35 INFO - TEST-INFO | started process 20059 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaWSyVx/profile http://localhost:39773/getInfo.html) 11:51:39 INFO - PROCESS | 20059 | __metrics Screen width/height:1600/1200 11:51:39 INFO - PROCESS | 20059 | colorDepth:24 11:51:39 INFO - PROCESS | 20059 | Browser inner width/height: 1024/697 11:51:39 INFO - PROCESS | 20059 | __metrics 11:51:40 ERROR - PROCESS | 20059 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:51:40 INFO - PROCESS | 20059 | 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. 11:51:41 INFO - TEST-INFO | 20059: exit 0 11:51:41 INFO - Browser initialized. 11:51:41 INFO - Running cycle 1/1 for kraken test... 11:51:41 INFO - TEST-INFO | started process 20140 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaWSyVx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:51:52 INFO - PROCESS | 20140 | RSS: Main: 153063424 11:51:52 INFO - PROCESS | 20140 | 11:51:55 INFO - PROCESS | 20140 | Cycle 1(1): loaded http://localhost:39773/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39773/tests/kraken/driver.html?testName=audio-beat-detection) 11:51:56 INFO - PROCESS | 20140 | RSS: Main: 195178496 11:51:56 INFO - PROCESS | 20140 | 11:51:58 INFO - PROCESS | 20140 | Cycle 1(1): loaded http://localhost:39773/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39773/tests/kraken/driver.html?testName=audio-dft) 11:51:59 INFO - PROCESS | 20140 | RSS: Main: 184700928 11:51:59 INFO - PROCESS | 20140 | 11:52:02 INFO - PROCESS | 20140 | Cycle 1(1): loaded http://localhost:39773/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39773/tests/kraken/driver.html?testName=audio-fft) 11:52:02 INFO - PROCESS | 20140 | RSS: Main: 170516480 11:52:02 INFO - PROCESS | 20140 | 11:52:04 INFO - PROCESS | 20140 | Cycle 1(1): loaded http://localhost:39773/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39773/tests/kraken/driver.html?testName=audio-oscillator) 11:52:05 INFO - PROCESS | 20140 | RSS: Main: 172380160 11:52:05 INFO - PROCESS | 20140 | 11:52:07 INFO - PROCESS | 20140 | Cycle 1(1): loaded http://localhost:39773/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39773/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:52:08 INFO - PROCESS | 20140 | RSS: Main: 173346816 11:52:08 INFO - PROCESS | 20140 | 11:52:11 INFO - PROCESS | 20140 | Cycle 1(1): loaded http://localhost:39773/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39773/tests/kraken/driver.html?testName=imaging-darkroom) 11:52:11 INFO - PROCESS | 20140 | RSS: Main: 174604288 11:52:11 INFO - PROCESS | 20140 | 11:52:15 INFO - PROCESS | 20140 | Cycle 1(1): loaded http://localhost:39773/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39773/tests/kraken/driver.html?testName=imaging-desaturate) 11:52:15 INFO - PROCESS | 20140 | RSS: Main: 174567424 11:52:15 INFO - PROCESS | 20140 | 11:52:18 INFO - PROCESS | 20140 | Cycle 1(1): loaded http://localhost:39773/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39773/tests/kraken/driver.html?testName=json-parse-financial) 11:52:18 INFO - PROCESS | 20140 | RSS: Main: 174669824 11:52:18 INFO - PROCESS | 20140 | 11:52:20 INFO - PROCESS | 20140 | Cycle 1(1): loaded http://localhost:39773/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39773/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:52:21 INFO - PROCESS | 20140 | RSS: Main: 189259776 11:52:21 INFO - PROCESS | 20140 | 11:52:22 INFO - PROCESS | 20140 | Cycle 1(1): loaded http://localhost:39773/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39773/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:52:23 INFO - PROCESS | 20140 | RSS: Main: 186347520 11:52:23 INFO - PROCESS | 20140 | 11:52:25 INFO - PROCESS | 20140 | Cycle 1(1): loaded http://localhost:39773/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39773/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:52:26 INFO - PROCESS | 20140 | RSS: Main: 195530752 11:52:26 INFO - PROCESS | 20140 | 11:52:28 INFO - PROCESS | 20140 | Cycle 1(1): loaded http://localhost:39773/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39773/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:52:28 INFO - PROCESS | 20140 | RSS: Main: 203194368 11:52:28 INFO - PROCESS | 20140 | 11:52:31 INFO - PROCESS | 20140 | Cycle 1(1): loaded http://localhost:39773/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39773/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:52:32 INFO - PROCESS | 20140 | RSS: Main: 201486336 11:52:32 INFO - PROCESS | 20140 | 11:52:33 INFO - PROCESS | 20140 | Cycle 1(1): loaded http://localhost:39773/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39773/tests/kraken/driver.html?testName=ai-astar) 11:52:34 INFO - PROCESS | 20140 | RSS: Main: 262017024 11:52:34 INFO - PROCESS | 20140 | 11:52:34 INFO - PROCESS | 20140 | __start_tp_report 11:52:34 INFO - PROCESS | 20140 | _x_x_mozilla_page_load 11:52:34 INFO - PROCESS | 20140 | _x_x_mozilla_page_load_details 11:52:34 INFO - PROCESS | 20140 | |i|pagename|runs| 11:52:34 INFO - PROCESS | 20140 | |0;ai-astar;112;111;106;111;110;111;99;111;110;111 11:52:34 INFO - PROCESS | 20140 | |1;audio-beat-detection;157;124;152;174;127;153;159;128;165;126 11:52:34 INFO - PROCESS | 20140 | |2;audio-dft;163;161;165;162;163;162;160;164;162;166 11:52:34 INFO - PROCESS | 20140 | |3;audio-fft;75;74;107;104;72;73;75;106;95;73 11:52:34 INFO - PROCESS | 20140 | |4;audio-oscillator;92;94;146;93;94;92;141;93;93;146 11:52:34 INFO - PROCESS | 20140 | |5;imaging-gaussian-blur;116;117;117;117;116;117;118;117;117;117 11:52:34 INFO - PROCESS | 20140 | |6;imaging-darkroom;145;147;145;146;145;146;145;146;147;146 11:52:34 INFO - PROCESS | 20140 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 11:52:34 INFO - PROCESS | 20140 | |8;json-parse-financial;57;57;57;56;54;57;55;70;63;56 11:52:34 INFO - PROCESS | 20140 | |9;json-stringify-tinderbox;60;60;61;60;60;60;61;61;61;61 11:52:34 INFO - PROCESS | 20140 | |10;stanford-crypto-aes;77;79;79;77;77;77;78;86;77;78 11:52:34 INFO - PROCESS | 20140 | |11;stanford-crypto-ccm;115;116;117;122;117;108;119;111;116;117 11:52:34 INFO - PROCESS | 20140 | |12;stanford-crypto-pbkdf2;147;150;148;144;144;139;143;140;146;152 11:52:34 INFO - PROCESS | 20140 | |13;stanford-crypto-sha256-iterative;64;65;64;66;63;65;63;65;65;64 11:52:34 INFO - PROCESS | 20140 | __end_tp_report 11:52:34 INFO - PROCESS | 20140 | __start_cc_report 11:52:34 INFO - PROCESS | 20140 | _x_x_mozilla_cycle_collect,1021 11:52:34 INFO - PROCESS | 20140 | __end_cc_report 11:52:34 INFO - PROCESS | 20140 | __startTimestamp1458240754034__endTimestamp 11:52:34 INFO - PROCESS | 20140 | 11:52:34 INFO - PROCESS | 20140 | ------- Summary: start ------- 11:52:34 INFO - PROCESS | 20140 | Number of tests: 14 11:52:34 INFO - PROCESS | 20140 | 11:52:34 INFO - PROCESS | 20140 | [#0] ai-astar Cycles:10 Average:109.20 Median:111.00 stddev:3.94 (3.5%) stddev-sans-first:4.04 11:52:34 INFO - PROCESS | 20140 | Values: 112.0 111.0 106.0 111.0 110.0 111.0 99.0 111.0 110.0 111.0 11:52:34 INFO - PROCESS | 20140 | 11:52:34 INFO - PROCESS | 20140 | [#1] audio-beat-detection Cycles:10 Average:146.50 Median:155.00 stddev:18.52 (11.9%) stddev-sans-first:19.25 11:52:34 INFO - PROCESS | 20140 | Values: 157.0 124.0 152.0 174.0 127.0 153.0 159.0 128.0 165.0 126.0 11:52:34 INFO - PROCESS | 20140 | 11:52:34 INFO - PROCESS | 20140 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:1.81 (1.1%) stddev-sans-first:1.92 11:52:34 INFO - PROCESS | 20140 | Values: 163.0 161.0 165.0 162.0 163.0 162.0 160.0 164.0 162.0 166.0 11:52:34 INFO - PROCESS | 20140 | 11:52:34 INFO - PROCESS | 20140 | [#3] audio-fft Cycles:10 Average:85.40 Median:73.50 stddev:15.50 (21.1%) stddev-sans-first:15.98 11:52:34 INFO - PROCESS | 20140 | Values: 75.0 74.0 107.0 104.0 72.0 73.0 75.0 106.0 95.0 73.0 11:52:34 INFO - PROCESS | 20140 | 11:52:34 INFO - PROCESS | 20140 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:93.00 stddev:24.84 (26.7%) stddev-sans-first:25.63 11:52:34 INFO - PROCESS | 20140 | Values: 92.0 94.0 146.0 93.0 94.0 92.0 141.0 93.0 93.0 146.0 11:52:34 INFO - PROCESS | 20140 | 11:52:34 INFO - PROCESS | 20140 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 11:52:34 INFO - PROCESS | 20140 | Values: 116.0 117.0 117.0 117.0 116.0 117.0 118.0 117.0 117.0 117.0 11:52:34 INFO - PROCESS | 20140 | 11:52:34 INFO - PROCESS | 20140 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 11:52:34 INFO - PROCESS | 20140 | Values: 145.0 147.0 145.0 146.0 145.0 146.0 145.0 146.0 147.0 146.0 11:52:34 INFO - PROCESS | 20140 | 11:52:34 INFO - PROCESS | 20140 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 11:52:34 INFO - PROCESS | 20140 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 11:52:34 INFO - PROCESS | 20140 | 11:52:34 INFO - PROCESS | 20140 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:57.00 stddev:4.78 (8.4%) stddev-sans-first:5.05 11:52:34 INFO - PROCESS | 20140 | Values: 57.0 57.0 57.0 56.0 54.0 57.0 55.0 70.0 63.0 56.0 11:52:34 INFO - PROCESS | 20140 | 11:52:34 INFO - PROCESS | 20140 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:61.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 11:52:34 INFO - PROCESS | 20140 | Values: 60.0 60.0 61.0 60.0 60.0 60.0 61.0 61.0 61.0 61.0 11:52:34 INFO - PROCESS | 20140 | 11:52:34 INFO - PROCESS | 20140 | [#10] stanford-crypto-aes Cycles:10 Average:78.50 Median:78.00 stddev:2.76 (3.5%) stddev-sans-first:2.87 11:52:34 INFO - PROCESS | 20140 | Values: 77.0 79.0 79.0 77.0 77.0 77.0 78.0 86.0 77.0 78.0 11:52:34 INFO - PROCESS | 20140 | 11:52:34 INFO - PROCESS | 20140 | [#11] stanford-crypto-ccm Cycles:10 Average:115.80 Median:117.00 stddev:3.91 (3.3%) stddev-sans-first:4.14 11:52:34 INFO - PROCESS | 20140 | Values: 115.0 116.0 117.0 122.0 117.0 108.0 119.0 111.0 116.0 117.0 11:52:34 INFO - PROCESS | 20140 | 11:52:34 INFO - PROCESS | 20140 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.30 Median:146.50 stddev:4.14 (2.8%) stddev-sans-first:4.34 11:52:34 INFO - PROCESS | 20140 | Values: 147.0 150.0 148.0 144.0 144.0 139.0 143.0 140.0 146.0 152.0 11:52:34 INFO - PROCESS | 20140 | 11:52:34 INFO - PROCESS | 20140 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:65.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 11:52:34 INFO - PROCESS | 20140 | Values: 64.0 65.0 64.0 66.0 63.0 65.0 63.0 65.0 65.0 64.0 11:52:34 INFO - PROCESS | 20140 | -------- Summary: end -------- 11:52:34 INFO - PROCESS | 20140 | 11:52:34 INFO - TEST-INFO | 20140: exit 0 11:52:35 INFO - TEST-OK | kraken | took 59867ms 11:52:35 INFO - SUITE-END | took 1170s 11:52:35 INFO - Completed test suite (00:19:30) 11:52:35 INFO - javascript benchmark 11:52:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3023.3046399328155, 3042.6500952390484, 3073.8616762245697, 3093.0720783764864, 3107.720305172534, 5050.949490505094, 5070.619703522232, 5173.844784656457, 5205.973970130144, 5229.163333866582, 5151.793928242875, 5170.121079416499, 5180.533751962323, 5181.715005674687, 5252.894942101156, 4605.055963527486, 4650.697704649187, 4752.07334569759, 4754.310624959378, 4796.47238803733, 4735.526447355272, 4736.597389221903, 4746.952530474703, 4792.664513484057, 4843.830465933693, 4556.0, 4635.096156249533, 4672.813087476497, 4673.485916549177, 4730.9763451182525, 4735.242361222188, 4744.833930812405, 4750.691205071659, 4769.260764581495, 4795.712257264575, 4616.215243408628, 4668.719876807402, 4709.505501922283, 4723.220668589679, 4747.715137091785, 5076.289319495274, 5090.898182036375, 5096.770645320969, 5120.257562653432, 5133.486651334874, 5492.780288788444, 5499.50504454597, 5499.50504454597, 5504.559635229172, 5542.889142217133, 5405.432429594875, 5525.972370138164, 5527.917081243784, 5554.166874968747, 5554.416786237427, 5209.6874187548865, 5221.921671174898, 5227.47725227478, 5228.8692782680355, 5252.028374750684, 5653.604247702621, 5669.149627555899, 5671.773129074873, 5673.120666296731, 5681.431856814285, 5352.170413585901, 5366.973165134149, 5368.91946620801, 5430.83707488776, 5433.809816656477, 5490.80782172622, 5539.723013849291, 5552.472515111058, 5556.777728890799, 5566.860828479321, 5540.9168862467095, 5545.085060964976, 5546.223528705985, 5547.33431988164, 5596.496315331639, 5396.163594642837, 5415.945840541544, 5436.293281873332, 5461.371942226615, 5469.15228139639, 4218.114196018871, 4249.192653395907, 4251.06476575153, 4251.936220956688, 4291.184674911757, 3735.7198210134347, 3768.811559422018, 3794.2221844521805, 3797.1646237827636, 3842.5965273646425, 5230.895382092337, 5242.659227150223, 5249.606279529051, 5296.841094767163, 5299.046171689133, 5525.060739674265, 5570.164475328733, 5576.0, 5587.888242235133, 5595.720213989284, 5079.771410286546, 5128.8717782055, 5237.502437268454, 5251.684898906002, 5252.501012403892, 4761.904761904742, 4764.737939413296, 4779.665423420327, 4801.135795556764, 4826.155422800995, 5685.800996965169, 5693.060644993612, 5693.658380497101, 5693.857653558694, 5740.167675687002, 5382.9192562112385, 5463.07127788269, 5510.393856675682, 5526.613137080366, 5533.584981126432, 5756.222909907109, 5757.827265181883, 5765.509931655689, 5775.566832487496, 5780.508656764222, 5423.972880135574, 5477.452254774491, 5482.424345443671, 5485.780568777363, 5486.780528778964, 5347.331583552056, 5527.088030475087, 5563.360213575329, 5603.299587551556, 5654.830355089354, 5478.397376288684, 5482.506574408322, 5484.808031718871, 5487.368952570346, 5488.451154884479, 5424.783008679608, 5437.755301011543, 5445.428230035947, 5451.945480545144, 5494.395616482264, 5236.450172731808, 5270.446603106619, 5275.314209152785, 5292.073887069824, 5327.653702509325, 5446.455354464521, 5453.372862120748, 5482.205080263419, 5487.122060470306, 5492.725363731877, 5235.450277720937, 5309.0, 5371.597130215171, 5372.516473517402, 5424.972875135599], "unit": "score", "name": "dojo.html", "value": 5107.349460683172}, {"lowerIsBetter": false, "replicates": [551.196547665751, 582.1994757208838, 584.2025635008214, 601.6480358989991, 619.8718332634604, 30864.69135308649, 31374.05877823663, 39694.60305396949, 39745.60254397455, 39927.802165935, 42504.78747606265, 42913.356299655454, 42953.0, 42968.0, 42987.0, 8604.225619694242, 8798.120187981183, 8800.911990880106, 8801.031886492481, 8807.031226565072, 8636.0, 8758.474491530496, 8763.430377025474, 8765.0, 8766.956165219197, 8975.057618950013, 9003.864942025875, 9031.819363612723, 9042.728718138467, 9052.140046695553, 8908.910910890905, 8937.687180948667, 9000.459972401677, 9003.5048072356, 9013.504257265848, 8761.912380876238, 8880.55597220143, 8891.911080889238, 8917.375783695144, 8921.241694455979, 41494.1701165978, 42056.36915446271, 42117.36823947643, 42129.789351053354, 42157.36763948513, 3540.168060505779, 3574.0528759878393, 3625.0605925829555, 3651.72612054097, 3744.7378683492166, 32220.677793222003, 32326.799460360235, 32673.346533069205, 32715.345693086005, 33125.0, 4003.819828107742, 4109.383592461125, 4110.897227569305, 4117.197146556423, 4148.751074935483, 252675.0, 253525.73237133882, 254247.0, 254417.0, 254825.0, 64979.0, 66164.0, 66671.66664166648, 66756.0, 67059.0, 64599.67700161469, 68069.0, 68502.3149768496, 71184.2881571188, 71416.285837142, 17025.829741702673, 17051.147442628066, 17051.72112091598, 17055.8913670611, 17185.39851105205, 13080.411381487856, 13220.933895330461, 13227.272500012592, 13229.140105893086, 13232.0, 18932.43202703921, 20770.896145519175, 21449.356519304445, 22107.889460552593, 22181.778182218295, 8147.551884646283, 8307.8338433231, 8374.748757537283, 8426.662933482714, 8448.112948140357, 932.5570354081757, 990.8266053440619, 994.751312171957, 1069.4545781651414, 1219.2257916223084, 30837.0, 31402.37195256082, 31791.841040795112, 32015.67984320127, 32356.35287294241, 1115.553778488611, 1146.6617347882395, 1149.574657376776, 1185.875483074282, 1234.6851552853964, 16808.495745127664, 16822.0, 16914.0, 16938.915305423394, 16949.49151525456, 387306.0, 390566.0, 391199.0, 391608.0, 391863.0, 55548.44451555433, 56995.71502142463, 57016.71491642515, 57097.14354284689, 57149.428505715245, 1223.8653748087704, 1383.0595195267115, 1384.5292600515672, 1399.5731301952799, 1419.070508816706, 29758.702412976458, 30308.54537181988, 30582.541261880644, 30745.464271608158, 31128.53307200439, 44584.55415445804, 45097.098058039315, 45294.77352613216, 45362.319565205886, 45404.318935215335, 206288.0, 210399.0, 212345.0, 212927.0, 226681.0, 30672.079837604906, 35076.473852891715, 35100.12249693778, 35125.0, 35736.821315894296, 41110.794446028776, 42055.0, 48533.27200092072, 49314.0, 50165.24752128648, 36490.0, 36753.71362002317, 37176.6282337184, 40058.39912401258, 40319.79840100898, 39012.80493597514, 39028.80485597554, 39579.0, 40101.1979760409, 40360.39459408053, 40215.597844021184, 40414.1917161661, 40611.593884061964, 40955.0, 41126.383104254055, 33412.83293583516, 34982.82508587441, 35176.0, 35747.0, 36132.27735445329, 27485.0, 27763.305917352227, 27864.442711146068, 28140.29649258703, 28170.15489535317], "unit": "score", "name": "ext.html", "value": 19468.33201125276}, {"lowerIsBetter": false, "replicates": [376.4973760030361, 378.757674826569, 381.1120090189857, 383.5914750790408, 384.571203108534, 17233.310667573296, 17752.023638699884, 19068.141933613002, 19562.21751129957, 19579.314723984662, 17531.0, 17876.910615446937, 18403.26386944524, 18430.26278948844, 18445.262189512403, 5465.398806131322, 5611.80358687446, 5634.549236061105, 5638.915416268759, 5645.463680950324, 4153.314703073989, 5569.0, 5955.3449120596915, 6166.537509686769, 6187.721552530147, 6193.102000209967, 6199.225096862892, 6200.472959798422, 6211.409916057967, 6215.81352559424, 5932.673702946337, 6053.757849686007, 6061.151438798572, 6064.666443345614, 6067.908981365283, 3775.4903088083033, 5238.266642670029, 5380.058489764276, 5391.757370918318, 5403.621746477748, 19510.219591216333, 20122.39632811018, 20220.19119235229, 20569.794302056936, 20630.5873882523, 2220.134147682405, 2273.8521996070367, 2302.792748652629, 2846.97508896797, 3063.7702172337163, 13223.73552528944, 13263.73472530544, 13277.468901244036, 13456.0, 13914.165150091027, 1960.7353007343968, 1971.310041485483, 1984.682450807864, 2014.738084049079, 2016.163292233736, 68589.31410685879, 69323.65338173327, 69789.3021069788, 71568.6421567894, 71987.64006179935, 10449.582016719398, 10529.0, 10689.83965240522, 10752.516136773864, 10841.0, 13974.510892118727, 14035.298235088205, 14048.929755351362, 14071.226082565558, 14083.929580352033, 8193.631286592117, 8407.663693452316, 8408.411411201158, 8499.745007649657, 8584.442011269248, 8344.457610255315, 8390.202930721573, 8407.789805254917, 8457.957710211533, 8514.276286515715, 6446.806595802133, 6540.444062254666, 6583.736650534021, 6584.374484424068, 6649.867002659919, 1733.1767410480172, 1804.4496428589407, 1807.1235450806348, 1828.2226276102303, 1847.6304739052243, 751.48523261566, 1013.9847902281472, 1083.2092572422018, 1083.3824719909733, 1116.7822274656364, 18325.266989320276, 18530.536736581424, 18531.536711582048, 18591.34930277434, 18852.717209241873, 1044.5143008500932, 1055.3140458701753, 1060.379677888444, 1079.7354648111263, 1119.6864877834219, 10883.727906802234, 11072.003519683267, 11079.5568177272, 11093.611723589636, 11101.222914396076, 471400.0, 474916.0, 475180.0, 478694.0, 489422.0, 65448.345516545174, 76753.0, 77497.61251193708, 77661.22338776653, 78441.0, 1070.6199299248965, 1086.581666058573, 1106.6292791914639, 1110.5724296146043, 1133.4672703829187, 16729.665406692042, 16736.079515626272, 16790.992540447125, 16805.91597042007, 16834.915825420794, 35783.0, 36018.09954751047, 36468.63531364759, 36614.8169259152, 37092.629073708915, 47401.28898066463, 47846.76076619595, 48056.27915581339, 48194.0, 48378.274325884435, 8205.917940820515, 8289.95855020721, 8309.127541608286, 8345.207205315486, 8353.832923341377, 11766.294022358687, 12099.57651482194, 12857.614271571867, 12918.612441626767, 13296.069275150647, 10983.560657573607, 11216.0, 11358.375289359165, 11871.762564748484, 11887.583934562248, 10588.788224235626, 10662.413567253876, 10884.45577721095, 10983.670489885317, 11280.548778048786, 11229.887701122883, 11589.304641721523, 11748.17762756633, 11756.0, 11908.34504102248, 8234.094249632415, 8282.58587070632, 8301.916980830356, 8312.168783121639, 8388.245057944814, 11373.54505819758, 11895.345755983504, 11898.524059037542, 11980.341081240615, 12013.939930300643], "unit": "score", "name": "jquery.html", "value": 9115.261186336269}, {"lowerIsBetter": false, "replicates": [1340.2963444191805, 1498.1161114942186, 1503.1957902522154, 1687.1564217891055, 1834.486343823729, 7436.107667079951, 7476.14024387195, 7484.0, 7484.96257518713, 7501.737439189623, 7269.600171990538, 7428.517146385481, 7481.289277518641, 7487.812804679886, 7499.512531685436, 2041.071312552785, 2272.397814579134, 2294.621387471065, 2320.535892821434, 2335.1009861203474, 2305.950792389467, 2323.035940084863, 2334.486412989148, 2335.824813139013, 2336.859788412692, 2276.169198242646, 2348.260298006131, 2349.4948586053997, 2350.4828937633692, 2357.693499845018, 2301.355620426283, 2321.419645088728, 2350.753170917046, 2358.174638876397, 2359.539889721505, 2321.9651705224437, 2324.4653729642278, 2341.8829058547003, 2365.219477572397, 2380.2859142257253, 7669.5398276103615, 7703.3452156566755, 7721.420893433015, 7732.884006739903, 7739.303462688329, 4798.232282834764, 4851.830185943475, 4890.853274401774, 4897.216445368724, 4907.558319751204, 3229.7739158258933, 3310.519974603669, 3342.2312868040485, 3382.441897086978, 3382.9323413531592, 1067.6370034188335, 1074.484247561175, 1075.6504136155781, 1088.2110469909333, 1099.082266307634, 10420.0, 10473.685789426254, 10523.526441310083, 10556.049955504042, 10571.471426428725, 4342.305231162999, 4350.60844523988, 4396.054848207651, 4434.667399944952, 4451.486494591854, 8990.865137022949, 9016.684416045407, 9058.54707264634, 9061.95469022664, 9086.273098152133, 4441.133978874089, 4938.950610493849, 4940.357753492023, 4941.43173535048, 4943.456219815817, 4454.28731402974, 4474.217012022883, 4487.282034874404, 4529.818807247739, 4540.545945405499, 3728.981355093207, 3816.31306364857, 3823.0824602095295, 3834.616538346199, 3860.324443222481, 1223.2110288863632, 1246.6010876519608, 1246.7007918099591, 1247.089624574066, 1253.9937300313622, 1385.736710025092, 1389.305347326337, 1407.5917983784589, 1420.4815242436437, 1425.2303755971866, 7255.056842610426, 7391.186969433358, 7405.481616286916, 7405.925940740523, 7412.1476030256135, 483.41265362583925, 486.3871521882383, 491.63864559548705, 495.74221404869985, 496.22588761532126, 5680.346760122557, 5686.9715651421475, 5699.515541178963, 5733.455321744427, 5757.280339957505, 8956.552172391355, 9364.110409511086, 9473.621055157855, 9474.573644186028, 9483.90516094844, 9259.490728010023, 9280.72157835266, 9355.485448300273, 9377.624895004259, 9415.576299066559, 7079.115110611174, 7266.96366518164, 7268.309510596485, 7280.053593032978, 7401.111866575938, 6911.827204319932, 6914.412274956484, 6960.338767817049, 6968.303169682991, 6993.825154371181, 7815.6092195388865, 8021.919780802117, 8036.357091432788, 8170.346372290322, 8211.0, 8204.0, 8260.132686067876, 8370.455920365157, 8415.53714545706, 8417.032041315328, 6181.876362472815, 6267.655278959701, 6691.364320389555, 6919.654017299215, 7187.029750983759, 7280.708771649075, 7296.087989001375, 7313.744018959311, 7322.157951835394, 7328.0, 6534.0, 6708.530402871752, 6717.798466046026, 6783.660816959231, 6800.319968003358, 6511.9348806511325, 6582.868342633024, 6589.505787066085, 6622.10601568782, 6658.866822663616, 6778.932210678027, 6819.420349270367, 6844.691988860413, 6872.45020398357, 6877.9656101721175, 6325.399087086719, 6444.0, 6461.224653041665, 6463.870722585428, 6466.127072845105, 6495.0906873036865, 6508.381703738138, 6516.315786842503, 6516.57642253252, 6526.5105117117355], "unit": "score", "name": "mootools.html", "value": 4426.749962472896}, {"lowerIsBetter": false, "replicates": [340.3805074763929, 343.3236524047626, 346.321210427562, 347.2499401293207, 353.56334926365935, 5940.7326670299835, 5942.732577034033, 5965.492933100686, 5973.372795856438, 6029.668368239745, 5922.733476993535, 5952.761889524414, 5958.5828991970575, 5965.850853728659, 5968.10478428236, 4384.0, 4449.0, 4499.61753250974, 4531.0258294466685, 4582.633389328846, 4569.657275704319, 4570.314452832068, 4580.0, 4598.057398233354, 4604.263317869141, 4524.592786649201, 4533.546645335473, 4536.637069034469, 4542.273236282195, 4555.63554915606, 4356.237658409766, 4438.511763705974, 4473.038296766211, 4487.12501062293, 4519.502854685982, 3975.4434379186646, 3998.10042740384, 4003.15933653933, 4005.379166229239, 4009.959900400988, 5703.08750599902, 5742.97128514359, 5744.368119506851, 5750.166225897264, 5754.251947246873, 5330.413654498041, 5339.919901201485, 5341.786328546854, 5343.064963631349, 5345.33183352081, 6271.027990661455, 6277.246730392382, 6284.340144284875, 6284.968575157141, 6287.779927702554, 4301.698881078326, 4431.645468362555, 4437.667174961891, 4492.07912377965, 4493.326001099828, 6573.441257493118, 6618.073469714244, 6630.038644396584, 6642.202935647753, 6649.069130321759, 4510.616597589242, 4514.525974772601, 4514.6388288936805, 4515.164694531522, 4515.277555591089, 4562.908741825145, 4567.885802854888, 4571.017231295287, 4576.0161565263625, 4576.496585375606, 5283.577313814885, 5290.127129023745, 5296.549793267538, 5300.469953004746, 5300.814471493479, 6225.750969961241, 6315.778947736807, 6367.42693157618, 6380.489560835122, 6380.649064301415, 1543.1512668032537, 1558.4155941521929, 1567.7334853075004, 1573.5122112145273, 1577.1798664694295, 1000.4397537379091, 1034.4414016431194, 1056.4559251985233, 1073.2809017957986, 1077.2513103393223, 5960.344362120163, 5974.1934838796205, 6030.517558595389, 6068.75724971005, 6074.878502429927, 6480.287168411471, 6484.935150648527, 6486.772962946275, 6487.7080531376205, 6506.902396464056, 6068.33248342682, 6068.393160683984, 6068.757249709962, 6078.392160783975, 6078.848028799227, 3463.8441270142903, 3499.6675315844955, 3500.8599656013985, 3501.7548771585743, 3511.2626348467106, 6596.241432235259, 6694.297098804653, 6739.764108256188, 6750.696218670171, 6759.831004224835, 6561.639109849004, 6564.6389448580785, 6592.340765923465, 6598.274189839114, 6602.537822352485, 6711.6979735912, 6733.0, 6763.932360676428, 6813.182418109858, 6818.420434263044, 6473.352664733489, 6475.190601174853, 6478.222613286436, 6480.773172938924, 6490.156279683611, 6276.744651069713, 6388.616682999035, 6401.615903045832, 6496.408379946944, 6502.284748677547, 6823.38589526945, 6843.589384636938, 6847.520673552804, 6851.143607049119, 6859.862802744017, 4481.215787237155, 4523.231050721451, 4530.184566778012, 4530.70550414222, 4534.888952206598, 6524.9673751630935, 6550.934490655032, 6551.377619126175, 6554.132072359545, 6561.934380656132, 6178.382161783786, 6327.367263273636, 6374.936250637435, 6383.5531512795515, 6400.0, 6247.687615619292, 6274.372562743872, 6283.7800676976085, 6284.183056202664, 6288.434040936338, 6190.350013248724, 6199.442050215503, 6200.596961197508, 6286.52851036165, 6291.874162516816, 6411.647359395278, 6414.102025716496, 6421.646809425526, 6422.100905873275, 6425.453836423956, 5934.762609495745, 6070.423309785563, 6139.907901381573, 6259.687015649109, 6267.749290028531], "unit": "score", "name": "prototype.html", "value": 4770.444629125773}, {"lowerIsBetter": false, "replicates": [717.8636059148762, 820.6061090676471, 829.3572481326971, 836.7238811192307, 858.523519446707, 14230.43078276869, 14468.710625787478, 14491.637709057279, 14504.404515503285, 14522.782158267635, 14328.64178395538, 14448.638784030405, 14464.566063018126, 14477.348519316629, 14480.855191448083, 691.0291041087255, 826.4875777018242, 835.0772396501869, 837.5560952695081, 838.4047326398264, 834.6744769539854, 847.525385783963, 849.3757088539918, 850.8085680721819, 851.3529717414748, 885.0, 888.8000199955023, 889.3463304471209, 889.5063239901851, 890.679355432044, 708.1290013283639, 865.9826803463895, 881.8104107616894, 882.32942963348, 885.154677283193, 642.4346575014005, 643.7328508668896, 644.3878315600152, 645.7223393940603, 646.7865604350553, 13778.65553361164, 13849.099808512414, 13849.307534623229, 13858.722825543533, 13867.23730194839, 13203.339833008407, 13763.793543096861, 14044.36800343987, 14050.36773345202, 14228.573142805732, 11375.203735738502, 11529.884701153049, 11620.410566549834, 11769.293842369485, 11886.881131188664, 3780.7353485256044, 3799.9620003799882, 3811.9809400953095, 3845.692344612424, 3937.4881265435597, 50549.24176137361, 50614.24078638823, 50905.74547127241, 51072.233916491285, 51191.23213151806, 10077.360648451051, 10422.947885260677, 10673.946630266799, 10707.196960228013, 10723.517441715141, 18710.158042888103, 18796.154173062245, 18800.811991879906, 18803.623927521647, 18812.435626931216, 7929.484583502054, 7940.28537431634, 8013.719519816778, 8265.0, 8355.665773369119, 4673.088747694167, 4681.882952926136, 4753.952460475421, 4779.139754844162, 4835.927461088087, 3284.4088064148204, 3299.6205436374644, 3299.785513941586, 3304.553885225464, 3307.5038744188564, 598.7455331484102, 618.0759764152531, 630.4483576870239, 632.9367063293726, 633.24959922492, 579.7874441942225, 605.5004621187538, 679.823245956055, 755.5731011978324, 768.8851165809486, 9601.423914565148, 9708.417494950325, 9813.901860981441, 9934.304598678167, 9962.203023758082, 691.6991108867659, 706.1737766812842, 748.098541257783, 751.8383547537305, 773.7175930785223, 4866.829660961849, 4884.658073934862, 4889.975550122226, 4894.461609222983, 4943.8022479101155, 60828.69585652132, 62808.69443500214, 63220.68389658114, 66220.0, 66465.6676716623, 56338.154927676114, 56495.0, 56768.71615641978, 57494.42505574974, 58211.126833097536, 48683.0, 48825.75587122042, 52399.21401178985, 52704.0, 53770.46229537733, 9695.9030409695, 10021.699349019542, 10058.14505767018, 10073.194144468278, 10184.0, 36832.631673683994, 37827.0, 38120.428193577674, 38997.0, 39994.800025999684, 44482.0, 45774.31338529858, 46759.53240467552, 46786.29820552626, 46864.297035543816, 11916.165868389477, 11956.521739130338, 11962.700932476757, 12091.395430228278, 12225.816612750994, 13277.468901244229, 13759.10565813219, 13907.235102069484, 14085.366158523097, 14257.28713564297, 12639.213410127179, 12702.68243293888, 12829.166104203197, 12984.870151298366, 13038.934805325913, 12474.5010199591, 12583.496660133858, 12592.937035314764, 13053.934730326288, 13253.13854599448, 12355.25868447896, 12496.0, 12832.165909215872, 12863.421146048637, 12983.415746291628, 10393.532291047073, 10509.369437833755, 10665.680029599125, 10691.30506517074, 11356.886431135583, 10250.333728307636, 10514.204094588124, 10626.901401426487, 10949.781004380027, 11287.0], "unit": "score", "name": "yui.html", "value": 6849.789847884383}], "name": "dromaeo_css", "value": 7127.590574334746}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 111.0, 106.0, 111.0, 110.0, 111.0, 99.0, 111.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.2}, {"lowerIsBetter": true, "replicates": [157.0, 124.0, 152.0, 174.0, 127.0, 153.0, 159.0, 128.0, 165.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 146.5}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 165.0, 162.0, 163.0, 162.0, 160.0, 164.0, 162.0, 166.0], "unit": "score", "name": "audio-dft", "value": 162.8}, {"lowerIsBetter": true, "replicates": [75.0, 74.0, 107.0, 104.0, 72.0, 73.0, 75.0, 106.0, 95.0, 73.0], "unit": "score", "name": "audio-fft", "value": 85.4}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 146.0, 93.0, 94.0, 92.0, 141.0, 93.0, 93.0, 146.0], "unit": "score", "name": "audio-oscillator", "value": 108.4}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 118.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [145.0, 147.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 57.0, 56.0, 54.0, 57.0, 55.0, 70.0, 63.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.2}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 61.0, 60.0, 60.0, 60.0, 61.0, 61.0, 61.0, 61.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 60.5}, {"lowerIsBetter": true, "replicates": [77.0, 79.0, 79.0, 77.0, 77.0, 77.0, 78.0, 86.0, 77.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.5}, {"lowerIsBetter": true, "replicates": [115.0, 116.0, 117.0, 122.0, 117.0, 108.0, 119.0, 111.0, 116.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.8}, {"lowerIsBetter": true, "replicates": [147.0, 150.0, 148.0, 144.0, 144.0, 139.0, 143.0, 140.0, 146.0, 152.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.3}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 66.0, 63.0, 65.0, 63.0, 65.0, 65.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 64.4}], "name": "kraken", "value": 1492.7}]} 11:52:35 INFO - Return code: 0 11:52:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:52:35 ERROR - # TBPL SUCCESS # 11:52:35 INFO - Running post-action listener: _resource_record_post_action 11:52:35 INFO - Running post-run listener: _resource_record_post_run 11:52:36 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 537198592; Read time: 0; Write time: 437260 11:52:36 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 242696192; Read time: 0; Write time: 236344 11:52:36 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 294502400; Read time: 0; Write time: 200916 11:52:36 INFO - Running post-run listener: _upload_blobber_files 11:52:36 INFO - Blob upload gear active. 11:52:36 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:52:36 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 11:52:36 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'] 11:52:36 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 11:52:36 INFO - (blobuploader) - INFO - Open directory for files ... 11:52:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 11:52:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:52:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:37 INFO - (blobuploader) - INFO - Done attempting. 11:52:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:52:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:52:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:38 INFO - (blobuploader) - INFO - Done attempting. 11:52:38 INFO - (blobuploader) - INFO - Iteration through files over. 11:52:38 INFO - Return code: 0 11:52:38 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:52:38 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:52:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a537ea7dce50ef2a8bd57019ac9d75566e1db0e0b5e6571a96f8f49fae779af8d3cb6212591246c116cd3a23cf1493eca6ddf0b02912b731a95a41ff6dc4d59d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/244cdcc7b6eaab543f3868fd8cc54d63090c6fca1d85688ad363ff3451d056d0120471bf8e584804c4878a616e3a8cf1770b2b30907f9ae8af27913b5e543d94"} 11:52:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:52:38 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:52:38 INFO - Contents: 11:52:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a537ea7dce50ef2a8bd57019ac9d75566e1db0e0b5e6571a96f8f49fae779af8d3cb6212591246c116cd3a23cf1493eca6ddf0b02912b731a95a41ff6dc4d59d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/244cdcc7b6eaab543f3868fd8cc54d63090c6fca1d85688ad363ff3451d056d0120471bf8e584804c4878a616e3a8cf1770b2b30907f9ae8af27913b5e543d94"} 11:52:38 INFO - Running post-run listener: copy_logs_to_upload_dir 11:52:38 INFO - Copying logs to upload dir... 11:52:38 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 11:52:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.685731 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-03-17 11:52:38.365053) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-17 11:52:38.368655) ========= 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=836cfdc75598d54cb747368e000001a9-1458239529.393178-1658050876 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/a537ea7dce50ef2a8bd57019ac9d75566e1db0e0b5e6571a96f8f49fae779af8d3cb6212591246c116cd3a23cf1493eca6ddf0b02912b731a95a41ff6dc4d59d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/244cdcc7b6eaab543f3868fd8cc54d63090c6fca1d85688ad363ff3451d056d0120471bf8e584804c4878a616e3a8cf1770b2b30907f9ae8af27913b5e543d94"} build_url:https://queue.taskcluster.net/v1/task/ZPfR0fZhQgiaEuI0ey0yYg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011438 build_url: 'https://queue.taskcluster.net/v1/task/ZPfR0fZhQgiaEuI0ey0yYg/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/a537ea7dce50ef2a8bd57019ac9d75566e1db0e0b5e6571a96f8f49fae779af8d3cb6212591246c116cd3a23cf1493eca6ddf0b02912b731a95a41ff6dc4d59d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/244cdcc7b6eaab543f3868fd8cc54d63090c6fca1d85688ad363ff3451d056d0120471bf8e584804c4878a616e3a8cf1770b2b30907f9ae8af27913b5e543d94"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-17 11:52:38.396618) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 11:52:38.396950) ========= 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=836cfdc75598d54cb747368e000001a9-1458239529.393178-1658050876 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004582 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 11:52:38.484850) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-17 11:52:38.485694) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-17 11:52:38.486019) ========= ========= Total master_lag: 0.28 =========