builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-065 starttime: 1459842971.31 results: success (0) buildid: 20160404223142 builduid: cbe05f5bb67a4835827fb86e02b837c1 revision: d7d928b340e56d95fd962146f21c8beb5e1aa663 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 00:56:11.305376) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 00:56:11.305940) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 00:56:11.306228) ========= 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=523ca41ca1e0623de333ad52000001bf-1459841213.711893-1840384910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006351 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 00:56:11.350543) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 00:56:11.350842) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 00:56:11.424237) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 00:56:11.424482) ========= 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=523ca41ca1e0623de333ad52000001bf-1459841213.711893-1840384910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004553 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 00:56:11.492641) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 00:56:11.492910) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 00:56:11.493264) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 00:56:11.493542) ========= 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=523ca41ca1e0623de333ad52000001bf-1459841213.711893-1840384910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-05 00:56:12-- 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% 223M=0s 2016-04-05 00:56:12 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.155901 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 00:56:11.662911) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 00:56:11.663189) ========= 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=523ca41ca1e0623de333ad52000001bf-1459841213.711893-1840384910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018501 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 00:56:11.714346) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 00:56:11.714663) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d7d928b340e56d95fd962146f21c8beb5e1aa663 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d7d928b340e56d95fd962146f21c8beb5e1aa663 --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=523ca41ca1e0623de333ad52000001bf-1459841213.711893-1840384910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-05 00:56:12,388 truncating revision to first 12 chars 2016-04-05 00:56:12,388 Setting DEBUG logging. 2016-04-05 00:56:12,388 attempt 1/10 2016-04-05 00:56:12,388 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d7d928b340e5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-05 00:56:12,784 unpacking tar archive at: mozilla-inbound-d7d928b340e5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.666432 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 00:56:12.394741) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 00:56:12.395056) ========= echo d7d928b340e56d95fd962146f21c8beb5e1aa663 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd7d928b340e56d95fd962146f21c8beb5e1aa663'] 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=523ca41ca1e0623de333ad52000001bf-1459841213.711893-1840384910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False d7d928b340e56d95fd962146f21c8beb5e1aa663 program finished with exit code 0 elapsedTime=0.003862 script_repo_revision: 'd7d928b340e56d95fd962146f21c8beb5e1aa663' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 00:56:12.443337) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 00:56:12.443662) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 00:56:12.454902) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-04-05 00:56:12.455176) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=523ca41ca1e0623de333ad52000001bf-1459841213.711893-1840384910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:56:13 INFO - MultiFileLogger online at 20160405 00:56:13 in /builds/slave/test-pgo 00:56:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 00:56:13 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 00:56:13 INFO - {'append_to_log': False, 00:56:13 INFO - 'base_work_dir': '/builds/slave/test-pgo', 00:56:13 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 00:56:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 00:56:13 INFO - 'branch': 'Mozilla-Inbound', 00:56:13 INFO - 'buildbot_json_path': 'buildprops.json', 00:56:13 INFO - 'config_files': ('talos/linux_config.py',), 00:56:13 INFO - 'default_actions': ('clobber', 00:56:13 INFO - 'read-buildbot-config', 00:56:13 INFO - 'download-and-extract', 00:56:13 INFO - 'populate-webroot', 00:56:13 INFO - 'create-virtualenv', 00:56:13 INFO - 'install', 00:56:13 INFO - 'run-tests'), 00:56:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:56:13 INFO - 'download_minidump_stackwalk': True, 00:56:13 INFO - 'download_symbols': 'ondemand', 00:56:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:56:13 INFO - 'tooltool.py': '/tools/tooltool.py', 00:56:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:56:13 INFO - '/tools/misc-python/virtualenv.py')}, 00:56:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:56:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:56:13 INFO - 'installer_path': 'installer.exe', 00:56:13 INFO - 'log_level': 'info', 00:56:13 INFO - 'log_name': 'talos', 00:56:13 INFO - 'log_to_console': True, 00:56:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:56:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:56:13 INFO - 'opt_config_files': (), 00:56:13 INFO - 'pip_index': False, 00:56:13 INFO - 'sps_profile': False, 00:56:13 INFO - 'sps_profile_interval': 0, 00:56:13 INFO - 'suite': 'dromaeojs', 00:56:13 INFO - 'system_bits': '32', 00:56:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:56:13 INFO - 'title': 'talos-linux64-ix-065', 00:56:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:56:13 INFO - 'use_talos_json': True, 00:56:13 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 00:56:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:56:13 INFO - 'work_dir': 'build'} 00:56:13 INFO - ##### 00:56:13 INFO - ##### Running clobber step. 00:56:13 INFO - ##### 00:56:13 INFO - Running pre-action listener: _resource_record_pre_action 00:56:13 INFO - Running main action method: clobber 00:56:13 INFO - rmtree: /builds/slave/test-pgo/build 00:56:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 00:56:13 INFO - Running post-action listener: _resource_record_post_action 00:56:13 INFO - ##### 00:56:13 INFO - ##### Running read-buildbot-config step. 00:56:13 INFO - ##### 00:56:13 INFO - Running pre-action listener: _resource_record_pre_action 00:56:13 INFO - Running main action method: read_buildbot_config 00:56:13 INFO - Using buildbot properties: 00:56:13 INFO - { 00:56:13 INFO - "project": "", 00:56:13 INFO - "product": "firefox", 00:56:13 INFO - "script_repo_revision": "production", 00:56:13 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 00:56:13 INFO - "repository": "", 00:56:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 00:56:13 INFO - "buildid": "20160404223142", 00:56:13 INFO - "pgo_build": "True", 00:56:13 INFO - "basedir": "/builds/slave/test-pgo", 00:56:13 INFO - "buildnumber": 1674, 00:56:13 INFO - "slavename": "talos-linux64-ix-065", 00:56:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:56:13 INFO - "platform": "ubuntu64_hw", 00:56:13 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 00:56:13 INFO - "branch": "mozilla-inbound", 00:56:13 INFO - "repo_path": "integration/mozilla-inbound", 00:56:13 INFO - "revision": "d7d928b340e56d95fd962146f21c8beb5e1aa663", 00:56:13 INFO - "stage_platform": "linux64-pgo", 00:56:13 INFO - "builduid": "cbe05f5bb67a4835827fb86e02b837c1", 00:56:13 INFO - "slavebuilddir": "test" 00:56:13 INFO - } 00:56:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/DTyoRwFJScmX9eyhRpvN2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 00:56:13 INFO - Running post-action listener: _resource_record_post_action 00:56:13 INFO - ##### 00:56:13 INFO - ##### Running download-and-extract step. 00:56:13 INFO - ##### 00:56:13 INFO - Running pre-action listener: _resource_record_pre_action 00:56:13 INFO - Running main action method: download_and_extract 00:56:13 INFO - mkdir: /builds/slave/test-pgo/build/tests 00:56: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')]} 00:56:13 INFO - https://queue.taskcluster.net/v1/task/DTyoRwFJScmX9eyhRpvN2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 00:56:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTyoRwFJScmX9eyhRpvN2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 00:56:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTyoRwFJScmX9eyhRpvN2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 00:56:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTyoRwFJScmX9eyhRpvN2w/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 00:56:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTyoRwFJScmX9eyhRpvN2w/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 00:56:16 INFO - Downloaded 1361 bytes. 00:56:16 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 00:56:16 INFO - Using the following test package requirements: 00:56:16 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 00:56:16 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:56:16 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:56:16 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:16 INFO - u'jsshell-linux-x86_64.zip'], 00:56:16 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:56:16 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 00:56:16 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:56:16 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:56:16 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:56:16 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:56:16 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:56:16 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')]} 00:56:16 INFO - https://queue.taskcluster.net/v1/task/DTyoRwFJScmX9eyhRpvN2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:56:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTyoRwFJScmX9eyhRpvN2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 00:56:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTyoRwFJScmX9eyhRpvN2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 00:56:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTyoRwFJScmX9eyhRpvN2w/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 00:56:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTyoRwFJScmX9eyhRpvN2w/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 00:56:18 INFO - Downloaded 23696178 bytes. 00:56:18 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'] 00:56:18 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 00:56:19 INFO - Return code: 0 00:56:19 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 00:56: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')]} 00:56:19 INFO - https://queue.taskcluster.net/v1/task/DTyoRwFJScmX9eyhRpvN2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:56:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTyoRwFJScmX9eyhRpvN2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 00:56:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTyoRwFJScmX9eyhRpvN2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 00:56:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTyoRwFJScmX9eyhRpvN2w/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 00:56:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTyoRwFJScmX9eyhRpvN2w/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 00:56:27 INFO - Downloaded 23696178 bytes. 00:56:27 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'] 00:56:27 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 00:56:29 INFO - Return code: 0 00:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:29 INFO - https://queue.taskcluster.net/v1/task/DTyoRwFJScmX9eyhRpvN2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:56:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTyoRwFJScmX9eyhRpvN2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 00:56:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTyoRwFJScmX9eyhRpvN2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 00:56:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTyoRwFJScmX9eyhRpvN2w/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 00:56:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTyoRwFJScmX9eyhRpvN2w/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 00:56:30 INFO - Downloaded 10847617 bytes. 00:56:30 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'] 00:56:30 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 00:56:30 INFO - Return code: 0 00:56:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:30 INFO - https://queue.taskcluster.net/v1/task/DTyoRwFJScmX9eyhRpvN2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:56:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTyoRwFJScmX9eyhRpvN2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 00:56:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTyoRwFJScmX9eyhRpvN2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 00:56:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTyoRwFJScmX9eyhRpvN2w/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 00:56:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTyoRwFJScmX9eyhRpvN2w/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 00:56:32 INFO - Downloaded 57690813 bytes. 00:56:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DTyoRwFJScmX9eyhRpvN2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 00:56:32 INFO - mkdir: /builds/slave/test-pgo/properties 00:56:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 00:56:32 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 00:56:32 INFO - Contents: 00:56:32 INFO - build_url:https://queue.taskcluster.net/v1/task/DTyoRwFJScmX9eyhRpvN2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 00:56:33 INFO - Running post-action listener: _resource_record_post_action 00:56:33 INFO - Running post-action listener: set_extra_try_arguments 00:56:33 INFO - ##### 00:56:33 INFO - ##### Running populate-webroot step. 00:56:33 INFO - ##### 00:56:33 INFO - Running pre-action listener: _resource_record_pre_action 00:56:33 INFO - Running main action method: populate_webroot 00:56:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:56:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:56:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:56:33 INFO - '--tppagecycles', 00:56:33 INFO - '7'], 00:56:33 INFO - 'tests': ['tsvgm']}}, 00:56:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:56:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:56:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:56:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:56:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:56:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:56:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:56:33 INFO - 'talos_options': ['--disable-e10s'], 00:56:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:56:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:56:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:56:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:56:33 INFO - 'talos_options': ['--disable-e10s'], 00:56:33 INFO - 'tests': ['damp', 'tps']}, 00:56:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:56:33 INFO - 'tests': ['damp', 'tps']}, 00:56:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:56:33 INFO - 'tests': ['dromaeo_dom']}, 00:56:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:56:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:56:33 INFO - 'tests': ['a11yr', 00:56:33 INFO - 'ts_paint', 00:56:33 INFO - 'tpaint', 00:56:33 INFO - 'sessionrestore', 00:56:33 INFO - 'sessionrestore_no_auto_restore', 00:56:33 INFO - 'tabpaint']}, 00:56:33 INFO - 'other-e10s': {'tests': ['a11yr', 00:56:33 INFO - 'ts_paint', 00:56:33 INFO - 'tpaint', 00:56:33 INFO - 'sessionrestore', 00:56:33 INFO - 'sessionrestore_no_auto_restore', 00:56:33 INFO - 'tabpaint']}, 00:56:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:56:33 INFO - 'ts_paint', 00:56:33 INFO - 'tpaint', 00:56:33 INFO - 'sessionrestore', 00:56:33 INFO - 'sessionrestore_no_auto_restore', 00:56:33 INFO - 'tabpaint']}, 00:56:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:56:33 INFO - 'ts_paint', 00:56:33 INFO - 'tpaint', 00:56:33 INFO - 'sessionrestore', 00:56:33 INFO - 'sessionrestore_no_auto_restore', 00:56:33 INFO - 'tabpaint']}, 00:56:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:56:33 INFO - 'tests': ['a11yr', 00:56:33 INFO - 'ts_paint', 00:56:33 INFO - 'tpaint', 00:56:33 INFO - 'sessionrestore', 00:56:33 INFO - 'sessionrestore_no_auto_restore', 00:56:33 INFO - 'tabpaint']}, 00:56:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:56:33 INFO - 'tests': ['a11yr', 00:56:33 INFO - 'ts_paint', 00:56:33 INFO - 'tpaint', 00:56:33 INFO - 'sessionrestore', 00:56:33 INFO - 'sessionrestore_no_auto_restore', 00:56:33 INFO - 'tabpaint']}, 00:56:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:56:33 INFO - 'tests': ['tsvgx', 00:56:33 INFO - 'tsvgr_opacity', 00:56:33 INFO - 'tart', 00:56:33 INFO - 'tscrollx', 00:56:33 INFO - 'cart']}, 00:56:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:56:33 INFO - 'tsvgr_opacity', 00:56:33 INFO - 'tart', 00:56:33 INFO - 'tscrollx', 00:56:33 INFO - 'cart']}, 00:56:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:56:33 INFO - 'talos_options': ['--disable-e10s'], 00:56:33 INFO - 'tests': ['tp5o']}, 00:56:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:56:33 INFO - 'tests': ['tp5o']}, 00:56:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:56:33 INFO - 'talos_options': ['--disable-e10s', 00:56:33 INFO - '--xperf_path', 00:56:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:56:33 INFO - 'tests': ['tp5n']}, 00:56:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:56:33 INFO - 'talos_options': ['--xperf_path', 00:56:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:56:33 INFO - 'tests': ['tp5n']}}, 00:56:33 INFO - 'talos.zip': {'path': '', 00:56:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:56:33 INFO - Running post-action listener: _resource_record_post_action 00:56:33 INFO - ##### 00:56:33 INFO - ##### Running create-virtualenv step. 00:56:33 INFO - ##### 00:56:33 INFO - Running pre-action listener: _resource_record_pre_action 00:56:33 INFO - Running main action method: create_virtualenv 00:56:33 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 00:56:33 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 00:56:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 00:56:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:56:33 INFO - Using real prefix '/usr' 00:56:33 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 00:56:33 INFO - Installing distribute.............................................................................................................................................................................................done. 00:56:35 INFO - Installing pip.................done. 00:56:35 INFO - Return code: 0 00:56:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 00:56:35 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')]} 00:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:35 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')]} 00:56:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:35 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 0x7fca5f05bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d88d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24678b0>, '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 0x24687b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2468c60>, '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': '523ca41ca1e0623de333ad52000001bf-1459841213.711893-1840384910', '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 00:56:35 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 00:56:35 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 00:56:35 INFO - Using env: {'DISPLAY': ':0', 00:56:35 INFO - 'HOME': '/home/cltbld', 00:56:35 INFO - 'LANG': 'en_US.UTF-8', 00:56:35 INFO - 'LANGUAGE': 'en_US:en', 00:56:35 INFO - 'LOGNAME': 'cltbld', 00:56:35 INFO - 'MAIL': '/var/mail/cltbld', 00:56:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:35 INFO - 'MOZ_NO_REMOTE': '1', 00:56:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:35 INFO - 'NO_EM_RESTART': '1', 00:56:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:56:35 INFO - 'PWD': '/builds/slave/test-pgo', 00:56:35 INFO - 'SHELL': '/bin/bash', 00:56:35 INFO - 'SHLVL': '1', 00:56:35 INFO - 'TERM': 'linux', 00:56:35 INFO - 'TMOUT': '86400', 00:56:35 INFO - 'USER': 'cltbld', 00:56:35 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1459841213.711893-1840384910', 00:56:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:35 INFO - '_': '/tools/buildbot/bin/python'} 00:56:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:36 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 00:56:36 INFO - Cleaning up... 00:56:36 INFO - Return code: 0 00:56:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 00:56: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')]} 00:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56: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')]} 00:56:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fca5f05bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d88d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24678b0>, '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 0x24687b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2468c60>, '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': '523ca41ca1e0623de333ad52000001bf-1459841213.711893-1840384910', '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 00:56:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 00:56:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 00:56:36 INFO - Using env: {'DISPLAY': ':0', 00:56:36 INFO - 'HOME': '/home/cltbld', 00:56:36 INFO - 'LANG': 'en_US.UTF-8', 00:56:36 INFO - 'LANGUAGE': 'en_US:en', 00:56:36 INFO - 'LOGNAME': 'cltbld', 00:56:36 INFO - 'MAIL': '/var/mail/cltbld', 00:56:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:36 INFO - 'MOZ_NO_REMOTE': '1', 00:56:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:36 INFO - 'NO_EM_RESTART': '1', 00:56:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:56:36 INFO - 'PWD': '/builds/slave/test-pgo', 00:56:36 INFO - 'SHELL': '/bin/bash', 00:56:36 INFO - 'SHLVL': '1', 00:56:36 INFO - 'TERM': 'linux', 00:56:36 INFO - 'TMOUT': '86400', 00:56:36 INFO - 'USER': 'cltbld', 00:56:36 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1459841213.711893-1840384910', 00:56:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:36 INFO - '_': '/tools/buildbot/bin/python'} 00:56:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:36 INFO - Downloading/unpacking psutil>=0.7.1 00:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 00:56:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:56:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:56:38 INFO - Installing collected packages: psutil 00:56:38 INFO - Running setup.py install for psutil 00:56:38 INFO - building 'psutil._psutil_linux' extension 00:56:38 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 00:56:38 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 00:56:38 INFO - building 'psutil._psutil_posix' extension 00:56:38 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 00:56:38 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 00:56:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:56:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:56:38 INFO - Successfully installed psutil 00:56:38 INFO - Cleaning up... 00:56:38 INFO - Return code: 0 00:56:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 00:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:38 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 0x7fca5f05bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d88d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24678b0>, '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 0x24687b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2468c60>, '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': '523ca41ca1e0623de333ad52000001bf-1459841213.711893-1840384910', '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 00:56:38 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 00:56:38 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 00:56:38 INFO - Using env: {'DISPLAY': ':0', 00:56:38 INFO - 'HOME': '/home/cltbld', 00:56:38 INFO - 'LANG': 'en_US.UTF-8', 00:56:38 INFO - 'LANGUAGE': 'en_US:en', 00:56:38 INFO - 'LOGNAME': 'cltbld', 00:56:38 INFO - 'MAIL': '/var/mail/cltbld', 00:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:38 INFO - 'MOZ_NO_REMOTE': '1', 00:56:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:38 INFO - 'NO_EM_RESTART': '1', 00:56:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:56:38 INFO - 'PWD': '/builds/slave/test-pgo', 00:56:38 INFO - 'SHELL': '/bin/bash', 00:56:38 INFO - 'SHLVL': '1', 00:56:38 INFO - 'TERM': 'linux', 00:56:38 INFO - 'TMOUT': '86400', 00:56:38 INFO - 'USER': 'cltbld', 00:56:38 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1459841213.711893-1840384910', 00:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:38 INFO - '_': '/tools/buildbot/bin/python'} 00:56:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:56:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:56:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:56:40 INFO - Installing collected packages: mozsystemmonitor 00:56:40 INFO - Running setup.py install for mozsystemmonitor 00:56:41 INFO - Successfully installed mozsystemmonitor 00:56:41 INFO - Cleaning up... 00:56:41 INFO - Return code: 0 00:56:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 00:56:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:41 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 0x7fca5f05bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d88d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24678b0>, '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 0x24687b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2468c60>, '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': '523ca41ca1e0623de333ad52000001bf-1459841213.711893-1840384910', '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 00:56:41 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 00:56:41 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 00:56:41 INFO - Using env: {'DISPLAY': ':0', 00:56:41 INFO - 'HOME': '/home/cltbld', 00:56:41 INFO - 'LANG': 'en_US.UTF-8', 00:56:41 INFO - 'LANGUAGE': 'en_US:en', 00:56:41 INFO - 'LOGNAME': 'cltbld', 00:56:41 INFO - 'MAIL': '/var/mail/cltbld', 00:56:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:41 INFO - 'MOZ_NO_REMOTE': '1', 00:56:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:41 INFO - 'NO_EM_RESTART': '1', 00:56:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:56:41 INFO - 'PWD': '/builds/slave/test-pgo', 00:56:41 INFO - 'SHELL': '/bin/bash', 00:56:41 INFO - 'SHLVL': '1', 00:56:41 INFO - 'TERM': 'linux', 00:56:41 INFO - 'TMOUT': '86400', 00:56:41 INFO - 'USER': 'cltbld', 00:56:41 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1459841213.711893-1840384910', 00:56:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:41 INFO - '_': '/tools/buildbot/bin/python'} 00:56:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:41 INFO - Downloading/unpacking blobuploader==1.2.4 00:56: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 00:56: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 00:56: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 00:56: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 00:56: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 00:56: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 00:56:43 INFO - Downloading blobuploader-1.2.4.tar.gz 00:56:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:56:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:56: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 00:56: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 00:56: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 00:56: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 00:56: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 00:56: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 00:56:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 00:56:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:56: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 00:56: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 00:56: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 00:56: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 00:56: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 00:56: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 00:56:43 INFO - Downloading docopt-0.6.1.tar.gz 00:56:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 00:56:43 INFO - Installing collected packages: blobuploader, requests, docopt 00:56:43 INFO - Running setup.py install for blobuploader 00:56:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:56:44 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 00:56:44 INFO - Running setup.py install for requests 00:56:44 INFO - Running setup.py install for docopt 00:56:44 INFO - Successfully installed blobuploader requests docopt 00:56:44 INFO - Cleaning up... 00:56:44 INFO - Return code: 0 00:56:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:44 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 0x7fca5f05bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d88d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24678b0>, '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 0x24687b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2468c60>, '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': '523ca41ca1e0623de333ad52000001bf-1459841213.711893-1840384910', '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 00:56:44 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 00:56:44 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 00:56:44 INFO - Using env: {'DISPLAY': ':0', 00:56:44 INFO - 'HOME': '/home/cltbld', 00:56:44 INFO - 'LANG': 'en_US.UTF-8', 00:56:44 INFO - 'LANGUAGE': 'en_US:en', 00:56:44 INFO - 'LOGNAME': 'cltbld', 00:56:44 INFO - 'MAIL': '/var/mail/cltbld', 00:56:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:44 INFO - 'MOZ_NO_REMOTE': '1', 00:56:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:44 INFO - 'NO_EM_RESTART': '1', 00:56:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:56:44 INFO - 'PWD': '/builds/slave/test-pgo', 00:56:44 INFO - 'SHELL': '/bin/bash', 00:56:44 INFO - 'SHLVL': '1', 00:56:44 INFO - 'TERM': 'linux', 00:56:44 INFO - 'TMOUT': '86400', 00:56:44 INFO - 'USER': 'cltbld', 00:56:44 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1459841213.711893-1840384910', 00:56:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:44 INFO - '_': '/tools/buildbot/bin/python'} 00:56:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:56:44 INFO - Running setup.py (path:/tmp/pip-GfTNGt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:56:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:56:44 INFO - Running setup.py (path:/tmp/pip-q8aLUA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:56:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:56:44 INFO - Running setup.py (path:/tmp/pip-LtKp7C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:56:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:56:44 INFO - Running setup.py (path:/tmp/pip-em3tuf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:56:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:56:45 INFO - Running setup.py (path:/tmp/pip-nzYuvZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:56:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:56:45 INFO - Running setup.py (path:/tmp/pip-Ua6WQI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:56:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:56:45 INFO - Running setup.py (path:/tmp/pip-ixaXQc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:56:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:56:45 INFO - Running setup.py (path:/tmp/pip-cTdsRE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:56:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:56:45 INFO - Running setup.py (path:/tmp/pip-jUPNfB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:56:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:56:45 INFO - Running setup.py (path:/tmp/pip-Sa0H3A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:56:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:56:45 INFO - Running setup.py (path:/tmp/pip-0nJT1E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:56:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:56:45 INFO - Running setup.py (path:/tmp/pip-Jm6qN5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:56:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:56:45 INFO - Running setup.py (path:/tmp/pip-Vg6uig-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:56:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:56:45 INFO - Running setup.py (path:/tmp/pip-8EdFeL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:56:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:56:45 INFO - Running setup.py (path:/tmp/pip-fl4qby-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:56:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:56:45 INFO - Running setup.py (path:/tmp/pip-xPl9t9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:56:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:56:45 INFO - Running setup.py (path:/tmp/pip-_krvY4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:56:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:56:45 INFO - Running setup.py install for manifestparser 00:56:46 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 00:56:46 INFO - Running setup.py install for mozcrash 00:56:46 INFO - Running setup.py install for mozdebug 00:56:46 INFO - Running setup.py install for mozdevice 00:56:46 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 00:56:46 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 00:56:46 INFO - Running setup.py install for mozfile 00:56:46 INFO - Running setup.py install for mozhttpd 00:56:46 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 00:56:46 INFO - Running setup.py install for mozinfo 00:56:46 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 00:56:46 INFO - Running setup.py install for mozInstall 00:56:46 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 00:56:46 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 00:56:46 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 00:56:46 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 00:56:46 INFO - Running setup.py install for mozleak 00:56:46 INFO - Running setup.py install for mozlog 00:56:46 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 00:56:47 INFO - Running setup.py install for moznetwork 00:56:47 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 00:56:47 INFO - Running setup.py install for mozprocess 00:56:47 INFO - Running setup.py install for mozprofile 00:56:47 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 00:56:47 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 00:56:47 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 00:56:47 INFO - Running setup.py install for mozrunner 00:56:47 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 00:56:47 INFO - Running setup.py install for mozscreenshot 00:56:47 INFO - Running setup.py install for moztest 00:56:47 INFO - Running setup.py install for mozversion 00:56:47 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 00:56:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:56:47 INFO - Cleaning up... 00:56:47 INFO - Return code: 0 00:56:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:56:47 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')]} 00:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:47 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')]} 00:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:47 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 0x7fca5f05bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d88d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24678b0>, '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 0x24687b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2468c60>, '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': '523ca41ca1e0623de333ad52000001bf-1459841213.711893-1840384910', '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 00:56:47 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 00:56:47 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 00:56:47 INFO - Using env: {'DISPLAY': ':0', 00:56:47 INFO - 'HOME': '/home/cltbld', 00:56:47 INFO - 'LANG': 'en_US.UTF-8', 00:56:47 INFO - 'LANGUAGE': 'en_US:en', 00:56:47 INFO - 'LOGNAME': 'cltbld', 00:56:47 INFO - 'MAIL': '/var/mail/cltbld', 00:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:47 INFO - 'MOZ_NO_REMOTE': '1', 00:56:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:47 INFO - 'NO_EM_RESTART': '1', 00:56:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:56:47 INFO - 'PWD': '/builds/slave/test-pgo', 00:56:47 INFO - 'SHELL': '/bin/bash', 00:56:47 INFO - 'SHLVL': '1', 00:56:47 INFO - 'TERM': 'linux', 00:56:47 INFO - 'TMOUT': '86400', 00:56:47 INFO - 'USER': 'cltbld', 00:56:47 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1459841213.711893-1840384910', 00:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:47 INFO - '_': '/tools/buildbot/bin/python'} 00:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:56:47 INFO - Running setup.py (path:/tmp/pip-S2brGE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:56:48 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)) 00:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:56:48 INFO - Running setup.py (path:/tmp/pip-SrqkSg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:56:48 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)) 00:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:56:48 INFO - Running setup.py (path:/tmp/pip-MeRhzO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:56:48 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)) 00:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:56:48 INFO - Running setup.py (path:/tmp/pip-Fzaftt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:56:48 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)) 00:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:56:48 INFO - Running setup.py (path:/tmp/pip-3po3px-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:56:48 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)) 00:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:56:48 INFO - Running setup.py (path:/tmp/pip-g8RUfV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:56:48 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)) 00:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:56:48 INFO - Running setup.py (path:/tmp/pip-18jJLs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:56:48 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)) 00:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:56:48 INFO - Running setup.py (path:/tmp/pip-KFbSLe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:56:48 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)) 00:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:56:48 INFO - Running setup.py (path:/tmp/pip-qy8Wpa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:56:48 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)) 00:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:56:48 INFO - Running setup.py (path:/tmp/pip-JftzjJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:56:48 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)) 00:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:56:48 INFO - Running setup.py (path:/tmp/pip-V71eol-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:56:48 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)) 00:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:56:48 INFO - Running setup.py (path:/tmp/pip-eKd2lv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:56:48 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)) 00:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:56:48 INFO - Running setup.py (path:/tmp/pip-HV8IUG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:56:48 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)) 00:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:56:48 INFO - Running setup.py (path:/tmp/pip-O3lnSM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:56:48 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)) 00:56:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:56:48 INFO - Running setup.py (path:/tmp/pip-cm6D7C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:56:49 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)) 00:56:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:56:49 INFO - Running setup.py (path:/tmp/pip-UMAorU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:56:49 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)) 00:56:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:56:49 INFO - Running setup.py (path:/tmp/pip-bHptOd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:56:49 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)) 00:56:49 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)) 00:56:49 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)) 00:56:49 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)) 00:56:49 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)) 00:56:49 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)) 00:56:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 00:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:51 INFO - Downloading blessings-1.6.tar.gz 00:56:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 00:56:51 INFO - Installing collected packages: blessings 00:56:51 INFO - Running setup.py install for blessings 00:56:51 INFO - Successfully installed blessings 00:56:51 INFO - Cleaning up... 00:56:51 INFO - Return code: 0 00:56:51 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 00:56:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:56:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:56:51 INFO - Reading from file tmpfile_stdout 00:56:51 INFO - Current package versions: 00:56:51 INFO - argparse == 1.2.1 00:56:51 INFO - blessings == 1.6 00:56:51 INFO - blobuploader == 1.2.4 00:56:51 INFO - docopt == 0.6.1 00:56:51 INFO - manifestparser == 1.1 00:56:51 INFO - mozInstall == 1.12 00:56:51 INFO - mozcrash == 0.17 00:56:51 INFO - mozdebug == 0.1 00:56:51 INFO - mozdevice == 0.48 00:56:51 INFO - mozfile == 1.2 00:56:51 INFO - mozhttpd == 0.7 00:56:51 INFO - mozinfo == 0.9 00:56:51 INFO - mozleak == 0.1 00:56:51 INFO - mozlog == 3.1 00:56:51 INFO - moznetwork == 0.27 00:56:51 INFO - mozprocess == 0.22 00:56:51 INFO - mozprofile == 0.28 00:56:51 INFO - mozrunner == 6.11 00:56:51 INFO - mozscreenshot == 0.1 00:56:51 INFO - mozsystemmonitor == 0.0 00:56:51 INFO - moztest == 0.7 00:56:51 INFO - mozversion == 1.4 00:56:51 INFO - psutil == 3.1.1 00:56:51 INFO - requests == 1.2.3 00:56:51 INFO - wsgiref == 0.1.2 00:56:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:51 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 0x7fca5f05bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d88d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24678b0>, '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 0x24687b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2468c60>, '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': '523ca41ca1e0623de333ad52000001bf-1459841213.711893-1840384910', '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 00:56:51 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 00:56:51 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 00:56:51 INFO - Using env: {'DISPLAY': ':0', 00:56:51 INFO - 'HOME': '/home/cltbld', 00:56:51 INFO - 'LANG': 'en_US.UTF-8', 00:56:51 INFO - 'LANGUAGE': 'en_US:en', 00:56:51 INFO - 'LOGNAME': 'cltbld', 00:56:51 INFO - 'MAIL': '/var/mail/cltbld', 00:56:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:51 INFO - 'MOZ_NO_REMOTE': '1', 00:56:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:51 INFO - 'NO_EM_RESTART': '1', 00:56:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:56:51 INFO - 'PWD': '/builds/slave/test-pgo', 00:56:51 INFO - 'SHELL': '/bin/bash', 00:56:51 INFO - 'SHLVL': '1', 00:56:51 INFO - 'TERM': 'linux', 00:56:51 INFO - 'TMOUT': '86400', 00:56:51 INFO - 'USER': 'cltbld', 00:56:51 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1459841213.711893-1840384910', 00:56:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:51 INFO - '_': '/tools/buildbot/bin/python'} 00:56:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:51 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)) 00:56:51 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)) 00:56:51 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)) 00:56:51 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)) 00:56:51 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)) 00:56:51 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)) 00:56:51 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)) 00:56:51 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)) 00:56:51 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)) 00:56:51 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)) 00:56:51 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)) 00:56:51 INFO - Cleaning up... 00:56:51 INFO - Return code: 0 00:56:51 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 00:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca5f05bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d88d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24678b0>, '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 0x24687b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2468c60>, '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': '523ca41ca1e0623de333ad52000001bf-1459841213.711893-1840384910', '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 00:56:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 00:56:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:56:51 INFO - Using env: {'DISPLAY': ':0', 00:56:51 INFO - 'HOME': '/home/cltbld', 00:56:51 INFO - 'LANG': 'en_US.UTF-8', 00:56:51 INFO - 'LANGUAGE': 'en_US:en', 00:56:51 INFO - 'LOGNAME': 'cltbld', 00:56:51 INFO - 'MAIL': '/var/mail/cltbld', 00:56:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:51 INFO - 'MOZ_NO_REMOTE': '1', 00:56:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:51 INFO - 'NO_EM_RESTART': '1', 00:56:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:56:51 INFO - 'PWD': '/builds/slave/test-pgo', 00:56:51 INFO - 'SHELL': '/bin/bash', 00:56:51 INFO - 'SHLVL': '1', 00:56:51 INFO - 'TERM': 'linux', 00:56:51 INFO - 'TMOUT': '86400', 00:56:51 INFO - 'USER': 'cltbld', 00:56:51 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1459841213.711893-1840384910', 00:56:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:51 INFO - '_': '/tools/buildbot/bin/python'} 00:56:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:51 INFO - Downloading/unpacking jsonschema 00:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:56:53 INFO - Downloading/unpacking functools32 (from jsonschema) 00:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:54 INFO - Downloading functools32-3.2.3-2.tar.gz 00:56:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 00:56:54 INFO - warning: no files found matching '*.txt' 00:56:54 INFO - no previously-included directories found matching 'build' 00:56:54 INFO - no previously-included directories found matching 'dist' 00:56:54 INFO - no previously-included directories found matching '.git*' 00:56:54 INFO - Installing collected packages: jsonschema, functools32 00:56:54 INFO - Running setup.py install for functools32 00:56:54 INFO - warning: no files found matching '*.txt' 00:56:54 INFO - no previously-included directories found matching 'build' 00:56:54 INFO - no previously-included directories found matching 'dist' 00:56:54 INFO - no previously-included directories found matching '.git*' 00:56:54 INFO - Successfully installed jsonschema functools32 00:56:54 INFO - Cleaning up... 00:56:54 INFO - Return code: 0 00:56:54 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 00:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca5f05bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d88d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24678b0>, '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 0x24687b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2468c60>, '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': '523ca41ca1e0623de333ad52000001bf-1459841213.711893-1840384910', '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 00:56:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 00:56:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 00:56:54 INFO - Using env: {'DISPLAY': ':0', 00:56:54 INFO - 'HOME': '/home/cltbld', 00:56:54 INFO - 'LANG': 'en_US.UTF-8', 00:56:54 INFO - 'LANGUAGE': 'en_US:en', 00:56:54 INFO - 'LOGNAME': 'cltbld', 00:56:54 INFO - 'MAIL': '/var/mail/cltbld', 00:56:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:54 INFO - 'MOZ_NO_REMOTE': '1', 00:56:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:54 INFO - 'NO_EM_RESTART': '1', 00:56:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:56:54 INFO - 'PWD': '/builds/slave/test-pgo', 00:56:54 INFO - 'SHELL': '/bin/bash', 00:56:54 INFO - 'SHLVL': '1', 00:56:54 INFO - 'TERM': 'linux', 00:56:54 INFO - 'TMOUT': '86400', 00:56:54 INFO - 'USER': 'cltbld', 00:56:54 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1459841213.711893-1840384910', 00:56:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:54 INFO - '_': '/tools/buildbot/bin/python'} 00:56:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:54 INFO - Downloading/unpacking flake8 00:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:56:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:56:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 00:56:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:56:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:56:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:56:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:56:57 INFO - no previously-included directories found matching 'docs/_build' 00:56:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:56:57 INFO - Running setup.py install for pep8 00:56:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:56:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:56:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:56:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:56:57 INFO - no previously-included directories found matching 'docs/_build' 00:56:57 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 00:56:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:56:57 INFO - Cleaning up... 00:56:57 INFO - Return code: 0 00:56:57 INFO - Running post-action listener: _resource_record_post_action 00:56:57 INFO - Running post-action listener: _start_resource_monitoring 00:56:57 INFO - Starting resource monitoring. 00:56:57 INFO - ##### 00:56:57 INFO - ##### Running install step. 00:56:57 INFO - ##### 00:56:57 INFO - Running pre-action listener: _resource_record_pre_action 00:56:57 INFO - Running main action method: install 00:56:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:56:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:56:57 INFO - Reading from file tmpfile_stdout 00:56:57 INFO - Detecting whether we're running mozinstall >=1.0... 00:56:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 00:56:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 00:56:57 INFO - Reading from file tmpfile_stdout 00:56:57 INFO - Output received: 00:56:57 INFO - Usage: mozinstall [options] installer 00:56:57 INFO - Options: 00:56:57 INFO - -h, --help show this help message and exit 00:56:57 INFO - -d DEST, --destination=DEST 00:56:57 INFO - Directory to install application into. [default: 00:56:57 INFO - "/builds/slave/test-pgo"] 00:56:57 INFO - --app=APP Application being installed. [default: firefox] 00:56:57 INFO - mkdir: /builds/slave/test-pgo/build/application 00:56:57 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'] 00:56:57 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 00:57:14 INFO - Reading from file tmpfile_stdout 00:57:14 INFO - Output received: 00:57:14 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 00:57:14 INFO - Running post-action listener: _resource_record_post_action 00:57:14 INFO - ##### 00:57:14 INFO - ##### Running run-tests step. 00:57:14 INFO - ##### 00:57:14 INFO - Running pre-action listener: _resource_record_pre_action 00:57:14 INFO - Running main action method: run_tests 00:57:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 00:57:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 00:57:14 INFO - Python 2.7.3 00:57:14 INFO - Return code: 0 00:57:14 INFO - grabbing minidump binary from tooltool 00:57:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:57:14 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 0x24678b0>, '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 0x24687b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2468c60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 00:57:14 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 00:57:14 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 00:57:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:57:14 INFO - Return code: 0 00:57:14 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 00:57:14 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 00:57:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 00:57:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 00:57:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 00:57:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 00:57:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 00:57:15 INFO - Return code: 0 00:57:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DTyoRwFJScmX9eyhRpvN2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 00:57:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DTyoRwFJScmX9eyhRpvN2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 00:57:15 INFO - Using env: {'DISPLAY': ':0', 00:57:15 INFO - 'HOME': '/home/cltbld', 00:57:15 INFO - 'LANG': 'en_US.UTF-8', 00:57:15 INFO - 'LANGUAGE': 'en_US:en', 00:57:15 INFO - 'LOGNAME': 'cltbld', 00:57:15 INFO - 'MAIL': '/var/mail/cltbld', 00:57:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:57:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 00:57:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:57:15 INFO - 'MOZ_NO_REMOTE': '1', 00:57:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:57:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:57:15 INFO - 'NO_EM_RESTART': '1', 00:57:15 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:57:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:57:15 INFO - 'PWD': '/builds/slave/test-pgo', 00:57:15 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 00:57:15 INFO - 'SHELL': '/bin/bash', 00:57:15 INFO - 'SHLVL': '1', 00:57:15 INFO - 'TERM': 'linux', 00:57:15 INFO - 'TMOUT': '86400', 00:57:15 INFO - 'USER': 'cltbld', 00:57:15 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1459841213.711893-1840384910', 00:57:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:57:15 INFO - '_': '/tools/buildbot/bin/python'} 00:57:15 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DTyoRwFJScmX9eyhRpvN2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 00:57:15 INFO - mozversion application_buildid: 20160404223142 00:57:15 INFO - mozversion application_changeset: d7d928b340e56d95fd962146f21c8beb5e1aa663 00:57:15 INFO - mozversion application_display_name: Nightly 00:57:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:57:15 INFO - mozversion application_name: Firefox 00:57:15 INFO - mozversion application_remotingname: firefox 00:57:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 00:57:15 INFO - mozversion application_vendor: Mozilla 00:57:15 INFO - mozversion application_version: 48.0a1 00:57:15 INFO - mozversion platform_buildid: 20160404223142 00:57:15 INFO - mozversion platform_changeset: d7d928b340e56d95fd962146f21c8beb5e1aa663 00:57:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 00:57:15 INFO - mozversion platform_version: 48.0a1 00:57:15 INFO - using testdate: 1459843035 00:57:15 INFO - actual date: 1459843035 00:57:15 INFO - starting webserver on 'localhost:59544' 00:57:15 INFO - SUITE-START | Running 2 tests 00:57:15 INFO - TEST-START | dromaeo_css 00:57:15 INFO - operating with platform_type : linux_ 00:57:15 INFO - Initialising browser for dromaeo_css test... 00:57:15 INFO - TEST-INFO | started process 11902 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpstqEU_/profile http://localhost:59544/getInfo.html) 00:57:19 INFO - PROCESS | 11902 | __metrics Screen width/height:1600/1200 00:57:19 INFO - PROCESS | 11902 | colorDepth:24 00:57:19 INFO - PROCESS | 11902 | Browser inner width/height: 1024/697 00:57:19 INFO - PROCESS | 11902 | __metrics 00:57:20 ERROR - PROCESS | 11902 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 00:57:21 INFO - TEST-INFO | 11902: exit 0 00:57:21 INFO - Browser initialized. 00:57:21 INFO - Running cycle 1/1 for dromaeo_css test... 00:57:21 INFO - TEST-INFO | started process 11983 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpstqEU_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:57:32 INFO - PROCESS | 11983 | RSS: Main: 152158208 00:57:32 INFO - PROCESS | 11983 | 00:58:24 INFO - PROCESS | 11983 | 1459843104514 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] 01:00:30 INFO - PROCESS | 11983 | Cycle 1(1): loaded http://localhost:59544/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59544/tests/dromaeo/cssquery-ext.html) 01:00:31 INFO - PROCESS | 11983 | RSS: Main: 256954368 01:00:31 INFO - PROCESS | 11983 | 01:03:33 INFO - PROCESS | 11983 | Cycle 1(1): loaded http://localhost:59544/tests/dromaeo/cssquery-ext.html (next: http://localhost:59544/tests/dromaeo/cssquery-jquery.html) 01:03:34 INFO - PROCESS | 11983 | RSS: Main: 231989248 01:03:34 INFO - PROCESS | 11983 | 01:06:36 INFO - PROCESS | 11983 | Cycle 1(1): loaded http://localhost:59544/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59544/tests/dromaeo/cssquery-mootools.html) 01:06:36 INFO - PROCESS | 11983 | RSS: Main: 223113216 01:06:36 INFO - PROCESS | 11983 | 01:09:38 INFO - PROCESS | 11983 | Cycle 1(1): loaded http://localhost:59544/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59544/tests/dromaeo/cssquery-prototype.html) 01:09:39 INFO - PROCESS | 11983 | RSS: Main: 218714112 01:09:39 INFO - PROCESS | 11983 | 01:12:41 INFO - PROCESS | 11983 | Cycle 1(1): loaded http://localhost:59544/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59544/tests/dromaeo/cssquery-yui.html) 01:12:42 INFO - PROCESS | 11983 | RSS: Main: 220807168 01:12:42 INFO - PROCESS | 11983 | 01:15:44 INFO - PROCESS | 11983 | Cycle 1(1): loaded http://localhost:59544/tests/dromaeo/cssquery-yui.html (next: http://localhost:59544/tests/dromaeo/cssquery-dojo.html) 01:15:44 INFO - PROCESS | 11983 | RSS: Main: 273305600 01:15:44 INFO - PROCESS | 11983 | 01:15:44 INFO - PROCESS | 11983 | __start_tp_report 01:15:44 INFO - PROCESS | 11983 | _x_x_mozilla_page_load 01:15:44 INFO - PROCESS | 11983 | _x_x_mozilla_page_load_details 01:15:44 INFO - PROCESS | 11983 | |i|pagename|runs| 01:15:44 INFO - PROCESS | 11983 | |0;dojo.html;3065.693430656934;3106.5184896341048;3136.200268931422;3143.764217683673;3170.5244213368;5121.078205922932;5134.537891589756;5282.709450980195;5316.680999140054;5340.145576707728;5155.639105262633;5231.267622532839;5233.816816411427;5234.528892399693;5236.083685355066;4695.741734204617;4713.175194340985;4753.90492190156;4771.117343291485;4804.639652026094;4655.86032419028;4760.357351757503;4788.11419887322;4808.447028591721;4813.061453016663;4694.812207511695;4718.764061796896;4723.36234608327;4737.3604563384015;4753.691010084333;4778.904421911577;4780.259059845729;4784.354112194878;4797.592204662608;4844.2975768513725;4671.416072990876;4751.83368582098;4758.286257061469;4792.041591681677;4831.0820944020525;5207.583393328525;5235.895282094375;5239.502247286502;5261.0793111205385;5268.446813084647;5662.207290979266;5669.0646043402785;5675.347335056439;5675.971620141873;5686.971565142189;5555.972220138914;5741.540676745892;5792.507636850873;5806.854828629276;5812.215350927655;5304.6286759926825;5330.600204984642;5333.866653333697;5334.333208348957;5335.839924802262;5796.971015144982;5817.941820581825;5819.88360232793;5822.737976791054;5828.038373668382;5488.945110548923;5498.340199176045;5518.44815518453;5553.111502159635;5570.248016517799;5664.433556644302;5685.090385538294;5686.545076393879;5688.857778555569;5693.772249109989;5521.00621888064;5648.491635752802;5663.348714897757;5664.85837854057;5666.121751128581;5699.373068962494;5730.627509211888;5737.426257374229;5739.8852022960145;5776.075827867521;4273.423087883159;4302.182585308781;4304.935425968613;4305.07440900208;4342.32693932441;3816.3512202925567;3841.5582208045876;3849.095462566295;3857.672097871712;3873.8837834865;5200.089984252816;5220.190870415092;5227;5273.920891186635;5301.363836339587;5636.943630563642;5642.943570564324;5645.9717701412055;5648.576356773258;5657;5224.843254702365;5305.469453054741;5305.814296499604;5330.546903513167;5364.7317634118135;4947.752612369439;4949.455559888409;4951.851444456672;4959.776810043557;4997.675151115166;5910.615809972338;5920.141579470953;5925.881482370329;5927.555433342516;5928.140419639129;5626.987142314259;5640.802571909963;5678.14827775837;5730.054541000688;5771.134329850556;5921.082232254007;5923.703814809329;5934.109883517507;5955.315138758925;5955.880882382415;5615.803446879339;5616.494515493625;5618.634788738719;5618.747156378055;5620.494155526022;5467.6719396836315;5657.2079908811975;5701.7434215461235;5712.143178523254;5758.366579676149;5602.075657516464;5608.242887210337;5612.607117501736;5615.522680572034;5619.072852979212;5536.612437129363;5571.303587051619;5573.7213139343685;5588.469095435927;5590.580706446952;5294.97352513235;5454.699991500505;5480.945190548203;5510.311211098613;5538.252335934597;5537.031019571639;5579.107342825128;5590.273264475592;5590.329160500766;5592.496675299242;5349.304590403222;5462.508374246337;5501.477359650827;5503.862403439786;5538.806141785019 01:15:44 INFO - PROCESS | 11983 | |1;ext.html;558.023458946843;562.9887402251952;567.6820980251057;574.7040274258757;585.4292065236396;31549.526757098633;39320.80339598305;39402.8029859851;39605.60394396055;39656.20687586247;43406.13187736244;43451.56548434515;43861.12277754443;43878.561214387846;43966.780166099205;7840.607969601526;8673.60968756406;8850.778730531756;8863.468191908507;10204.591816327338;9809;10394.792104157912;10398.532066057007;10403.37579745214;10405.895941040568;10384.117350025257;10452.790944181112;10468.842967355497;10469.424181670005;10470.42412667303;10343.431111288875;10433.895661043369;10435.426051567161;10438.530266138005;10452.425116618659;10257;10742.3017503862;10745.355278683304;10746.623868164656;10760.515776789985;42800.78599606982;43117.56882431167;43128.568714313085;43156.78421607903;43173;3489.5638045244345;3573.4997100405963;3589.910252243689;3626.963730362689;3724.1062145085257;32512.349753004808;32957.50563741546;33048.834755826305;33140;33616.49575256373;4198.979005104986;4203.201391735591;4219.2405367033925;4302.698811083225;4392.516823149451;331603;336182;336336;337756;339069.99999999756;48093.27860082102;48257;65782.34217657858;67238.32761672419;67522.66238668874;48294.27558586624;48520;48521.177458705184;48585.75707121513;48646;16247.431339903047;16423.932444391077;16424.425145119865;16439.424620138478;16440.177991100398;12995.675108122372;13042.087053906136;13077.476900924046;13081.803772943413;13098;16119.113448760196;16487;16532;16557.751633725504;16558.586035349213;5948.970255148696;6099.420555047263;6169.383061693885;6203.8138855834395;6225.564210505221;997.4240699694466;1016.9491525423699;1073.3667136389568;1097.6871591596357;1108.3405373802575;29718.702812972027;29884.252893677833;30398.088057358316;30514.69485305163;30792.846035770126;1001.7746007148334;1130.6601677012766;1136.971575710614;1145.7536629624672;1146.2492067695673;13727.503863602215;13809.240491772847;14331.856681433052;14441.277936103153;14710.705785884222;400022;402533;405411;406749;407306;57672.13491797626;58689.70655146697;58693.70653146707;58760;58778.412215877295;1283.1467074395423;1317.8748018938377;1341.7048249385314;1363.740889231043;1365.9112157709717;26567.33581660474;26579.7342026585;27018.324541885824;27191.72808271892;27569;42566.574334256264;42646.78676606597;42974;42983.570164297955;43080;256095;261977;262053;262693;263039;35080.12299692426;35101.47347789836;35940.28119437649;36066.8196659015;36094.278114438086;44330.77834610806;44525.33212001758;44676.32985505285;45489.54510454853;45869.54130458653;37610.6238937618;37806.62193378141;37847.621523785514;37946.810265948494;38092.2381552373;36700;37216.44175337318;37819.432708508844;38010.809945950095;38208.42687359748;38120;38307.808460957516;38695.6130438692;38997;39714.40428393634;32884.233267760654;33773.83113084419;33969;34095.82952085224;34177.65822341745;26551.734482654927;27118.322041949108;27193.59209611818;27211;27641 01:15:44 INFO - PROCESS | 11983 | |2;jquery.html;363.58732838228605;364.26055108130504;369.23936690417736;373.9682127019203;378.94505296731955;17757.378491752792;17990.820091799094;18232;18337.358192463267;18353.449396518125;17535.2109155088;18098.457046288633;18678.906605466953;18808.905955470203;18828.811711882878;5580.246666700004;5722.656640601556;5741.167530708045;5742.7415766290615;5747.798827041054;4190.078182799779;5629.915551266734;5990.520758339322;6224.906626400608;6241.21984751906;6196.318404975449;6204.193454850885;6217.626942383449;6231.189945307104;6231.439170474657;6030.96984515079;6116.877662446748;6207.255129384457;6210.968945155268;6211.068339749028;3763.209725957552;5258.474152584749;5414.7834086636485;5421.593380496439;5459.508644221999;20917.5816483671;21163.894180528998;21275.787242127535;22099.668504972436;22135.778642213532;2565.999260288489;2634.894604215848;2857.4856525825553;2860.184847318504;3112.0197137901714;13915.23466209358;13984.580462586138;13986.720265594733;14075.577732668036;14655.70688586233;1856.6008308213663;1879.8966056866866;1885.3966730646198;1893.3184053740642;1908.0745838268429;68939.65530172367;70666.29333706648;70958;71068.2893171072;72499.63750181215;9755.609775609038;10124.848127278097;10129.797404051878;10255.58977640901;10285.125764309967;12418.627441176779;12441.37793110359;12466.252024878537;12876.034297427543;12938;8000.679972801139;8275;8278.668853245923;8289.626966786509;8352.331813454908;7097.716091356391;7145.92854071463;7152.642367881585;7391.371733402721;8291.378146639026;6012;6193.628382297076;6196.1635179251125;6287.937120628735;6307.463865571478;1683.3519095148456;1732.0773940925562;1775.5117342730593;1785.8392744653045;1811.7191835265555;1032.99483502582;1038.039813172812;1096.4079397125463;1113.7828123515837;1117.3128675371242;17765.911170444324;18185;18258.54353641143;18473.076346182635;18877.52806179829;1017.6234793126442;1034.5396298647029;1063.2238465919922;1081.5889961814617;1095.0418383914075;10547.472626368652;10643.574257029786;10742.140628749681;10754.300970436896;10770.24608277413;505066;506513;514248;525640;533501;73529;74449;74750.62624686841;76139;76141;1057.1701214546545;1074.3339129739454;1092.0444610965405;1104.3373975614568;1116.8603924509437;16139.273732682292;16328.265228064529;16342;16364.509064728078;16713.16434178262;35096.47355289724;35574.466383004794;36839.26321473609;37600.247995040496;37617.24765504729;47645.28532072091;48350.5164948346;49036.26445603248;49321.753391232814;49394.259086113016;7954.250064985694;8064.435489515912;8074.273315401407;8111.594420278844;8157.6329065193395;12215.877841221474;12646.30445325516;12857;12899.355032248537;13255.66860828487;11023;11638.825417618911;11805.350705711267;11851.525938962344;11878.82181767257;11133.94433027862;11292.827501485583;11487.655370338904;11758.706032348917;11793.351365674971;11549.249298795552;11686.298822070703;11744.88255117472;11927.701807454883;12035.939820300842;7812.414068944739;7832.921670783219;7836.92163078362;7921.801954951173;7930.801729956797;11327.433628318717;11366.772664546828;11404.771904562029;11406.600768973047;11636.53453861836 01:15:44 INFO - PROCESS | 11983 | |3;mootools.html;1360.0887405438355;1492.4925525321391;1499.2953311943386;1671.983280167198;1790.1049475262369;7741.419393545486;7895.763127106189;7898.842023159534;7909.881351779728;7916.010498687671;7852.293293603575;7976;7977.282044615983;8011.198880111986;8027.036755589323;1963.7054441833695;2003.6994450832347;2183.410479170623;2259.830512711545;2274.590573696734;2255.086689890597;2260.536589999046;2262.7171603549555;2263.958579053637;2264.445210923318;2176.4885251965857;2195.4401627584944;2224.3882932193615;2226.543558570489;2226.565819665166;2221.133757834446;2223.3107736601705;2226.031676220841;2234.5307485427916;2298.678185054094;2232.05137816429;2261.898214580348;2266.9659955100524;2268.036084664028;2268.4669102760836;8104.1085480597085;8119.837603247961;8150.510969341858;8161.347092232607;8168.877466838002;4918.508149185089;5004.699718016895;5007.524285192937;5046.1926091825135;5046.520580544842;3135.937281254362;3161.920951976196;3164.4145833020966;3187.4581321175456;3224.3712476067176;951.3863558005048;952.5903861339622;1000.2698030437748;1012.427978192319;1042.9322094063862;11435.59975400857;11505.942470287595;11520.02079823216;11531.308121512737;11543.826842597367;4239.258129827268;4316.935245971313;4318.805653745589;4363.170997510463;4433.379326894237;9756.707298781048;9780.902190978142;9787.070228328439;9800.31397802147;9809.55856986423;5009.273655319958;5011.07295150391;5016.824411145592;5017.397912250553;5020.246962955586;3938.625830546151;4301.118270754488;4322.15717935006;4353.673474489426;4361.5856493633055;3637.1634524059614;3728.7017038636845;3739.2147648993473;3761.755485893408;3761.774293542396;1141.7202785317484;1165.7493638867516;1167.1129941244546;1172.6775136837439;1180.533689192764;1024.6618615856748;1034.4155552113032;1042.2704107125044;1162.7965106106396;1326.4362645875465;7526.172121066678;7658.578778167142;7678.385729141655;7708.49894756839;7719.266669666373;439.84385543131725;444.1051281667443;444.52879947256014;445.1630933844352;445.9375687403766;5800.970995144998;5836.737346819404;5854.736536855852;5879.294484661782;6072.028475443996;9757.951210244046;10170.796584068277;10306.278560500843;10308.226882983656;10321.74195645115;9635.470049147223;9998.600055997678;10007.649732259337;10010.799784004279;10018.448985305733;7455.478116531899;7470.738524151629;7473.85052298951;7519.8496030079095;7521.135069466972;7269.854602907806;7323.707051718085;7348.228436014141;7444.516106453063;7445.664945077593;8678.08880067609;8772.429792063496;8848.734537963872;8980.057094005035;9041.819163616823;8986.32602554824;9063.909360906306;9209.585568649292;9330;9395.624175032923;6208.565400421927;6648.401643852077;6853.143357080365;7198.856022879618;7229.240929702306;7472.663730132048;7487.438442116754;7504;7514.361279291322;7547.320741133324;6691.531592788653;6812.931870681428;6866.862662746617;6891.069705589681;6964.26875178099;6701.530892837454;6713.966430168013;6809.455243580403;6845.5550389224545;6978.720851165896;7218.89171662415;7233.204347521873;7307.926920730724;7307.963460182665;7341.4860959732305;6632.038354438676;6639.900401493885;6676.499262555425;6685.598864068172;6689.364510371507;6839.589624622538;6862.142232220973;6882.346177113166;6895.172579290517;6922.7923162305215 01:15:44 INFO - PROCESS | 11983 | |4;prototype.html;329.2328873724222;329.74609550646005;329.76586623497315;330.95366648669176;334.3013102615533;5966.254218222723;6078.270607527097;6084.908726369103;6096.298925623543;6097.237845269341;6005.789797357093;6008.729607167677;6011.849703757408;6032.065029920358;6035.72839222235;4341.2836881914445;4443.15580039793;4531.093781243748;4544.954550454503;4564.15563120822;4530.093981203756;4559.475660299058;4587.816487340502;4591.104734576759;4603.263477843546;4354.08564201518;4559.635229181674;4564.452265728118;4568.771561421932;4571.062932098912;4432.911341773162;4528.18492671319;4553.2942393929;4556.066006468666;4559.361689363492;3989.1024519483176;3991.980040099781;3994.1811928554575;4005.6995725320426;4021.9798901005306;5770.971145144247;5803.854903627401;5812.738426770806;5820.825375238707;5835.445632664932;5356.38401583819;5359.08895487768;5359.437259087778;5364.865878353034;5365.356157261114;6354.428101470844;6361.045843123568;6361.9045714314325;6363.204599425072;6366.87266254677;4227.0489139943265;4342.891427714301;4351.042770590465;4353.934690979638;4358.237308471005;6497.577657452251;6619.867602647968;6621.205455345341;6649.567778094457;6652.268250492442;4468.664850136252;4470.195364834296;4474.865754027384;4478.57453541913;4479.664025198123;4527.185106680829;4531.342955271533;4532.524084971096;4532.9320060199125;4537.02453972391;5264.263003179558;5271.367435907716;5276.709780962007;5282.841514754564;5283.762230699628;6235.781747638811;6420.967895160495;6431.13179720741;6435.259945106279;6442.162518872517;1572.2610373124612;1581.5255423373171;1591.4748133116043;1593.442295196695;1597.0497553955379;985.6254623243121;1017.2624846986024;1024.4212020208558;1053.346924906563;1053.952572134256;6079.082040620527;6130.6628135452975;6132.816015519542;6135.110408990671;6143.201383820075;6507.219133703986;6545.345465453416;6546.836329091716;6557.704903279364;6567.211934567882;6132.846678832976;6134.78528251509;6136.6011209271255;6141.140240366352;6141.416565426277;3509.5437593113243;3535.840887160084;3543.362194804908;3545.4150065238946;3547.822608869546;6714.3957043866285;6826.488013399015;6941.47938904574;6948.062011628365;6961.582305061713;6788.694508747119;6809.148856392951;6813.046173535709;6829.214640316427;6829.931700683029;6894.758683446155;6920.5847649141215;6929.203141638776;6931.965340173267;6936.653167341613;6646.700898459484;6663.633500157344;6664.733410663519;6668.433183179484;6670.566413183127;6421.8715625688155;6487.3188315226225;6542.54202205841;6545.574537655038;6573.408393244631;6849.075374824335;6886.24251332343;6897;6906.896396554156;6907.551009184387;4461.107778444389;4483.125790470957;4493;4494.280915053576;4496.640268778425;6576.112224849775;6640.103586015826;6653.0020496925845;6659.60148368848;6661.134052573135;6308.52686048539;6377.585456945284;6425.58233714807;6435.613863168225;6440.774572889926;6421.389967953037;6425.261094973951;6455.483561315177;6458.580192287486;6468.838279043061;6278.968605157128;6291.307956124914;6301.054841773771;6305.464035557029;6313.810585682437;6429.903551446639;6457.61254324742;6467.062275969864;6470.288268290578;6474.676266186766;5991.550633702577;6009.128676341818;6211.291894728985;6338.207724034496;6387.329330420239 01:15:44 INFO - PROCESS | 11983 | |5;yui.html;771.8803585444255;817.9836403271931;828.704666290433;832.9833403331932;874.7113452560656;14236.786448203273;14393.280335983198;14523.20122393268;14542.709145817078;14576.271186440688;12532.749345013117;13119.278439685837;13548.848347890416;13783.517576884811;13794.586162415118;808.510850935186;810.5784991804259;817.1011886924395;817.3869597801648;817.4032955942166;810.0522388805113;811.9634616442274;816.5345752920838;817.627979269431;817.652497688483;849.4436144325476;855.589317127779;856.3235044315015;856.8072183758667;856.9271611912994;854.7307598106577;855.8887344645187;856.1181982557913;856.7472595584318;856.7900864288227;624.7032659486753;627.0061951806392;628.5568674084759;629.4303655192059;629.7827249598881;13357.866421335759;13392.263425511594;13400.798988015187;13409;13413;12145.574904878287;12387.318697471635;12438.502459901592;12600.180988235827;12715.427805748763;9415.488665631254;9693;9761.414315141114;10093.293469457141;10122.696319110364;3829.7893615851117;3841.8463261469506;3852.7303088783797;3857.4971680082253;3877.1082650990147;54593.727031364586;55065.1740223897;55213.17180242299;55225.72387138039;55360.9999999996;9082.273418126533;9524.666636667684;9671.661491847752;9681.951590242144;9726.36778609388;18287.26850925948;19193.32823351176;19357.90321048386;19462.416127516197;19509;8580.01329847063;8594.957025214959;8632.352573556882;8673.959124905052;8696.826063478822;4832.855014349575;4846.733429661403;4974.477679843564;5028.79884804611;5158.613104017214;3262.200760813616;3296.4066468035503;3306.6197387300285;3309.7186739126964;3310.7185889199204;582.5980073749099;592.4963780786297;623.5261201486902;637.3658210080999;643.4369926314475;692.6986760759086;753.5139834806519;770.3875419041875;791.3669064748178;803.7003499669657;9857.408555486694;9910.653127140515;9963;10002.649907253211;10017.098461138532;660.6993817812884;696.7909627111846;760.4334770595831;783.8745800671979;787.5156778581131;4526.343680166423;4526.909461810746;4565.771711414416;4597.540245975376;4620.422447194101;59507.70246148742;60239.686817225476;60306.39693603096;64632.676836615516;64758.676206618664;45980;53529.1970620441;55394;57833.4216657828;59619.105713414334;49589.25616115761;50565;50786;51500.227496587584;51592.22611660828;9837.545126353925;9966.152877005536;9985.983709179434;9989.700308990741;10069.597216111273;38540.42189367218;39187.216255675296;39806.80096599498;40365;42220.788896055325;50164.247536287716;50598.494015059376;50699;51262;51716.48283517117;12753.936230318788;12978.935105324414;13162.210267383987;13362.465501379836;13364.933175334061;13274.269915154373;13304;14100.224487653277;14366.784498232326;14396.640083997983;12755;13226.07417480767;13290.933545332211;13531.729365412833;13718;12516.812247816108;12534.686632833887;13258.337083145998;13267;13277.40251688657;12678.366081696062;13123.409446574737;13498.190108593515;13516.864831351953;13829.723405532035;10482.580696772044;10523.421211833116;10570.947145264225;10707.411092389993;11097.33415995043;10653.786924261316;10869.402182880018;10916.399598021868;11209.943950280196;11213.66359009231 01:15:44 INFO - PROCESS | 11983 | __end_tp_report 01:15:44 INFO - PROCESS | 11983 | __start_cc_report 01:15:44 INFO - PROCESS | 11983 | _x_x_mozilla_cycle_collect,790 01:15:44 INFO - PROCESS | 11983 | __end_cc_report 01:15:44 INFO - PROCESS | 11983 | __startTimestamp1459844144882__endTimestamp 01:15:44 INFO - PROCESS | 11983 | 01:15:44 INFO - PROCESS | 11983 | ------- Summary: start ------- 01:15:44 INFO - PROCESS | 11983 | Number of tests: 6 01:15:44 INFO - PROCESS | 11983 | 01:15:44 INFO - PROCESS | 11983 | [#0] dojo.html Cycles:165 Average:5260.25 Median:5498.34 stddev:608.39 (11.1%) stddev-sans-first:585.40 01:15:44 INFO - PROCESS | 11983 | Values: 3065.7 3106.5 3136.2 3143.8 3170.5 5121.1 5134.5 5282.7 5316.7 5340.1 5155.6 5231.3 5233.8 5234.5 5236.1 4695.7 4713.2 4753.9 4771.1 4804.6 4655.9 4760.4 4788.1 4808.4 4813.1 4694.8 4718.8 4723.4 4737.4 4753.7 4778.9 4780.3 4784.4 4797.6 4844.3 4671.4 4751.8 4758.3 4792.0 4831.1 5207.6 5235.9 5239.5 5261.1 5268.4 5662.2 5669.1 5675.3 5676.0 5687.0 5556.0 5741.5 5792.5 5806.9 5812.2 5304.6 5330.6 5333.9 5334.3 5335.8 5797.0 5817.9 5819.9 5822.7 5828.0 5488.9 5498.3 5518.4 5553.1 5570.2 5664.4 5685.1 5686.5 5688.9 5693.8 5521.0 5648.5 5663.3 5664.9 5666.1 5699.4 5730.6 5737.4 5739.9 5776.1 4273.4 4302.2 4304.9 4305.1 4342.3 3816.4 3841.6 3849.1 3857.7 3873.9 5200.1 5220.2 5227.0 5273.9 5301.4 5636.9 5642.9 5646.0 5648.6 5657.0 5224.8 5305.5 5305.8 5330.5 5364.7 4947.8 4949.5 4951.9 4959.8 4997.7 5910.6 5920.1 5925.9 5927.6 5928.1 5627.0 5640.8 5678.1 5730.1 5771.1 5921.1 5923.7 5934.1 5955.3 5955.9 5615.8 5616.5 5618.6 5618.7 5620.5 5467.7 5657.2 5701.7 5712.1 5758.4 5602.1 5608.2 5612.6 5615.5 5619.1 5536.6 5571.3 5573.7 5588.5 5590.6 5295.0 5454.7 5480.9 5510.3 5538.3 5537.0 5579.1 5590.3 5590.3 5592.5 5349.3 5462.5 5501.5 5503.9 5538.8 01:15:44 INFO - PROCESS | 11983 | 01:15:44 INFO - PROCESS | 11983 | [#1] ext.html Cycles:180 Average:50296.31 Median:19284.84 stddev:89055.69 (461.8%) stddev-sans-first:89227.22 01:15:44 INFO - PROCESS | 11983 | Values: 558.0 563.0 567.7 574.7 585.4 31549.5 39320.8 39402.8 39605.6 39656.2 43406.1 43451.6 43861.1 43878.6 43966.8 7840.6 8673.6 8850.8 8863.5 10204.6 9809.0 10394.8 10398.5 10403.4 10405.9 10384.1 10452.8 10468.8 10469.4 10470.4 10343.4 10433.9 10435.4 10438.5 10452.4 10257.0 10742.3 10745.4 10746.6 10760.5 42800.8 43117.6 43128.6 43156.8 43173.0 3489.6 3573.5 3589.9 3627.0 3724.1 32512.3 32957.5 33048.8 33140.0 33616.5 4199.0 4203.2 4219.2 4302.7 4392.5 331603.0 336182.0 336336.0 337756.0 339070.0 48093.3 48257.0 65782.3 67238.3 67522.7 48294.3 48520.0 48521.2 48585.8 48646.0 16247.4 16423.9 16424.4 16439.4 16440.2 12995.7 13042.1 13077.5 13081.8 13098.0 16119.1 16487.0 16532.0 16557.8 16558.6 5949.0 6099.4 6169.4 6203.8 6225.6 997.4 1016.9 1073.4 1097.7 1108.3 29718.7 29884.3 30398.1 30514.7 30792.8 1001.8 1130.7 1137.0 1145.8 1146.2 13727.5 13809.2 14331.9 14441.3 14710.7 400022.0 402533.0 405411.0 406749.0 407306.0 57672.1 58689.7 58693.7 58760.0 58778.4 1283.1 1317.9 1341.7 1363.7 1365.9 26567.3 26579.7 27018.3 27191.7 27569.0 42566.6 42646.8 42974.0 42983.6 43080.0 256095.0 261977.0 262053.0 262693.0 263039.0 35080.1 35101.5 35940.3 36066.8 36094.3 44330.8 44525.3 44676.3 45489.5 45869.5 37610.6 37806.6 37847.6 37946.8 38092.2 36700.0 37216.4 37819.4 38010.8 38208.4 38120.0 38307.8 38695.6 38997.0 39714.4 32884.2 33773.8 33969.0 34095.8 34177.7 26551.7 27118.3 27193.6 27211.0 27641.0 01:15:44 INFO - PROCESS | 11983 | 01:15:44 INFO - PROCESS | 11983 | [#2] jquery.html Cycles:180 Average:28449.00 Median:21219.84 stddev:84580.81 (398.6%) stddev-sans-first:84791.79 01:15:44 INFO - PROCESS | 11983 | Values: 363.6 364.3 369.2 374.0 378.9 17757.4 17990.8 18232.0 18337.4 18353.4 17535.2 18098.5 18678.9 18808.9 18828.8 5580.2 5722.7 5741.2 5742.7 5747.8 4190.1 5629.9 5990.5 6224.9 6241.2 6196.3 6204.2 6217.6 6231.2 6231.4 6031.0 6116.9 6207.3 6211.0 6211.1 3763.2 5258.5 5414.8 5421.6 5459.5 20917.6 21163.9 21275.8 22099.7 22135.8 2566.0 2634.9 2857.5 2860.2 3112.0 13915.2 13984.6 13986.7 14075.6 14655.7 1856.6 1879.9 1885.4 1893.3 1908.1 68939.7 70666.3 70958.0 71068.3 72499.6 9755.6 10124.8 10129.8 10255.6 10285.1 12418.6 12441.4 12466.3 12876.0 12938.0 8000.7 8275.0 8278.7 8289.6 8352.3 7097.7 7145.9 7152.6 7391.4 8291.4 6012.0 6193.6 6196.2 6287.9 6307.5 1683.4 1732.1 1775.5 1785.8 1811.7 1033.0 1038.0 1096.4 1113.8 1117.3 17765.9 18185.0 18258.5 18473.1 18877.5 1017.6 1034.5 1063.2 1081.6 1095.0 10547.5 10643.6 10742.1 10754.3 10770.2 505066.0 506513.0 514248.0 525640.0 533501.0 73529.0 74449.0 74750.6 76139.0 76141.0 1057.2 1074.3 1092.0 1104.3 1116.9 16139.3 16328.3 16342.0 16364.5 16713.2 35096.5 35574.5 36839.3 37600.2 37617.2 47645.3 48350.5 49036.3 49321.8 49394.3 7954.3 8064.4 8074.3 8111.6 8157.6 12215.9 12646.3 12857.0 12899.4 13255.7 11023.0 11638.8 11805.4 11851.5 11878.8 11133.9 11292.8 11487.7 11758.7 11793.4 11549.2 11686.3 11744.9 11927.7 12035.9 7812.4 7832.9 7836.9 7921.8 7930.8 11327.4 11366.8 11404.8 11406.6 11636.5 01:15:44 INFO - PROCESS | 11983 | 01:15:44 INFO - PROCESS | 11983 | [#3] mootools.html Cycles:180 Average:5626.72 Median:5818.85 stddev:3047.69 (52.4%) stddev-sans-first:3039.36 01:15:44 INFO - PROCESS | 11983 | Values: 1360.1 1492.5 1499.3 1672.0 1790.1 7741.4 7895.8 7898.8 7909.9 7916.0 7852.3 7976.0 7977.3 8011.2 8027.0 1963.7 2003.7 2183.4 2259.8 2274.6 2255.1 2260.5 2262.7 2264.0 2264.4 2176.5 2195.4 2224.4 2226.5 2226.6 2221.1 2223.3 2226.0 2234.5 2298.7 2232.1 2261.9 2267.0 2268.0 2268.5 8104.1 8119.8 8150.5 8161.3 8168.9 4918.5 5004.7 5007.5 5046.2 5046.5 3135.9 3161.9 3164.4 3187.5 3224.4 951.4 952.6 1000.3 1012.4 1042.9 11435.6 11505.9 11520.0 11531.3 11543.8 4239.3 4316.9 4318.8 4363.2 4433.4 9756.7 9780.9 9787.1 9800.3 9809.6 5009.3 5011.1 5016.8 5017.4 5020.2 3938.6 4301.1 4322.2 4353.7 4361.6 3637.2 3728.7 3739.2 3761.8 3761.8 1141.7 1165.7 1167.1 1172.7 1180.5 1024.7 1034.4 1042.3 1162.8 1326.4 7526.2 7658.6 7678.4 7708.5 7719.3 439.8 444.1 444.5 445.2 445.9 5801.0 5836.7 5854.7 5879.3 6072.0 9758.0 10170.8 10306.3 10308.2 10321.7 9635.5 9998.6 10007.6 10010.8 10018.4 7455.5 7470.7 7473.9 7519.8 7521.1 7269.9 7323.7 7348.2 7444.5 7445.7 8678.1 8772.4 8848.7 8980.1 9041.8 8986.3 9063.9 9209.6 9330.0 9395.6 6208.6 6648.4 6853.1 7198.9 7229.2 7472.7 7487.4 7504.0 7514.4 7547.3 6691.5 6812.9 6866.9 6891.1 6964.3 6701.5 6714.0 6809.5 6845.6 6978.7 7218.9 7233.2 7307.9 7308.0 7341.5 6632.0 6639.9 6676.5 6685.6 6689.4 6839.6 6862.1 6882.3 6895.2 6922.8 01:15:44 INFO - PROCESS | 11983 | 01:15:44 INFO - PROCESS | 11983 | [#4] prototype.html Cycles:180 Average:5339.33 Median:6096.77 stddev:1636.46 (26.8%) stddev-sans-first:1597.26 01:15:44 INFO - PROCESS | 11983 | Values: 329.2 329.7 329.8 331.0 334.3 5966.3 6078.3 6084.9 6096.3 6097.2 6005.8 6008.7 6011.8 6032.1 6035.7 4341.3 4443.2 4531.1 4545.0 4564.2 4530.1 4559.5 4587.8 4591.1 4603.3 4354.1 4559.6 4564.5 4568.8 4571.1 4432.9 4528.2 4553.3 4556.1 4559.4 3989.1 3992.0 3994.2 4005.7 4022.0 5771.0 5803.9 5812.7 5820.8 5835.4 5356.4 5359.1 5359.4 5364.9 5365.4 6354.4 6361.0 6361.9 6363.2 6366.9 4227.0 4342.9 4351.0 4353.9 4358.2 6497.6 6619.9 6621.2 6649.6 6652.3 4468.7 4470.2 4474.9 4478.6 4479.7 4527.2 4531.3 4532.5 4532.9 4537.0 5264.3 5271.4 5276.7 5282.8 5283.8 6235.8 6421.0 6431.1 6435.3 6442.2 1572.3 1581.5 1591.5 1593.4 1597.0 985.6 1017.3 1024.4 1053.3 1054.0 6079.1 6130.7 6132.8 6135.1 6143.2 6507.2 6545.3 6546.8 6557.7 6567.2 6132.8 6134.8 6136.6 6141.1 6141.4 3509.5 3535.8 3543.4 3545.4 3547.8 6714.4 6826.5 6941.5 6948.1 6961.6 6788.7 6809.1 6813.0 6829.2 6829.9 6894.8 6920.6 6929.2 6932.0 6936.7 6646.7 6663.6 6664.7 6668.4 6670.6 6421.9 6487.3 6542.5 6545.6 6573.4 6849.1 6886.2 6897.0 6906.9 6907.6 4461.1 4483.1 4493.0 4494.3 4496.6 6576.1 6640.1 6653.0 6659.6 6661.1 6308.5 6377.6 6425.6 6435.6 6440.8 6421.4 6425.3 6455.5 6458.6 6468.8 6279.0 6291.3 6301.1 6305.5 6313.8 6429.9 6457.6 6467.1 6470.3 6474.7 5991.6 6009.1 6211.3 6338.2 6387.3 01:15:44 INFO - PROCESS | 11983 | 01:15:44 INFO - PROCESS | 11983 | [#5] yui.html Cycles:180 Average:15160.14 Median:27596.52 stddev:17617.48 (63.8%) stddev-sans-first:17633.77 01:15:44 INFO - PROCESS | 11983 | Values: 771.9 818.0 828.7 833.0 874.7 14236.8 14393.3 14523.2 14542.7 14576.3 12532.7 13119.3 13548.8 13783.5 13794.6 808.5 810.6 817.1 817.4 817.4 810.1 812.0 816.5 817.6 817.7 849.4 855.6 856.3 856.8 856.9 854.7 855.9 856.1 856.7 856.8 624.7 627.0 628.6 629.4 629.8 13357.9 13392.3 13400.8 13409.0 13413.0 12145.6 12387.3 12438.5 12600.2 12715.4 9415.5 9693.0 9761.4 10093.3 10122.7 3829.8 3841.8 3852.7 3857.5 3877.1 54593.7 55065.2 55213.2 55225.7 55361.0 9082.3 9524.7 9671.7 9682.0 9726.4 18287.3 19193.3 19357.9 19462.4 19509.0 8580.0 8595.0 8632.4 8674.0 8696.8 4832.9 4846.7 4974.5 5028.8 5158.6 3262.2 3296.4 3306.6 3309.7 3310.7 582.6 592.5 623.5 637.4 643.4 692.7 753.5 770.4 791.4 803.7 9857.4 9910.7 9963.0 10002.6 10017.1 660.7 696.8 760.4 783.9 787.5 4526.3 4526.9 4565.8 4597.5 4620.4 59507.7 60239.7 60306.4 64632.7 64758.7 45980.0 53529.2 55394.0 57833.4 59619.1 49589.3 50565.0 50786.0 51500.2 51592.2 9837.5 9966.2 9986.0 9989.7 10069.6 38540.4 39187.2 39806.8 40365.0 42220.8 50164.2 50598.5 50699.0 51262.0 51716.5 12753.9 12978.9 13162.2 13362.5 13364.9 13274.3 13304.0 14100.2 14366.8 14396.6 12755.0 13226.1 13290.9 13531.7 13718.0 12516.8 12534.7 13258.3 13267.0 13277.4 12678.4 13123.4 13498.2 13516.9 13829.7 10482.6 10523.4 10570.9 10707.4 11097.3 10653.8 10869.4 10916.4 11209.9 11213.7 01:15:44 INFO - PROCESS | 11983 | -------- Summary: end -------- 01:15:44 INFO - PROCESS | 11983 | 01:15:45 INFO - TEST-INFO | 11983: exit 0 01:15:45 INFO - TEST-OK | dromaeo_css | took 1110110ms 01:15:45 INFO - TEST-START | kraken 01:15:45 INFO - operating with platform_type : linux_ 01:15:45 INFO - Initialising browser for kraken test... 01:15:45 INFO - TEST-INFO | started process 12166 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7UvRCi/profile http://localhost:59544/getInfo.html) 01:15:49 INFO - PROCESS | 12166 | __metrics Screen width/height:1600/1200 01:15:49 INFO - PROCESS | 12166 | colorDepth:24 01:15:49 INFO - PROCESS | 12166 | Browser inner width/height: 1024/697 01:15:49 INFO - PROCESS | 12166 | __metrics 01:15:50 ERROR - PROCESS | 12166 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:15:50 INFO - TEST-INFO | 12166: exit 0 01:15:50 INFO - Browser initialized. 01:15:50 INFO - Running cycle 1/1 for kraken test... 01:15:50 INFO - TEST-INFO | started process 12246 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7UvRCi/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:16:02 INFO - PROCESS | 12246 | RSS: Main: 152055808 01:16:02 INFO - PROCESS | 12246 | 01:16:05 INFO - PROCESS | 12246 | Cycle 1(1): loaded http://localhost:59544/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59544/tests/kraken/driver.html?testName=audio-beat-detection) 01:16:05 INFO - PROCESS | 12246 | RSS: Main: 193777664 01:16:05 INFO - PROCESS | 12246 | 01:16:08 INFO - PROCESS | 12246 | Cycle 1(1): loaded http://localhost:59544/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59544/tests/kraken/driver.html?testName=audio-dft) 01:16:08 INFO - PROCESS | 12246 | RSS: Main: 183652352 01:16:08 INFO - PROCESS | 12246 | 01:16:11 INFO - PROCESS | 12246 | Cycle 1(1): loaded http://localhost:59544/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59544/tests/kraken/driver.html?testName=audio-fft) 01:16:12 INFO - PROCESS | 12246 | RSS: Main: 167747584 01:16:12 INFO - PROCESS | 12246 | 01:16:14 INFO - PROCESS | 12246 | Cycle 1(1): loaded http://localhost:59544/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59544/tests/kraken/driver.html?testName=audio-oscillator) 01:16:15 INFO - PROCESS | 12246 | RSS: Main: 169975808 01:16:15 INFO - PROCESS | 12246 | 01:16:17 INFO - PROCESS | 12246 | Cycle 1(1): loaded http://localhost:59544/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59544/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:16:17 INFO - PROCESS | 12246 | RSS: Main: 171749376 01:16:17 INFO - PROCESS | 12246 | 01:16:20 INFO - PROCESS | 12246 | Cycle 1(1): loaded http://localhost:59544/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59544/tests/kraken/driver.html?testName=imaging-darkroom) 01:16:21 INFO - PROCESS | 12246 | RSS: Main: 172396544 01:16:21 INFO - PROCESS | 12246 | 01:16:24 INFO - PROCESS | 12246 | Cycle 1(1): loaded http://localhost:59544/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59544/tests/kraken/driver.html?testName=imaging-desaturate) 01:16:25 INFO - PROCESS | 12246 | RSS: Main: 173432832 01:16:25 INFO - PROCESS | 12246 | 01:16:28 INFO - PROCESS | 12246 | Cycle 1(1): loaded http://localhost:59544/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59544/tests/kraken/driver.html?testName=json-parse-financial) 01:16:28 INFO - PROCESS | 12246 | RSS: Main: 173064192 01:16:28 INFO - PROCESS | 12246 | 01:16:30 INFO - PROCESS | 12246 | Cycle 1(1): loaded http://localhost:59544/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59544/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:16:30 INFO - PROCESS | 12246 | RSS: Main: 181370880 01:16:30 INFO - PROCESS | 12246 | 01:16:32 INFO - PROCESS | 12246 | Cycle 1(1): loaded http://localhost:59544/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59544/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:16:33 INFO - PROCESS | 12246 | RSS: Main: 179621888 01:16:33 INFO - PROCESS | 12246 | 01:16:35 INFO - PROCESS | 12246 | Cycle 1(1): loaded http://localhost:59544/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59544/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:16:35 INFO - PROCESS | 12246 | RSS: Main: 190820352 01:16:35 INFO - PROCESS | 12246 | 01:16:38 INFO - PROCESS | 12246 | Cycle 1(1): loaded http://localhost:59544/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59544/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:16:38 INFO - PROCESS | 12246 | RSS: Main: 196530176 01:16:38 INFO - PROCESS | 12246 | 01:16:41 INFO - PROCESS | 12246 | Cycle 1(1): loaded http://localhost:59544/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59544/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:16:41 INFO - PROCESS | 12246 | RSS: Main: 194588672 01:16:41 INFO - PROCESS | 12246 | 01:16:43 INFO - PROCESS | 12246 | Cycle 1(1): loaded http://localhost:59544/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59544/tests/kraken/driver.html?testName=ai-astar) 01:16:43 INFO - PROCESS | 12246 | RSS: Main: 257089536 01:16:43 INFO - PROCESS | 12246 | 01:16:43 INFO - PROCESS | 12246 | __start_tp_report 01:16:43 INFO - PROCESS | 12246 | _x_x_mozilla_page_load 01:16:43 INFO - PROCESS | 12246 | _x_x_mozilla_page_load_details 01:16:43 INFO - PROCESS | 12246 | |i|pagename|runs| 01:16:43 INFO - PROCESS | 12246 | |0;ai-astar;110;110;106;110;111;112;100;111;110;111 01:16:43 INFO - PROCESS | 12246 | |1;audio-beat-detection;150;129;154;179;128;152;159;127;174;128 01:16:43 INFO - PROCESS | 12246 | |2;audio-dft;160;161;161;160;160;159;161;166;164;161 01:16:43 INFO - PROCESS | 12246 | |3;audio-fft;75;76;103;100;76;75;72;119;97;73 01:16:43 INFO - PROCESS | 12246 | |4;audio-oscillator;92;93;152;93;93;94;144;92;93;147 01:16:43 INFO - PROCESS | 12246 | |5;imaging-gaussian-blur;117;117;117;118;118;117;117;117;117;117 01:16:43 INFO - PROCESS | 12246 | |6;imaging-darkroom;146;145;146;147;145;145;145;145;145;145 01:16:43 INFO - PROCESS | 12246 | |7;imaging-desaturate;96;95;95;95;95;96;95;96;95;95 01:16:43 INFO - PROCESS | 12246 | |8;json-parse-financial;57;58;58;58;60;58;58;71;54;55 01:16:43 INFO - PROCESS | 12246 | |9;json-stringify-tinderbox;60;60;61;60;60;61;60;61;61;61 01:16:43 INFO - PROCESS | 12246 | |10;stanford-crypto-aes;77;78;79;86;80;80;79;79;78;79 01:16:43 INFO - PROCESS | 12246 | |11;stanford-crypto-ccm;115;113;111;118;111;119;119;114;114;119 01:16:43 INFO - PROCESS | 12246 | |12;stanford-crypto-pbkdf2;142;143;151;157;142;132;142;142;153;142 01:16:43 INFO - PROCESS | 12246 | |13;stanford-crypto-sha256-iterative;64;65;64;63;64;64;64;65;64;63 01:16:43 INFO - PROCESS | 12246 | __end_tp_report 01:16:43 INFO - PROCESS | 12246 | __start_cc_report 01:16:43 INFO - PROCESS | 12246 | _x_x_mozilla_cycle_collect,1099 01:16:43 INFO - PROCESS | 12246 | __end_cc_report 01:16:43 INFO - PROCESS | 12246 | __startTimestamp1459844203861__endTimestamp 01:16:43 INFO - PROCESS | 12246 | 01:16:43 INFO - PROCESS | 12246 | ------- Summary: start ------- 01:16:43 INFO - PROCESS | 12246 | Number of tests: 14 01:16:43 INFO - PROCESS | 12246 | 01:16:43 INFO - PROCESS | 12246 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.50 stddev:3.57 (3.2%) stddev-sans-first:3.77 01:16:43 INFO - PROCESS | 12246 | Values: 110.0 110.0 106.0 110.0 111.0 112.0 100.0 111.0 110.0 111.0 01:16:43 INFO - PROCESS | 12246 | 01:16:43 INFO - PROCESS | 12246 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:153.00 stddev:19.48 (12.7%) stddev-sans-first:20.65 01:16:43 INFO - PROCESS | 12246 | Values: 150.0 129.0 154.0 179.0 128.0 152.0 159.0 127.0 174.0 128.0 01:16:43 INFO - PROCESS | 12246 | 01:16:43 INFO - PROCESS | 12246 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:2.11 (1.3%) stddev-sans-first:2.19 01:16:43 INFO - PROCESS | 12246 | Values: 160.0 161.0 161.0 160.0 160.0 159.0 161.0 166.0 164.0 161.0 01:16:43 INFO - PROCESS | 12246 | 01:16:43 INFO - PROCESS | 12246 | [#3] audio-fft Cycles:10 Average:86.60 Median:75.00 stddev:16.66 (22.2%) stddev-sans-first:17.14 01:16:43 INFO - PROCESS | 12246 | Values: 75.0 76.0 103.0 100.0 76.0 75.0 72.0 119.0 97.0 73.0 01:16:43 INFO - PROCESS | 12246 | 01:16:43 INFO - PROCESS | 12246 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:93.00 stddev:26.55 (28.5%) stddev-sans-first:27.41 01:16:43 INFO - PROCESS | 12246 | Values: 92.0 93.0 152.0 93.0 93.0 94.0 144.0 92.0 93.0 147.0 01:16:43 INFO - PROCESS | 12246 | 01:16:43 INFO - PROCESS | 12246 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 01:16:43 INFO - PROCESS | 12246 | Values: 117.0 117.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 01:16:43 INFO - PROCESS | 12246 | 01:16:43 INFO - PROCESS | 12246 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 01:16:43 INFO - PROCESS | 12246 | Values: 146.0 145.0 146.0 147.0 145.0 145.0 145.0 145.0 145.0 145.0 01:16:43 INFO - PROCESS | 12246 | 01:16:43 INFO - PROCESS | 12246 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 01:16:43 INFO - PROCESS | 12246 | Values: 96.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 01:16:43 INFO - PROCESS | 12246 | 01:16:43 INFO - PROCESS | 12246 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:58.00 stddev:4.64 (8.0%) stddev-sans-first:4.88 01:16:43 INFO - PROCESS | 12246 | Values: 57.0 58.0 58.0 58.0 60.0 58.0 58.0 71.0 54.0 55.0 01:16:43 INFO - PROCESS | 12246 | 01:16:43 INFO - PROCESS | 12246 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:61.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 01:16:43 INFO - PROCESS | 12246 | Values: 60.0 60.0 61.0 60.0 60.0 61.0 60.0 61.0 61.0 61.0 01:16:43 INFO - PROCESS | 12246 | 01:16:43 INFO - PROCESS | 12246 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:79.00 stddev:2.46 (3.1%) stddev-sans-first:2.44 01:16:43 INFO - PROCESS | 12246 | Values: 77.0 78.0 79.0 86.0 80.0 80.0 79.0 79.0 78.0 79.0 01:16:43 INFO - PROCESS | 12246 | 01:16:43 INFO - PROCESS | 12246 | [#11] stanford-crypto-ccm Cycles:10 Average:115.30 Median:116.50 stddev:3.23 (2.8%) stddev-sans-first:3.43 01:16:43 INFO - PROCESS | 12246 | Values: 115.0 113.0 111.0 118.0 111.0 119.0 119.0 114.0 114.0 119.0 01:16:43 INFO - PROCESS | 12246 | 01:16:43 INFO - PROCESS | 12246 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.60 Median:142.50 stddev:7.15 (5.0%) stddev-sans-first:7.52 01:16:43 INFO - PROCESS | 12246 | Values: 142.0 143.0 151.0 157.0 142.0 132.0 142.0 142.0 153.0 142.0 01:16:43 INFO - PROCESS | 12246 | 01:16:43 INFO - PROCESS | 12246 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 01:16:43 INFO - PROCESS | 12246 | Values: 64.0 65.0 64.0 63.0 64.0 64.0 64.0 65.0 64.0 63.0 01:16:43 INFO - PROCESS | 12246 | -------- Summary: end -------- 01:16:43 INFO - PROCESS | 12246 | 01:16:44 INFO - TEST-INFO | 12246: exit 0 01:16:44 INFO - TEST-OK | kraken | took 59132ms 01:16:44 INFO - SUITE-END | took 1169s 01:16:45 INFO - Completed test suite (00:19:29) 01:16:45 INFO - javascript benchmark 01:16:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3065.693430656934, 3106.5184896341048, 3136.200268931422, 3143.764217683673, 3170.5244213368, 5121.078205922932, 5134.537891589756, 5282.709450980195, 5316.680999140054, 5340.145576707728, 5155.639105262633, 5231.267622532839, 5233.816816411427, 5234.528892399693, 5236.083685355066, 4695.741734204617, 4713.175194340985, 4753.90492190156, 4771.117343291485, 4804.639652026094, 4655.86032419028, 4760.357351757503, 4788.11419887322, 4808.447028591721, 4813.061453016663, 4694.812207511695, 4718.764061796896, 4723.36234608327, 4737.3604563384015, 4753.691010084333, 4778.904421911577, 4780.259059845729, 4784.354112194878, 4797.592204662608, 4844.2975768513725, 4671.416072990876, 4751.83368582098, 4758.286257061469, 4792.041591681677, 4831.0820944020525, 5207.583393328525, 5235.895282094375, 5239.502247286502, 5261.0793111205385, 5268.446813084647, 5662.207290979266, 5669.0646043402785, 5675.347335056439, 5675.971620141873, 5686.971565142189, 5555.972220138914, 5741.540676745892, 5792.507636850873, 5806.854828629276, 5812.215350927655, 5304.6286759926825, 5330.600204984642, 5333.866653333697, 5334.333208348957, 5335.839924802262, 5796.971015144982, 5817.941820581825, 5819.88360232793, 5822.737976791054, 5828.038373668382, 5488.945110548923, 5498.340199176045, 5518.44815518453, 5553.111502159635, 5570.248016517799, 5664.433556644302, 5685.090385538294, 5686.545076393879, 5688.857778555569, 5693.772249109989, 5521.00621888064, 5648.491635752802, 5663.348714897757, 5664.85837854057, 5666.121751128581, 5699.373068962494, 5730.627509211888, 5737.426257374229, 5739.8852022960145, 5776.075827867521, 4273.423087883159, 4302.182585308781, 4304.935425968613, 4305.07440900208, 4342.32693932441, 3816.3512202925567, 3841.5582208045876, 3849.095462566295, 3857.672097871712, 3873.8837834865, 5200.089984252816, 5220.190870415092, 5227.0, 5273.920891186635, 5301.363836339587, 5636.943630563642, 5642.943570564324, 5645.9717701412055, 5648.576356773258, 5657.0, 5224.843254702365, 5305.469453054741, 5305.814296499604, 5330.546903513167, 5364.7317634118135, 4947.752612369439, 4949.455559888409, 4951.851444456672, 4959.776810043557, 4997.675151115166, 5910.615809972338, 5920.141579470953, 5925.881482370329, 5927.555433342516, 5928.140419639129, 5626.987142314259, 5640.802571909963, 5678.14827775837, 5730.054541000688, 5771.134329850556, 5921.082232254007, 5923.703814809329, 5934.109883517507, 5955.315138758925, 5955.880882382415, 5615.803446879339, 5616.494515493625, 5618.634788738719, 5618.747156378055, 5620.494155526022, 5467.6719396836315, 5657.2079908811975, 5701.7434215461235, 5712.143178523254, 5758.366579676149, 5602.075657516464, 5608.242887210337, 5612.607117501736, 5615.522680572034, 5619.072852979212, 5536.612437129363, 5571.303587051619, 5573.7213139343685, 5588.469095435927, 5590.580706446952, 5294.97352513235, 5454.699991500505, 5480.945190548203, 5510.311211098613, 5538.252335934597, 5537.031019571639, 5579.107342825128, 5590.273264475592, 5590.329160500766, 5592.496675299242, 5349.304590403222, 5462.508374246337, 5501.477359650827, 5503.862403439786, 5538.806141785019], "unit": "score", "name": "dojo.html", "value": 5219.076707457346}, {"lowerIsBetter": false, "replicates": [558.023458946843, 562.9887402251952, 567.6820980251057, 574.7040274258757, 585.4292065236396, 31549.526757098633, 39320.80339598305, 39402.8029859851, 39605.60394396055, 39656.20687586247, 43406.13187736244, 43451.56548434515, 43861.12277754443, 43878.561214387846, 43966.780166099205, 7840.607969601526, 8673.60968756406, 8850.778730531756, 8863.468191908507, 10204.591816327338, 9809.0, 10394.792104157912, 10398.532066057007, 10403.37579745214, 10405.895941040568, 10384.117350025257, 10452.790944181112, 10468.842967355497, 10469.424181670005, 10470.42412667303, 10343.431111288875, 10433.895661043369, 10435.426051567161, 10438.530266138005, 10452.425116618659, 10257.0, 10742.3017503862, 10745.355278683304, 10746.623868164656, 10760.515776789985, 42800.78599606982, 43117.56882431167, 43128.568714313085, 43156.78421607903, 43173.0, 3489.5638045244345, 3573.4997100405963, 3589.910252243689, 3626.963730362689, 3724.1062145085257, 32512.349753004808, 32957.50563741546, 33048.834755826305, 33140.0, 33616.49575256373, 4198.979005104986, 4203.201391735591, 4219.2405367033925, 4302.698811083225, 4392.516823149451, 331603.0, 336182.0, 336336.0, 337756.0, 339069.99999999756, 48093.27860082102, 48257.0, 65782.34217657858, 67238.32761672419, 67522.66238668874, 48294.27558586624, 48520.0, 48521.177458705184, 48585.75707121513, 48646.0, 16247.431339903047, 16423.932444391077, 16424.425145119865, 16439.424620138478, 16440.177991100398, 12995.675108122372, 13042.087053906136, 13077.476900924046, 13081.803772943413, 13098.0, 16119.113448760196, 16487.0, 16532.0, 16557.751633725504, 16558.586035349213, 5948.970255148696, 6099.420555047263, 6169.383061693885, 6203.8138855834395, 6225.564210505221, 997.4240699694466, 1016.9491525423699, 1073.3667136389568, 1097.6871591596357, 1108.3405373802575, 29718.702812972027, 29884.252893677833, 30398.088057358316, 30514.69485305163, 30792.846035770126, 1001.7746007148334, 1130.6601677012766, 1136.971575710614, 1145.7536629624672, 1146.2492067695673, 13727.503863602215, 13809.240491772847, 14331.856681433052, 14441.277936103153, 14710.705785884222, 400022.0, 402533.0, 405411.0, 406749.0, 407306.0, 57672.13491797626, 58689.70655146697, 58693.70653146707, 58760.0, 58778.412215877295, 1283.1467074395423, 1317.8748018938377, 1341.7048249385314, 1363.740889231043, 1365.9112157709717, 26567.33581660474, 26579.7342026585, 27018.324541885824, 27191.72808271892, 27569.0, 42566.574334256264, 42646.78676606597, 42974.0, 42983.570164297955, 43080.0, 256095.0, 261977.0, 262053.0, 262693.0, 263039.0, 35080.12299692426, 35101.47347789836, 35940.28119437649, 36066.8196659015, 36094.278114438086, 44330.77834610806, 44525.33212001758, 44676.32985505285, 45489.54510454853, 45869.54130458653, 37610.6238937618, 37806.62193378141, 37847.621523785514, 37946.810265948494, 38092.2381552373, 36700.0, 37216.44175337318, 37819.432708508844, 38010.809945950095, 38208.42687359748, 38120.0, 38307.808460957516, 38695.6130438692, 38997.0, 39714.40428393634, 32884.233267760654, 33773.83113084419, 33969.0, 34095.82952085224, 34177.65822341745, 26551.734482654927, 27118.322041949108, 27193.59209611818, 27211.0, 27641.0], "unit": "score", "name": "ext.html", "value": 19269.038174972924}, {"lowerIsBetter": false, "replicates": [363.58732838228605, 364.26055108130504, 369.23936690417736, 373.9682127019203, 378.94505296731955, 17757.378491752792, 17990.820091799094, 18232.0, 18337.358192463267, 18353.449396518125, 17535.2109155088, 18098.457046288633, 18678.906605466953, 18808.905955470203, 18828.811711882878, 5580.246666700004, 5722.656640601556, 5741.167530708045, 5742.7415766290615, 5747.798827041054, 4190.078182799779, 5629.915551266734, 5990.520758339322, 6224.906626400608, 6241.21984751906, 6196.318404975449, 6204.193454850885, 6217.626942383449, 6231.189945307104, 6231.439170474657, 6030.96984515079, 6116.877662446748, 6207.255129384457, 6210.968945155268, 6211.068339749028, 3763.209725957552, 5258.474152584749, 5414.7834086636485, 5421.593380496439, 5459.508644221999, 20917.5816483671, 21163.894180528998, 21275.787242127535, 22099.668504972436, 22135.778642213532, 2565.999260288489, 2634.894604215848, 2857.4856525825553, 2860.184847318504, 3112.0197137901714, 13915.23466209358, 13984.580462586138, 13986.720265594733, 14075.577732668036, 14655.70688586233, 1856.6008308213663, 1879.8966056866866, 1885.3966730646198, 1893.3184053740642, 1908.0745838268429, 68939.65530172367, 70666.29333706648, 70958.0, 71068.2893171072, 72499.63750181215, 9755.609775609038, 10124.848127278097, 10129.797404051878, 10255.58977640901, 10285.125764309967, 12418.627441176779, 12441.37793110359, 12466.252024878537, 12876.034297427543, 12938.0, 8000.679972801139, 8275.0, 8278.668853245923, 8289.626966786509, 8352.331813454908, 7097.716091356391, 7145.92854071463, 7152.642367881585, 7391.371733402721, 8291.378146639026, 6012.0, 6193.628382297076, 6196.1635179251125, 6287.937120628735, 6307.463865571478, 1683.3519095148456, 1732.0773940925562, 1775.5117342730593, 1785.8392744653045, 1811.7191835265555, 1032.99483502582, 1038.039813172812, 1096.4079397125463, 1113.7828123515837, 1117.3128675371242, 17765.911170444324, 18185.0, 18258.54353641143, 18473.076346182635, 18877.52806179829, 1017.6234793126442, 1034.5396298647029, 1063.2238465919922, 1081.5889961814617, 1095.0418383914075, 10547.472626368652, 10643.574257029786, 10742.140628749681, 10754.300970436896, 10770.24608277413, 505066.0, 506513.0, 514248.0, 525640.0, 533501.0, 73529.0, 74449.0, 74750.62624686841, 76139.0, 76141.0, 1057.1701214546545, 1074.3339129739454, 1092.0444610965405, 1104.3373975614568, 1116.8603924509437, 16139.273732682292, 16328.265228064529, 16342.0, 16364.509064728078, 16713.16434178262, 35096.47355289724, 35574.466383004794, 36839.26321473609, 37600.247995040496, 37617.24765504729, 47645.28532072091, 48350.5164948346, 49036.26445603248, 49321.753391232814, 49394.259086113016, 7954.250064985694, 8064.435489515912, 8074.273315401407, 8111.594420278844, 8157.6329065193395, 12215.877841221474, 12646.30445325516, 12857.0, 12899.355032248537, 13255.66860828487, 11023.0, 11638.825417618911, 11805.350705711267, 11851.525938962344, 11878.82181767257, 11133.94433027862, 11292.827501485583, 11487.655370338904, 11758.706032348917, 11793.351365674971, 11549.249298795552, 11686.298822070703, 11744.88255117472, 11927.701807454883, 12035.939820300842, 7812.414068944739, 7832.921670783219, 7836.92163078362, 7921.801954951173, 7930.801729956797, 11327.433628318717, 11366.772664546828, 11404.771904562029, 11406.600768973047, 11636.53453861836], "unit": "score", "name": "jquery.html", "value": 9074.086125649208}, {"lowerIsBetter": false, "replicates": [1360.0887405438355, 1492.4925525321391, 1499.2953311943386, 1671.983280167198, 1790.1049475262369, 7741.419393545486, 7895.763127106189, 7898.842023159534, 7909.881351779728, 7916.010498687671, 7852.293293603575, 7976.0, 7977.282044615983, 8011.198880111986, 8027.036755589323, 1963.7054441833695, 2003.6994450832347, 2183.410479170623, 2259.830512711545, 2274.590573696734, 2255.086689890597, 2260.536589999046, 2262.7171603549555, 2263.958579053637, 2264.445210923318, 2176.4885251965857, 2195.4401627584944, 2224.3882932193615, 2226.543558570489, 2226.565819665166, 2221.133757834446, 2223.3107736601705, 2226.031676220841, 2234.5307485427916, 2298.678185054094, 2232.05137816429, 2261.898214580348, 2266.9659955100524, 2268.036084664028, 2268.4669102760836, 8104.1085480597085, 8119.837603247961, 8150.510969341858, 8161.347092232607, 8168.877466838002, 4918.508149185089, 5004.699718016895, 5007.524285192937, 5046.1926091825135, 5046.520580544842, 3135.937281254362, 3161.920951976196, 3164.4145833020966, 3187.4581321175456, 3224.3712476067176, 951.3863558005048, 952.5903861339622, 1000.2698030437748, 1012.427978192319, 1042.9322094063862, 11435.59975400857, 11505.942470287595, 11520.02079823216, 11531.308121512737, 11543.826842597367, 4239.258129827268, 4316.935245971313, 4318.805653745589, 4363.170997510463, 4433.379326894237, 9756.707298781048, 9780.902190978142, 9787.070228328439, 9800.31397802147, 9809.55856986423, 5009.273655319958, 5011.07295150391, 5016.824411145592, 5017.397912250553, 5020.246962955586, 3938.625830546151, 4301.118270754488, 4322.15717935006, 4353.673474489426, 4361.5856493633055, 3637.1634524059614, 3728.7017038636845, 3739.2147648993473, 3761.755485893408, 3761.774293542396, 1141.7202785317484, 1165.7493638867516, 1167.1129941244546, 1172.6775136837439, 1180.533689192764, 1024.6618615856748, 1034.4155552113032, 1042.2704107125044, 1162.7965106106396, 1326.4362645875465, 7526.172121066678, 7658.578778167142, 7678.385729141655, 7708.49894756839, 7719.266669666373, 439.84385543131725, 444.1051281667443, 444.52879947256014, 445.1630933844352, 445.9375687403766, 5800.970995144998, 5836.737346819404, 5854.736536855852, 5879.294484661782, 6072.028475443996, 9757.951210244046, 10170.796584068277, 10306.278560500843, 10308.226882983656, 10321.74195645115, 9635.470049147223, 9998.600055997678, 10007.649732259337, 10010.799784004279, 10018.448985305733, 7455.478116531899, 7470.738524151629, 7473.85052298951, 7519.8496030079095, 7521.135069466972, 7269.854602907806, 7323.707051718085, 7348.228436014141, 7444.516106453063, 7445.664945077593, 8678.08880067609, 8772.429792063496, 8848.734537963872, 8980.057094005035, 9041.819163616823, 8986.32602554824, 9063.909360906306, 9209.585568649292, 9330.0, 9395.624175032923, 6208.565400421927, 6648.401643852077, 6853.143357080365, 7198.856022879618, 7229.240929702306, 7472.663730132048, 7487.438442116754, 7504.0, 7514.361279291322, 7547.320741133324, 6691.531592788653, 6812.931870681428, 6866.862662746617, 6891.069705589681, 6964.26875178099, 6701.530892837454, 6713.966430168013, 6809.455243580403, 6845.5550389224545, 6978.720851165896, 7218.89171662415, 7233.204347521873, 7307.926920730724, 7307.963460182665, 7341.4860959732305, 6632.038354438676, 6639.900401493885, 6676.499262555425, 6685.598864068172, 6689.364510371507, 6839.589624622538, 6862.142232220973, 6882.346177113166, 6895.172579290517, 6922.7923162305215], "unit": "score", "name": "mootools.html", "value": 4466.552660532768}, {"lowerIsBetter": false, "replicates": [329.2328873724222, 329.74609550646005, 329.76586623497315, 330.95366648669176, 334.3013102615533, 5966.254218222723, 6078.270607527097, 6084.908726369103, 6096.298925623543, 6097.237845269341, 6005.789797357093, 6008.729607167677, 6011.849703757408, 6032.065029920358, 6035.72839222235, 4341.2836881914445, 4443.15580039793, 4531.093781243748, 4544.954550454503, 4564.15563120822, 4530.093981203756, 4559.475660299058, 4587.816487340502, 4591.104734576759, 4603.263477843546, 4354.08564201518, 4559.635229181674, 4564.452265728118, 4568.771561421932, 4571.062932098912, 4432.911341773162, 4528.18492671319, 4553.2942393929, 4556.066006468666, 4559.361689363492, 3989.1024519483176, 3991.980040099781, 3994.1811928554575, 4005.6995725320426, 4021.9798901005306, 5770.971145144247, 5803.854903627401, 5812.738426770806, 5820.825375238707, 5835.445632664932, 5356.38401583819, 5359.08895487768, 5359.437259087778, 5364.865878353034, 5365.356157261114, 6354.428101470844, 6361.045843123568, 6361.9045714314325, 6363.204599425072, 6366.87266254677, 4227.0489139943265, 4342.891427714301, 4351.042770590465, 4353.934690979638, 4358.237308471005, 6497.577657452251, 6619.867602647968, 6621.205455345341, 6649.567778094457, 6652.268250492442, 4468.664850136252, 4470.195364834296, 4474.865754027384, 4478.57453541913, 4479.664025198123, 4527.185106680829, 4531.342955271533, 4532.524084971096, 4532.9320060199125, 4537.02453972391, 5264.263003179558, 5271.367435907716, 5276.709780962007, 5282.841514754564, 5283.762230699628, 6235.781747638811, 6420.967895160495, 6431.13179720741, 6435.259945106279, 6442.162518872517, 1572.2610373124612, 1581.5255423373171, 1591.4748133116043, 1593.442295196695, 1597.0497553955379, 985.6254623243121, 1017.2624846986024, 1024.4212020208558, 1053.346924906563, 1053.952572134256, 6079.082040620527, 6130.6628135452975, 6132.816015519542, 6135.110408990671, 6143.201383820075, 6507.219133703986, 6545.345465453416, 6546.836329091716, 6557.704903279364, 6567.211934567882, 6132.846678832976, 6134.78528251509, 6136.6011209271255, 6141.140240366352, 6141.416565426277, 3509.5437593113243, 3535.840887160084, 3543.362194804908, 3545.4150065238946, 3547.822608869546, 6714.3957043866285, 6826.488013399015, 6941.47938904574, 6948.062011628365, 6961.582305061713, 6788.694508747119, 6809.148856392951, 6813.046173535709, 6829.214640316427, 6829.931700683029, 6894.758683446155, 6920.5847649141215, 6929.203141638776, 6931.965340173267, 6936.653167341613, 6646.700898459484, 6663.633500157344, 6664.733410663519, 6668.433183179484, 6670.566413183127, 6421.8715625688155, 6487.3188315226225, 6542.54202205841, 6545.574537655038, 6573.408393244631, 6849.075374824335, 6886.24251332343, 6897.0, 6906.896396554156, 6907.551009184387, 4461.107778444389, 4483.125790470957, 4493.0, 4494.280915053576, 4496.640268778425, 6576.112224849775, 6640.103586015826, 6653.0020496925845, 6659.60148368848, 6661.134052573135, 6308.52686048539, 6377.585456945284, 6425.58233714807, 6435.613863168225, 6440.774572889926, 6421.389967953037, 6425.261094973951, 6455.483561315177, 6458.580192287486, 6468.838279043061, 6278.968605157128, 6291.307956124914, 6301.054841773771, 6305.464035557029, 6313.810585682437, 6429.903551446639, 6457.61254324742, 6467.062275969864, 6470.288268290578, 6474.676266186766, 5991.550633702577, 6009.128676341818, 6211.291894728985, 6338.207724034496, 6387.329330420239], "unit": "score", "name": "prototype.html", "value": 4800.21828109732}, {"lowerIsBetter": false, "replicates": [771.8803585444255, 817.9836403271931, 828.704666290433, 832.9833403331932, 874.7113452560656, 14236.786448203273, 14393.280335983198, 14523.20122393268, 14542.709145817078, 14576.271186440688, 12532.749345013117, 13119.278439685837, 13548.848347890416, 13783.517576884811, 13794.586162415118, 808.510850935186, 810.5784991804259, 817.1011886924395, 817.3869597801648, 817.4032955942166, 810.0522388805113, 811.9634616442274, 816.5345752920838, 817.627979269431, 817.652497688483, 849.4436144325476, 855.589317127779, 856.3235044315015, 856.8072183758667, 856.9271611912994, 854.7307598106577, 855.8887344645187, 856.1181982557913, 856.7472595584318, 856.7900864288227, 624.7032659486753, 627.0061951806392, 628.5568674084759, 629.4303655192059, 629.7827249598881, 13357.866421335759, 13392.263425511594, 13400.798988015187, 13409.0, 13413.0, 12145.574904878287, 12387.318697471635, 12438.502459901592, 12600.180988235827, 12715.427805748763, 9415.488665631254, 9693.0, 9761.414315141114, 10093.293469457141, 10122.696319110364, 3829.7893615851117, 3841.8463261469506, 3852.7303088783797, 3857.4971680082253, 3877.1082650990147, 54593.727031364586, 55065.1740223897, 55213.17180242299, 55225.72387138039, 55360.9999999996, 9082.273418126533, 9524.666636667684, 9671.661491847752, 9681.951590242144, 9726.36778609388, 18287.26850925948, 19193.32823351176, 19357.90321048386, 19462.416127516197, 19509.0, 8580.01329847063, 8594.957025214959, 8632.352573556882, 8673.959124905052, 8696.826063478822, 4832.855014349575, 4846.733429661403, 4974.477679843564, 5028.79884804611, 5158.613104017214, 3262.200760813616, 3296.4066468035503, 3306.6197387300285, 3309.7186739126964, 3310.7185889199204, 582.5980073749099, 592.4963780786297, 623.5261201486902, 637.3658210080999, 643.4369926314475, 692.6986760759086, 753.5139834806519, 770.3875419041875, 791.3669064748178, 803.7003499669657, 9857.408555486694, 9910.653127140515, 9963.0, 10002.649907253211, 10017.098461138532, 660.6993817812884, 696.7909627111846, 760.4334770595831, 783.8745800671979, 787.5156778581131, 4526.343680166423, 4526.909461810746, 4565.771711414416, 4597.540245975376, 4620.422447194101, 59507.70246148742, 60239.686817225476, 60306.39693603096, 64632.676836615516, 64758.676206618664, 45980.0, 53529.1970620441, 55394.0, 57833.4216657828, 59619.105713414334, 49589.25616115761, 50565.0, 50786.0, 51500.227496587584, 51592.22611660828, 9837.545126353925, 9966.152877005536, 9985.983709179434, 9989.700308990741, 10069.597216111273, 38540.42189367218, 39187.216255675296, 39806.80096599498, 40365.0, 42220.788896055325, 50164.247536287716, 50598.494015059376, 50699.0, 51262.0, 51716.48283517117, 12753.936230318788, 12978.935105324414, 13162.210267383987, 13362.465501379836, 13364.933175334061, 13274.269915154373, 13304.0, 14100.224487653277, 14366.784498232326, 14396.640083997983, 12755.0, 13226.07417480767, 13290.933545332211, 13531.729365412833, 13718.0, 12516.812247816108, 12534.686632833887, 13258.337083145998, 13267.0, 13277.40251688657, 12678.366081696062, 13123.409446574737, 13498.190108593515, 13516.864831351953, 13829.723405532035, 10482.580696772044, 10523.421211833116, 10570.947145264225, 10707.411092389993, 11097.33415995043, 10653.786924261316, 10869.402182880018, 10916.399598021868, 11209.943950280196, 11213.66359009231], "unit": "score", "name": "yui.html", "value": 6845.086136247645}], "name": "dromaeo_css", "value": 7152.945340590189}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 106.0, 110.0, 111.0, 112.0, 100.0, 111.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.1}, {"lowerIsBetter": true, "replicates": [150.0, 129.0, 154.0, 179.0, 128.0, 152.0, 159.0, 127.0, 174.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 148.0}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 161.0, 160.0, 160.0, 159.0, 161.0, 166.0, 164.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [75.0, 76.0, 103.0, 100.0, 76.0, 75.0, 72.0, 119.0, 97.0, 73.0], "unit": "score", "name": "audio-fft", "value": 86.6}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 152.0, 93.0, 93.0, 94.0, 144.0, 92.0, 93.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 109.3}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.2}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 147.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [57.0, 58.0, 58.0, 58.0, 60.0, 58.0, 58.0, 71.0, 54.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.7}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 61.0, 60.0, 60.0, 61.0, 60.0, 61.0, 61.0, 61.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 60.5}, {"lowerIsBetter": true, "replicates": [77.0, 78.0, 79.0, 86.0, 80.0, 80.0, 79.0, 79.0, 78.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.5}, {"lowerIsBetter": true, "replicates": [115.0, 113.0, 111.0, 118.0, 111.0, 119.0, 119.0, 114.0, 114.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.3}, {"lowerIsBetter": true, "replicates": [142.0, 143.0, 151.0, 157.0, 142.0, 132.0, 142.0, 142.0, 153.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.6}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 63.0, 64.0, 64.0, 64.0, 65.0, 64.0, 63.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 64.0}], "name": "kraken", "value": 1494.7999999999997}]} 01:16:45 INFO - Return code: 0 01:16:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 01:16:45 ERROR - # TBPL SUCCESS # 01:16:45 INFO - Running post-action listener: _resource_record_post_action 01:16:45 INFO - Running post-run listener: _resource_record_post_run 01:16:46 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 527421440; Read time: 8; Write time: 468944 01:16:46 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 242864128; Read time: 0; Write time: 271856 01:16:46 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284246016; Read time: 8; Write time: 197088 01:16:46 INFO - Running post-run listener: _upload_blobber_files 01:16:46 INFO - Blob upload gear active. 01:16:46 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 01:16:46 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 01:16:46 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', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 01:16:46 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 Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 01:16:46 INFO - (blobuploader) - INFO - Open directory for files ... 01:16:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:16:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:16:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:16:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:16:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:16:47 INFO - (blobuploader) - INFO - Done attempting. 01:16:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 01:16:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:16:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:16:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:16:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:16:48 INFO - (blobuploader) - INFO - Done attempting. 01:16:48 INFO - (blobuploader) - INFO - Iteration through files over. 01:16:48 INFO - Return code: 0 01:16:48 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 01:16:48 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 01:16:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/48f870131dce69c3ce7125832209b5201b8ae726757af7b0f8686ae42f0bb45ea8b76490a8d4e62076270b106d144ea3d5d271c2437f60d7eb578882b7b7c85e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b5c85b1ebdc3ba037a130e20d20e9732a5827d767200fe6833786926ea8c72ad184d354da03aaff065f05c387c9bea96f312c6dcd6c8d32e473fff80133dcb0c"} 01:16:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 01:16:48 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 01:16:48 INFO - Contents: 01:16:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/48f870131dce69c3ce7125832209b5201b8ae726757af7b0f8686ae42f0bb45ea8b76490a8d4e62076270b106d144ea3d5d271c2437f60d7eb578882b7b7c85e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b5c85b1ebdc3ba037a130e20d20e9732a5827d767200fe6833786926ea8c72ad184d354da03aaff065f05c387c9bea96f312c6dcd6c8d32e473fff80133dcb0c"} 01:16:48 INFO - Running post-run listener: copy_logs_to_upload_dir 01:16:48 INFO - Copying logs to upload dir... 01:16:48 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 01:16:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.417571 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-04-05 01:16:47.885300) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 01:16:47.888984) ========= 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=523ca41ca1e0623de333ad52000001bf-1459841213.711893-1840384910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/48f870131dce69c3ce7125832209b5201b8ae726757af7b0f8686ae42f0bb45ea8b76490a8d4e62076270b106d144ea3d5d271c2437f60d7eb578882b7b7c85e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b5c85b1ebdc3ba037a130e20d20e9732a5827d767200fe6833786926ea8c72ad184d354da03aaff065f05c387c9bea96f312c6dcd6c8d32e473fff80133dcb0c"} build_url:https://queue.taskcluster.net/v1/task/DTyoRwFJScmX9eyhRpvN2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011181 build_url: 'https://queue.taskcluster.net/v1/task/DTyoRwFJScmX9eyhRpvN2w/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/Mozilla-Inbound/sha512/48f870131dce69c3ce7125832209b5201b8ae726757af7b0f8686ae42f0bb45ea8b76490a8d4e62076270b106d144ea3d5d271c2437f60d7eb578882b7b7c85e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b5c85b1ebdc3ba037a130e20d20e9732a5827d767200fe6833786926ea8c72ad184d354da03aaff065f05c387c9bea96f312c6dcd6c8d32e473fff80133dcb0c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 01:16:47.918391) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 01:16:47.919064) ========= 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=523ca41ca1e0623de333ad52000001bf-1459841213.711893-1840384910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 01:16:48.003882) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 01:16:48.004228) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 01:16:48.004549) ========= ========= Total master_lag: 0.32 =========