builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-032 starttime: 1457128881.04 results: success (0) buildid: 20160304113025 builduid: f40250e82ebb40a2bd6efaf54f3bdc8b revision: b479a3b0fde9a3dfc67dfb6dbf35d3c958fd1a9c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-04 14:01:21.040994) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-04 14:01:21.041667) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-04 14:01:21.041987) ========= 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=745a4373a2a16df560f216e000000264-1457126135.895393-1607768215 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006089 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-04 14:01:21.063619) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-04 14:01:21.063921) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-04 14:01:21.076810) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 14:01:21.077068) ========= 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=745a4373a2a16df560f216e000000264-1457126135.895393-1607768215 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004551 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 14:01:21.125209) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-04 14:01:21.125602) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-04 14:01:21.126113) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 14:01:21.126492) ========= 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=745a4373a2a16df560f216e000000264-1457126135.895393-1607768215 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-04 14:01:21-- 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% 113M=0s 2016-03-04 14:01:21 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120190 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 14:01:21.321970) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 14:01:21.322239) ========= 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=745a4373a2a16df560f216e000000264-1457126135.895393-1607768215 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018252 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 14:01:21.357356) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 14:01:21.357808) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b479a3b0fde9a3dfc67dfb6dbf35d3c958fd1a9c --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/fx-team --rev b479a3b0fde9a3dfc67dfb6dbf35d3c958fd1a9c --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=745a4373a2a16df560f216e000000264-1457126135.895393-1607768215 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-04 14:01:21,580 truncating revision to first 12 chars 2016-03-04 14:01:21,580 Setting DEBUG logging. 2016-03-04 14:01:21,580 attempt 1/10 2016-03-04 14:01:21,580 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b479a3b0fde9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-04 14:01:21,867 unpacking tar archive at: fx-team-b479a3b0fde9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.603274 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 14:01:21.973050) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-04 14:01:21.973366) ========= echo b479a3b0fde9a3dfc67dfb6dbf35d3c958fd1a9c in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b479a3b0fde9a3dfc67dfb6dbf35d3c958fd1a9c'] 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=745a4373a2a16df560f216e000000264-1457126135.895393-1607768215 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b479a3b0fde9a3dfc67dfb6dbf35d3c958fd1a9c program finished with exit code 0 elapsedTime=0.004556 script_repo_revision: 'b479a3b0fde9a3dfc67dfb6dbf35d3c958fd1a9c' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-04 14:01:22.023804) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-04 14:01:22.024075) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-04 14:01:22.035233) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-03-04 14:01:22.035487) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=745a4373a2a16df560f216e000000264-1457126135.895393-1607768215 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:01:22 INFO - MultiFileLogger online at 20160304 14:01:22 in /builds/slave/test-pgo 14:01:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:01:22 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:01:22 INFO - {'append_to_log': False, 14:01:22 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:01:22 INFO - 'blob_upload_branch': 'Fx-Team', 14:01:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:01:22 INFO - 'branch': 'Fx-Team', 14:01:22 INFO - 'buildbot_json_path': 'buildprops.json', 14:01:22 INFO - 'config_files': ('talos/linux_config.py',), 14:01:22 INFO - 'default_actions': ('clobber', 14:01:22 INFO - 'read-buildbot-config', 14:01:22 INFO - 'download-and-extract', 14:01:22 INFO - 'populate-webroot', 14:01:22 INFO - 'create-virtualenv', 14:01:22 INFO - 'install', 14:01:22 INFO - 'run-tests'), 14:01:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:01:22 INFO - 'download_minidump_stackwalk': True, 14:01:22 INFO - 'download_symbols': 'ondemand', 14:01:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:01:22 INFO - 'tooltool.py': '/tools/tooltool.py', 14:01:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:01:22 INFO - '/tools/misc-python/virtualenv.py')}, 14:01:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:01:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:01:22 INFO - 'installer_path': 'installer.exe', 14:01:22 INFO - 'log_level': 'info', 14:01:22 INFO - 'log_name': 'talos', 14:01:22 INFO - 'log_to_console': True, 14:01:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:01:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:01:22 INFO - 'opt_config_files': (), 14:01:22 INFO - 'pip_index': False, 14:01:22 INFO - 'sps_profile': False, 14:01:22 INFO - 'sps_profile_interval': 0, 14:01:22 INFO - 'suite': 'dromaeojs', 14:01:22 INFO - 'system_bits': '32', 14:01:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:01:22 INFO - 'title': 'talos-linux64-ix-032', 14:01:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:01:22 INFO - 'use_talos_json': True, 14:01:22 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:01:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:01:22 INFO - 'work_dir': 'build'} 14:01:22 INFO - ##### 14:01:22 INFO - ##### Running clobber step. 14:01:22 INFO - ##### 14:01:22 INFO - Running pre-action listener: _resource_record_pre_action 14:01:22 INFO - Running main action method: clobber 14:01:22 INFO - rmtree: /builds/slave/test-pgo/build 14:01:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:01:22 INFO - Running post-action listener: _resource_record_post_action 14:01:22 INFO - ##### 14:01:22 INFO - ##### Running read-buildbot-config step. 14:01:22 INFO - ##### 14:01:22 INFO - Running pre-action listener: _resource_record_pre_action 14:01:22 INFO - Running main action method: read_buildbot_config 14:01:22 INFO - Using buildbot properties: 14:01:22 INFO - { 14:01:22 INFO - "project": "", 14:01:22 INFO - "product": "firefox", 14:01:22 INFO - "script_repo_revision": "production", 14:01:22 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:01:22 INFO - "repository": "", 14:01:22 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:01:22 INFO - "buildid": "20160304113025", 14:01:22 INFO - "pgo_build": "True", 14:01:22 INFO - "basedir": "/builds/slave/test-pgo", 14:01:22 INFO - "buildnumber": 975, 14:01:22 INFO - "slavename": "talos-linux64-ix-032", 14:01:22 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:01:22 INFO - "platform": "ubuntu64_hw", 14:01:22 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:01:22 INFO - "branch": "fx-team", 14:01:22 INFO - "repo_path": "integration/fx-team", 14:01:22 INFO - "revision": "b479a3b0fde9a3dfc67dfb6dbf35d3c958fd1a9c", 14:01:22 INFO - "stage_platform": "linux64-pgo", 14:01:22 INFO - "builduid": "f40250e82ebb40a2bd6efaf54f3bdc8b", 14:01:22 INFO - "slavebuilddir": "test" 14:01:22 INFO - } 14:01:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/clHn5J3tRcWBvu1-cRevfg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 14:01:22 INFO - Running post-action listener: _resource_record_post_action 14:01:22 INFO - ##### 14:01:22 INFO - ##### Running download-and-extract step. 14:01:22 INFO - ##### 14:01:22 INFO - Running pre-action listener: _resource_record_pre_action 14:01:22 INFO - Running main action method: download_and_extract 14:01:22 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:01:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:22 INFO - https://queue.taskcluster.net/v1/task/clHn5J3tRcWBvu1-cRevfg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:01:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clHn5J3tRcWBvu1-cRevfg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 14:01:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clHn5J3tRcWBvu1-cRevfg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 14:01:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clHn5J3tRcWBvu1-cRevfg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 14:01:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clHn5J3tRcWBvu1-cRevfg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:01:28 INFO - Downloaded 1448 bytes. 14:01:28 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 14:01:28 INFO - Using the following test package requirements: 14:01:28 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 14:01:28 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:01:28 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:01:28 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:01:28 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:01:28 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:01:28 INFO - u'jsshell-linux-x86_64.zip'], 14:01:28 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:01:28 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:01:28 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 14:01:28 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:01:28 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:01:28 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:01:28 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:01:28 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:01:28 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:01:28 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 14:01:28 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:01:28 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:01:28 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:01:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:28 INFO - https://queue.taskcluster.net/v1/task/clHn5J3tRcWBvu1-cRevfg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:01:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clHn5J3tRcWBvu1-cRevfg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:01:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clHn5J3tRcWBvu1-cRevfg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:01:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clHn5J3tRcWBvu1-cRevfg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:01:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clHn5J3tRcWBvu1-cRevfg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:01:31 INFO - Downloaded 23396657 bytes. 14:01:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 14:01:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 14:01:32 INFO - Return code: 0 14:01:32 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:01:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:32 INFO - https://queue.taskcluster.net/v1/task/clHn5J3tRcWBvu1-cRevfg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:01:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clHn5J3tRcWBvu1-cRevfg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:01:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clHn5J3tRcWBvu1-cRevfg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:01:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clHn5J3tRcWBvu1-cRevfg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:01:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clHn5J3tRcWBvu1-cRevfg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:01:38 INFO - Downloaded 23396657 bytes. 14:01:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 14:01:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 14:01:40 INFO - Return code: 0 14:01:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:40 INFO - https://queue.taskcluster.net/v1/task/clHn5J3tRcWBvu1-cRevfg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:01:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clHn5J3tRcWBvu1-cRevfg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 14:01:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clHn5J3tRcWBvu1-cRevfg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 14:01:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clHn5J3tRcWBvu1-cRevfg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 14:01:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clHn5J3tRcWBvu1-cRevfg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:01:41 INFO - Downloaded 10803659 bytes. 14:01:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 14:01:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 14:01:41 INFO - Return code: 0 14:01: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')]} 14:01:41 INFO - https://queue.taskcluster.net/v1/task/clHn5J3tRcWBvu1-cRevfg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:01:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clHn5J3tRcWBvu1-cRevfg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:01:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clHn5J3tRcWBvu1-cRevfg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:01:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clHn5J3tRcWBvu1-cRevfg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:01:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/clHn5J3tRcWBvu1-cRevfg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:01:42 INFO - Downloaded 56119764 bytes. 14:01:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/clHn5J3tRcWBvu1-cRevfg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:01:42 INFO - mkdir: /builds/slave/test-pgo/properties 14:01:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:01:42 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:01:42 INFO - Contents: 14:01:42 INFO - build_url:https://queue.taskcluster.net/v1/task/clHn5J3tRcWBvu1-cRevfg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:01:43 INFO - Running post-action listener: _resource_record_post_action 14:01:43 INFO - Running post-action listener: set_extra_try_arguments 14:01:43 INFO - ##### 14:01:43 INFO - ##### Running populate-webroot step. 14:01:43 INFO - ##### 14:01:43 INFO - Running pre-action listener: _resource_record_pre_action 14:01:43 INFO - Running main action method: populate_webroot 14:01:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:01:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:01:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:01:43 INFO - '--tppagecycles', 14:01:43 INFO - '7'], 14:01:43 INFO - 'tests': ['tsvgm']}}, 14:01:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:01:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:01:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:01:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:01:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:01:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:01:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:01:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:43 INFO - 'talos_options': ['--e10s'], 14:01:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:01:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:43 INFO - 'tests': ['damp', 'tps']}, 14:01:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:43 INFO - 'talos_options': ['--e10s'], 14:01:43 INFO - 'tests': ['damp', 'tps']}, 14:01:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:01:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:01:43 INFO - 'other': {'tests': ['a11yr', 14:01:43 INFO - 'ts_paint', 14:01:43 INFO - 'tpaint', 14:01:43 INFO - 'sessionrestore', 14:01:43 INFO - 'sessionrestore_no_auto_restore']}, 14:01:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:01:43 INFO - 'tests': ['a11yr', 14:01:43 INFO - 'ts_paint', 14:01:43 INFO - 'tpaint', 14:01:43 INFO - 'sessionrestore', 14:01:43 INFO - 'sessionrestore_no_auto_restore']}, 14:01:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:01:43 INFO - 'tests': ['a11yr', 14:01:43 INFO - 'ts_paint', 14:01:43 INFO - 'tpaint', 14:01:43 INFO - 'sessionrestore', 14:01:43 INFO - 'sessionrestore_no_auto_restore']}, 14:01:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:01:43 INFO - 'tests': ['a11yr', 14:01:43 INFO - 'ts_paint', 14:01:43 INFO - 'tpaint', 14:01:43 INFO - 'sessionrestore', 14:01:43 INFO - 'sessionrestore_no_auto_restore']}, 14:01:43 INFO - 'other_l64': {'tests': ['a11yr', 14:01:43 INFO - 'ts_paint', 14:01:43 INFO - 'tpaint', 14:01:43 INFO - 'sessionrestore', 14:01:43 INFO - 'sessionrestore_no_auto_restore']}, 14:01:43 INFO - 'other_nol64': {'tests': ['a11yr', 14:01:43 INFO - 'ts_paint', 14:01:43 INFO - 'tpaint', 14:01:43 INFO - 'sessionrestore', 14:01:43 INFO - 'sessionrestore_no_auto_restore']}, 14:01:43 INFO - 'svgr': {'tests': ['tsvgx', 14:01:43 INFO - 'tsvgr_opacity', 14:01:43 INFO - 'tart', 14:01:43 INFO - 'tscrollx', 14:01:43 INFO - 'cart']}, 14:01:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:01:43 INFO - 'tests': ['tsvgx', 14:01:43 INFO - 'tsvgr_opacity', 14:01:43 INFO - 'tart', 14:01:43 INFO - 'tscrollx', 14:01:43 INFO - 'cart']}, 14:01:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:43 INFO - 'tests': ['tp5o']}, 14:01:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:43 INFO - 'talos_options': ['--e10s'], 14:01:43 INFO - 'tests': ['tp5o']}, 14:01:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:43 INFO - 'talos_options': ['--xperf_path', 14:01:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:01:43 INFO - 'tests': ['tp5n']}, 14:01:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:43 INFO - 'talos_options': ['--e10s', 14:01:43 INFO - '--xperf_path', 14:01:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:01:43 INFO - 'tests': ['tp5n']}}, 14:01:43 INFO - 'talos.zip': {'path': '', 14:01:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:01:43 INFO - Running post-action listener: _resource_record_post_action 14:01:43 INFO - ##### 14:01:43 INFO - ##### Running create-virtualenv step. 14:01:43 INFO - ##### 14:01:43 INFO - Running pre-action listener: _resource_record_pre_action 14:01:43 INFO - Running main action method: create_virtualenv 14:01:43 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:01:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 14:01:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:01:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:01:43 INFO - Using real prefix '/usr' 14:01:43 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:01:43 INFO - Installing distribute.............................................................................................................................................................................................done. 14:01:45 INFO - Installing pip.................done. 14:01:45 INFO - Return code: 0 14:01:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:01:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:45 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 0x7f39d5d91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aad920>, '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 0x2aae820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aaecb0>, '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': '745a4373a2a16df560f216e000000264-1457126135.895393-1607768215', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:01:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 14:01:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:01:45 INFO - Using env: {'DISPLAY': ':0', 14:01:45 INFO - 'HOME': '/home/cltbld', 14:01:45 INFO - 'LANG': 'en_US.UTF-8', 14:01:45 INFO - 'LANGUAGE': 'en_US:en', 14:01:45 INFO - 'LOGNAME': 'cltbld', 14:01:45 INFO - 'MAIL': '/var/mail/cltbld', 14:01:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:45 INFO - 'MOZ_NO_REMOTE': '1', 14:01:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:45 INFO - 'NO_EM_RESTART': '1', 14:01:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:45 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:45 INFO - 'SHELL': '/bin/bash', 14:01:45 INFO - 'SHLVL': '1', 14:01:45 INFO - 'TERM': 'linux', 14:01:45 INFO - 'TMOUT': '86400', 14:01:45 INFO - 'USER': 'cltbld', 14:01:45 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457126135.895393-1607768215', 14:01:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:45 INFO - '_': '/tools/buildbot/bin/python'} 14:01:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:01:46 INFO - Cleaning up... 14:01:46 INFO - Return code: 0 14:01:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:46 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 0x7f39d5d91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aad920>, '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 0x2aae820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aaecb0>, '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': '745a4373a2a16df560f216e000000264-1457126135.895393-1607768215', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:01:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 14:01:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:01:46 INFO - Using env: {'DISPLAY': ':0', 14:01:46 INFO - 'HOME': '/home/cltbld', 14:01:46 INFO - 'LANG': 'en_US.UTF-8', 14:01:46 INFO - 'LANGUAGE': 'en_US:en', 14:01:46 INFO - 'LOGNAME': 'cltbld', 14:01:46 INFO - 'MAIL': '/var/mail/cltbld', 14:01:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:46 INFO - 'MOZ_NO_REMOTE': '1', 14:01:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:46 INFO - 'NO_EM_RESTART': '1', 14:01:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:46 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:46 INFO - 'SHELL': '/bin/bash', 14:01:46 INFO - 'SHLVL': '1', 14:01:46 INFO - 'TERM': 'linux', 14:01:46 INFO - 'TMOUT': '86400', 14:01:46 INFO - 'USER': 'cltbld', 14:01:46 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457126135.895393-1607768215', 14:01:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:46 INFO - '_': '/tools/buildbot/bin/python'} 14:01:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:46 INFO - Downloading/unpacking psutil>=0.7.1 14:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:01:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:01:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:01:48 INFO - Installing collected packages: psutil 14:01:48 INFO - Running setup.py install for psutil 14:01:48 INFO - building 'psutil._psutil_linux' extension 14:01:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:01:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:01:48 INFO - building 'psutil._psutil_posix' extension 14:01:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:01:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:01:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:01:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:01:48 INFO - Successfully installed psutil 14:01:48 INFO - Cleaning up... 14:01:48 INFO - Return code: 0 14:01:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:01:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:48 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 0x7f39d5d91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aad920>, '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 0x2aae820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aaecb0>, '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': '745a4373a2a16df560f216e000000264-1457126135.895393-1607768215', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:01:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 14:01:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:01:48 INFO - Using env: {'DISPLAY': ':0', 14:01:48 INFO - 'HOME': '/home/cltbld', 14:01:48 INFO - 'LANG': 'en_US.UTF-8', 14:01:48 INFO - 'LANGUAGE': 'en_US:en', 14:01:48 INFO - 'LOGNAME': 'cltbld', 14:01:48 INFO - 'MAIL': '/var/mail/cltbld', 14:01:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:48 INFO - 'MOZ_NO_REMOTE': '1', 14:01:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:48 INFO - 'NO_EM_RESTART': '1', 14:01:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:48 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:48 INFO - 'SHELL': '/bin/bash', 14:01:48 INFO - 'SHLVL': '1', 14:01:48 INFO - 'TERM': 'linux', 14:01:48 INFO - 'TMOUT': '86400', 14:01:48 INFO - 'USER': 'cltbld', 14:01:48 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457126135.895393-1607768215', 14:01:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:48 INFO - '_': '/tools/buildbot/bin/python'} 14:01:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:01: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 14:01: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 14:01: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 14:01: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 14:01: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 14:01: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 14:01:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:01:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:01:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:01:50 INFO - Installing collected packages: mozsystemmonitor 14:01:50 INFO - Running setup.py install for mozsystemmonitor 14:01:51 INFO - Successfully installed mozsystemmonitor 14:01:51 INFO - Cleaning up... 14:01:51 INFO - Return code: 0 14:01:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:01: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')]} 14:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01: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')]} 14:01:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01: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', '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 0x7f39d5d91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aad920>, '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 0x2aae820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aaecb0>, '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': '745a4373a2a16df560f216e000000264-1457126135.895393-1607768215', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:01: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 14:01: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 blobuploader==1.2.4 14:01:51 INFO - Using env: {'DISPLAY': ':0', 14:01:51 INFO - 'HOME': '/home/cltbld', 14:01:51 INFO - 'LANG': 'en_US.UTF-8', 14:01:51 INFO - 'LANGUAGE': 'en_US:en', 14:01:51 INFO - 'LOGNAME': 'cltbld', 14:01:51 INFO - 'MAIL': '/var/mail/cltbld', 14:01:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:51 INFO - 'MOZ_NO_REMOTE': '1', 14:01:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:51 INFO - 'NO_EM_RESTART': '1', 14:01:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:51 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:51 INFO - 'SHELL': '/bin/bash', 14:01:51 INFO - 'SHLVL': '1', 14:01:51 INFO - 'TERM': 'linux', 14:01:51 INFO - 'TMOUT': '86400', 14:01:51 INFO - 'USER': 'cltbld', 14:01:51 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457126135.895393-1607768215', 14:01:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:51 INFO - '_': '/tools/buildbot/bin/python'} 14:01:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:51 INFO - Downloading/unpacking blobuploader==1.2.4 14:01: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 14:01: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 14:01: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 14:01: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 14:01: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 14:01: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 14:01:53 INFO - Downloading blobuploader-1.2.4.tar.gz 14:01:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:01:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:01: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 14:01: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 14:01: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 14:01: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 14:01: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 14:01: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 14:01:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:01:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:01: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 14:01: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 14:01: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 14:01: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 14:01: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 14:01: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 14:01:53 INFO - Downloading docopt-0.6.1.tar.gz 14:01:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:01:53 INFO - Installing collected packages: blobuploader, requests, docopt 14:01:53 INFO - Running setup.py install for blobuploader 14:01:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:01:53 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:01:53 INFO - Running setup.py install for requests 14:01:54 INFO - Running setup.py install for docopt 14:01:54 INFO - Successfully installed blobuploader requests docopt 14:01:54 INFO - Cleaning up... 14:01:54 INFO - Return code: 0 14:01:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:01: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')]} 14:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01: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')]} 14:01:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:54 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 0x7f39d5d91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aad920>, '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 0x2aae820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aaecb0>, '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': '745a4373a2a16df560f216e000000264-1457126135.895393-1607768215', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:01:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 14:01:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:01:54 INFO - Using env: {'DISPLAY': ':0', 14:01:54 INFO - 'HOME': '/home/cltbld', 14:01:54 INFO - 'LANG': 'en_US.UTF-8', 14:01:54 INFO - 'LANGUAGE': 'en_US:en', 14:01:54 INFO - 'LOGNAME': 'cltbld', 14:01:54 INFO - 'MAIL': '/var/mail/cltbld', 14:01:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:54 INFO - 'MOZ_NO_REMOTE': '1', 14:01:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:54 INFO - 'NO_EM_RESTART': '1', 14:01:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:54 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:54 INFO - 'SHELL': '/bin/bash', 14:01:54 INFO - 'SHLVL': '1', 14:01:54 INFO - 'TERM': 'linux', 14:01:54 INFO - 'TMOUT': '86400', 14:01:54 INFO - 'USER': 'cltbld', 14:01:54 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457126135.895393-1607768215', 14:01:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:54 INFO - '_': '/tools/buildbot/bin/python'} 14:01:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:01:54 INFO - Running setup.py (path:/tmp/pip-UZhGGJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:01:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:01:54 INFO - Running setup.py (path:/tmp/pip-BhUrNy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:01:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:01:54 INFO - Running setup.py (path:/tmp/pip-tOLCsM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:01:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:01:54 INFO - Running setup.py (path:/tmp/pip-__M9xl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:01:55 INFO - Running setup.py (path:/tmp/pip-M1NLD5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:01:55 INFO - Running setup.py (path:/tmp/pip-uYdLC1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:01:55 INFO - Running setup.py (path:/tmp/pip-ynDPtx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:01:55 INFO - Running setup.py (path:/tmp/pip-cR7AGa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:01:55 INFO - Running setup.py (path:/tmp/pip-kXUbJH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:01:55 INFO - Running setup.py (path:/tmp/pip-BKbU54-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:01:55 INFO - Running setup.py (path:/tmp/pip-xReccD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:01:55 INFO - Running setup.py (path:/tmp/pip-iPqPi9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:01:55 INFO - Running setup.py (path:/tmp/pip-kDC9er-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:01:55 INFO - Running setup.py (path:/tmp/pip-F679wc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:01:55 INFO - Running setup.py (path:/tmp/pip-2D1yF5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:01:55 INFO - Running setup.py (path:/tmp/pip-iFYuQU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:01:55 INFO - Running setup.py (path:/tmp/pip-0AAiNq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:01:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:01:55 INFO - Running setup.py install for manifestparser 14:01:56 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:01:56 INFO - Running setup.py install for mozcrash 14:01:56 INFO - Running setup.py install for mozdebug 14:01:56 INFO - Running setup.py install for mozdevice 14:01:56 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:01:56 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:01:56 INFO - Running setup.py install for mozfile 14:01:56 INFO - Running setup.py install for mozhttpd 14:01:56 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:01:56 INFO - Running setup.py install for mozinfo 14:01:56 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:01:56 INFO - Running setup.py install for mozInstall 14:01:56 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:01:56 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:01:56 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:01:56 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:01:56 INFO - Running setup.py install for mozleak 14:01:56 INFO - Running setup.py install for mozlog 14:01:56 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:01:56 INFO - Running setup.py install for moznetwork 14:01:57 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:01:57 INFO - Running setup.py install for mozprocess 14:01:57 INFO - Running setup.py install for mozprofile 14:01:57 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:01:57 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:01:57 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:01:57 INFO - Running setup.py install for mozrunner 14:01:57 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:01:57 INFO - Running setup.py install for mozscreenshot 14:01:57 INFO - Running setup.py install for moztest 14:01:57 INFO - Running setup.py install for mozversion 14:01:57 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:01:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:01:57 INFO - Cleaning up... 14:01:57 INFO - Return code: 0 14:01:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:57 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 0x7f39d5d91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aad920>, '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 0x2aae820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aaecb0>, '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': '745a4373a2a16df560f216e000000264-1457126135.895393-1607768215', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:01:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 14:01:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:01:57 INFO - Using env: {'DISPLAY': ':0', 14:01:57 INFO - 'HOME': '/home/cltbld', 14:01:57 INFO - 'LANG': 'en_US.UTF-8', 14:01:57 INFO - 'LANGUAGE': 'en_US:en', 14:01:57 INFO - 'LOGNAME': 'cltbld', 14:01:57 INFO - 'MAIL': '/var/mail/cltbld', 14:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:57 INFO - 'MOZ_NO_REMOTE': '1', 14:01:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:57 INFO - 'NO_EM_RESTART': '1', 14:01:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:57 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:57 INFO - 'SHELL': '/bin/bash', 14:01:57 INFO - 'SHLVL': '1', 14:01:57 INFO - 'TERM': 'linux', 14:01:57 INFO - 'TMOUT': '86400', 14:01:57 INFO - 'USER': 'cltbld', 14:01:57 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457126135.895393-1607768215', 14:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:57 INFO - '_': '/tools/buildbot/bin/python'} 14:01:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:01:57 INFO - Running setup.py (path:/tmp/pip-NUQ8U6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 14:01:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:01:58 INFO - Running setup.py (path:/tmp/pip-Bxei78-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:01:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:01:58 INFO - Running setup.py (path:/tmp/pip-C7qplU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 14:01:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:01:58 INFO - Running setup.py (path:/tmp/pip-lE1nOB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:01:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:01:58 INFO - Running setup.py (path:/tmp/pip-eAgZdr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 14:01:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:01:58 INFO - Running setup.py (path:/tmp/pip-Ik7s9r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 14:01:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:01:58 INFO - Running setup.py (path:/tmp/pip-RtDWYh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 14:01:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:01:58 INFO - Running setup.py (path:/tmp/pip-KHtnls-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 14:01:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:01:58 INFO - Running setup.py (path:/tmp/pip-UMJJjy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 14:01:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:01:58 INFO - Running setup.py (path:/tmp/pip-QvSSCy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:01:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:01:58 INFO - Running setup.py (path:/tmp/pip-huBzDZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 14:01:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:01:58 INFO - Running setup.py (path:/tmp/pip-qNApwN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 14:01:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:01:58 INFO - Running setup.py (path:/tmp/pip-YOeby7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 14:01:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:01:58 INFO - Running setup.py (path:/tmp/pip-_QR_nD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 14:01:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:01:58 INFO - Running setup.py (path:/tmp/pip-KVvVkt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 14:01:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:01:59 INFO - Running setup.py (path:/tmp/pip-zjmnG8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 14:01:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:01:59 INFO - Running setup.py (path:/tmp/pip-GneG0R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 14:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 14:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:01:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:01 INFO - Downloading blessings-1.6.tar.gz 14:02:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:02:01 INFO - Installing collected packages: blessings 14:02:01 INFO - Running setup.py install for blessings 14:02:01 INFO - Successfully installed blessings 14:02:01 INFO - Cleaning up... 14:02:01 INFO - Return code: 0 14:02:01 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:02:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:02:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:02:01 INFO - Reading from file tmpfile_stdout 14:02:01 INFO - Current package versions: 14:02:01 INFO - argparse == 1.2.1 14:02:01 INFO - blessings == 1.6 14:02:01 INFO - blobuploader == 1.2.4 14:02:01 INFO - docopt == 0.6.1 14:02:01 INFO - manifestparser == 1.1 14:02:01 INFO - mozInstall == 1.12 14:02:01 INFO - mozcrash == 0.16 14:02:01 INFO - mozdebug == 0.1 14:02:01 INFO - mozdevice == 0.48 14:02:01 INFO - mozfile == 1.2 14:02:01 INFO - mozhttpd == 0.7 14:02:01 INFO - mozinfo == 0.9 14:02:01 INFO - mozleak == 0.1 14:02:01 INFO - mozlog == 3.1 14:02:01 INFO - moznetwork == 0.27 14:02:01 INFO - mozprocess == 0.22 14:02:01 INFO - mozprofile == 0.28 14:02:01 INFO - mozrunner == 6.11 14:02:01 INFO - mozscreenshot == 0.1 14:02:01 INFO - mozsystemmonitor == 0.0 14:02:01 INFO - moztest == 0.7 14:02:01 INFO - mozversion == 1.4 14:02:01 INFO - psutil == 3.1.1 14:02:01 INFO - requests == 1.2.3 14:02:01 INFO - wsgiref == 0.1.2 14:02:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:01 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 0x7f39d5d91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aad920>, '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 0x2aae820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aaecb0>, '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': '745a4373a2a16df560f216e000000264-1457126135.895393-1607768215', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:02:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 14:02:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:02:01 INFO - Using env: {'DISPLAY': ':0', 14:02:01 INFO - 'HOME': '/home/cltbld', 14:02:01 INFO - 'LANG': 'en_US.UTF-8', 14:02:01 INFO - 'LANGUAGE': 'en_US:en', 14:02:01 INFO - 'LOGNAME': 'cltbld', 14:02:01 INFO - 'MAIL': '/var/mail/cltbld', 14:02:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:01 INFO - 'MOZ_NO_REMOTE': '1', 14:02:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:01 INFO - 'NO_EM_RESTART': '1', 14:02:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:02:01 INFO - 'PWD': '/builds/slave/test-pgo', 14:02:01 INFO - 'SHELL': '/bin/bash', 14:02:01 INFO - 'SHLVL': '1', 14:02:01 INFO - 'TERM': 'linux', 14:02:01 INFO - 'TMOUT': '86400', 14:02:01 INFO - 'USER': 'cltbld', 14:02:01 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457126135.895393-1607768215', 14:02:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:01 INFO - '_': '/tools/buildbot/bin/python'} 14:02:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 14:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 14:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 14:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 14:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 14:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 14:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 14:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 14:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 14:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 14:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 14:02:01 INFO - Cleaning up... 14:02:01 INFO - Return code: 0 14:02:01 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:01 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 0x7f39d5d91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aad920>, '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 0x2aae820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aaecb0>, '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': '745a4373a2a16df560f216e000000264-1457126135.895393-1607768215', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:02:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 14:02:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:02:01 INFO - Using env: {'DISPLAY': ':0', 14:02:01 INFO - 'HOME': '/home/cltbld', 14:02:01 INFO - 'LANG': 'en_US.UTF-8', 14:02:01 INFO - 'LANGUAGE': 'en_US:en', 14:02:01 INFO - 'LOGNAME': 'cltbld', 14:02:01 INFO - 'MAIL': '/var/mail/cltbld', 14:02:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:01 INFO - 'MOZ_NO_REMOTE': '1', 14:02:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:01 INFO - 'NO_EM_RESTART': '1', 14:02:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:02:01 INFO - 'PWD': '/builds/slave/test-pgo', 14:02:01 INFO - 'SHELL': '/bin/bash', 14:02:01 INFO - 'SHLVL': '1', 14:02:01 INFO - 'TERM': 'linux', 14:02:01 INFO - 'TMOUT': '86400', 14:02:01 INFO - 'USER': 'cltbld', 14:02:01 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457126135.895393-1607768215', 14:02:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:01 INFO - '_': '/tools/buildbot/bin/python'} 14:02:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:01 INFO - Downloading/unpacking jsonschema 14:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:02:03 INFO - Downloading/unpacking functools32 (from jsonschema) 14:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:03 INFO - Downloading functools32-3.2.3-2.tar.gz 14:02:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:02:03 INFO - warning: no files found matching '*.txt' 14:02:03 INFO - no previously-included directories found matching 'build' 14:02:03 INFO - no previously-included directories found matching 'dist' 14:02:03 INFO - no previously-included directories found matching '.git*' 14:02:04 INFO - Installing collected packages: jsonschema, functools32 14:02:04 INFO - Running setup.py install for functools32 14:02:04 INFO - warning: no files found matching '*.txt' 14:02:04 INFO - no previously-included directories found matching 'build' 14:02:04 INFO - no previously-included directories found matching 'dist' 14:02:04 INFO - no previously-included directories found matching '.git*' 14:02:04 INFO - Successfully installed jsonschema functools32 14:02:04 INFO - Cleaning up... 14:02:04 INFO - Return code: 0 14:02:04 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:02:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f39d5d91f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aad920>, '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 0x2aae820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aaecb0>, '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': '745a4373a2a16df560f216e000000264-1457126135.895393-1607768215', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:02:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 14:02:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:02:04 INFO - Using env: {'DISPLAY': ':0', 14:02:04 INFO - 'HOME': '/home/cltbld', 14:02:04 INFO - 'LANG': 'en_US.UTF-8', 14:02:04 INFO - 'LANGUAGE': 'en_US:en', 14:02:04 INFO - 'LOGNAME': 'cltbld', 14:02:04 INFO - 'MAIL': '/var/mail/cltbld', 14:02:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:04 INFO - 'MOZ_NO_REMOTE': '1', 14:02:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:04 INFO - 'NO_EM_RESTART': '1', 14:02:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:02:04 INFO - 'PWD': '/builds/slave/test-pgo', 14:02:04 INFO - 'SHELL': '/bin/bash', 14:02:04 INFO - 'SHLVL': '1', 14:02:04 INFO - 'TERM': 'linux', 14:02:04 INFO - 'TMOUT': '86400', 14:02:04 INFO - 'USER': 'cltbld', 14:02:04 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457126135.895393-1607768215', 14:02:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:04 INFO - '_': '/tools/buildbot/bin/python'} 14:02:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:04 INFO - Downloading/unpacking flake8 14:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:02:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:02:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:02:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:02:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:02:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:02:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:02:06 INFO - no previously-included directories found matching 'docs/_build' 14:02:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:02:07 INFO - Running setup.py install for pep8 14:02:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:02:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:02:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:02:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:02:07 INFO - no previously-included directories found matching 'docs/_build' 14:02:07 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:02:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:02:07 INFO - Cleaning up... 14:02:07 INFO - Return code: 0 14:02:07 INFO - Running post-action listener: _resource_record_post_action 14:02:07 INFO - Running post-action listener: _start_resource_monitoring 14:02:07 INFO - Starting resource monitoring. 14:02:07 INFO - ##### 14:02:07 INFO - ##### Running install step. 14:02:07 INFO - ##### 14:02:07 INFO - Running pre-action listener: _resource_record_pre_action 14:02:07 INFO - Running main action method: install 14:02:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:02:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:02:07 INFO - Reading from file tmpfile_stdout 14:02:07 INFO - Detecting whether we're running mozinstall >=1.0... 14:02:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:02:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:02:07 INFO - Reading from file tmpfile_stdout 14:02:07 INFO - Output received: 14:02:07 INFO - Usage: mozinstall [options] installer 14:02:07 INFO - Options: 14:02:07 INFO - -h, --help show this help message and exit 14:02:07 INFO - -d DEST, --destination=DEST 14:02:07 INFO - Directory to install application into. [default: 14:02:07 INFO - "/builds/slave/test-pgo"] 14:02:07 INFO - --app=APP Application being installed. [default: firefox] 14:02:07 INFO - mkdir: /builds/slave/test-pgo/build/application 14:02:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 14:02:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 14:02:23 INFO - Reading from file tmpfile_stdout 14:02:23 INFO - Output received: 14:02:23 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:02:23 INFO - Running post-action listener: _resource_record_post_action 14:02:23 INFO - ##### 14:02:23 INFO - ##### Running run-tests step. 14:02:23 INFO - ##### 14:02:23 INFO - Running pre-action listener: _resource_record_pre_action 14:02:23 INFO - Running main action method: run_tests 14:02:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:02:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:02:23 INFO - Python 2.7.3 14:02:23 INFO - Return code: 0 14:02:23 INFO - grabbing minidump binary from tooltool 14:02:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:23 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 0x2aad920>, '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 0x2aae820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aaecb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:02:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 14:02:23 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:02:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:02:23 INFO - Return code: 0 14:02:23 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:02:23 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:02:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:02:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:02:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:02:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:02:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:02:24 INFO - Return code: 0 14:02:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/clHn5J3tRcWBvu1-cRevfg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 14:02:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/clHn5J3tRcWBvu1-cRevfg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 14:02:24 INFO - Using env: {'DISPLAY': ':0', 14:02:24 INFO - 'HOME': '/home/cltbld', 14:02:24 INFO - 'LANG': 'en_US.UTF-8', 14:02:24 INFO - 'LANGUAGE': 'en_US:en', 14:02:24 INFO - 'LOGNAME': 'cltbld', 14:02:24 INFO - 'MAIL': '/var/mail/cltbld', 14:02:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:02:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:02:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:24 INFO - 'MOZ_NO_REMOTE': '1', 14:02:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:02:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:24 INFO - 'NO_EM_RESTART': '1', 14:02:24 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:02:24 INFO - 'PWD': '/builds/slave/test-pgo', 14:02:24 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:02:24 INFO - 'SHELL': '/bin/bash', 14:02:24 INFO - 'SHLVL': '1', 14:02:24 INFO - 'TERM': 'linux', 14:02:24 INFO - 'TMOUT': '86400', 14:02:24 INFO - 'USER': 'cltbld', 14:02:24 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1457126135.895393-1607768215', 14:02:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:24 INFO - '_': '/tools/buildbot/bin/python'} 14:02:24 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/clHn5J3tRcWBvu1-cRevfg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:02:24 INFO - mozversion application_buildid: 20160304113025 14:02:24 INFO - mozversion application_changeset: b479a3b0fde9a3dfc67dfb6dbf35d3c958fd1a9c 14:02:24 INFO - mozversion application_display_name: Nightly 14:02:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:02:24 INFO - mozversion application_name: Firefox 14:02:24 INFO - mozversion application_remotingname: firefox 14:02:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:02:24 INFO - mozversion application_vendor: Mozilla 14:02:24 INFO - mozversion application_version: 47.0a1 14:02:24 INFO - mozversion platform_buildid: 20160304113025 14:02:24 INFO - mozversion platform_changeset: b479a3b0fde9a3dfc67dfb6dbf35d3c958fd1a9c 14:02:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:02:24 INFO - mozversion platform_version: 47.0a1 14:02:24 INFO - using testdate: 1457128944 14:02:24 INFO - actual date: 1457128944 14:02:24 INFO - starting webserver on 'localhost:45647' 14:02:24 INFO - SUITE-START | Running 2 tests 14:02:24 INFO - TEST-START | dromaeo_css 14:02:24 INFO - operating with platform_type : linux_ 14:02:24 INFO - Initialising browser for dromaeo_css test... 14:02:24 INFO - TEST-INFO | started process 23182 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXqSdqV/profile http://localhost:45647/getInfo.html) 14:02:29 INFO - PROCESS | 23182 | __metrics Screen width/height:1600/1200 14:02:29 INFO - PROCESS | 23182 | colorDepth:24 14:02:29 INFO - PROCESS | 23182 | Browser inner width/height: 1024/697 14:02:29 INFO - PROCESS | 23182 | __metrics 14:02:30 INFO - PROCESS | 23182 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:02:31 INFO - TEST-INFO | 23182: exit 0 14:02:31 INFO - Browser initialized. 14:02:31 INFO - Running cycle 1/1 for dromaeo_css test... 14:02:31 INFO - TEST-INFO | started process 23279 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXqSdqV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:02:43 INFO - PROCESS | 23279 | RSS: Main: 153509888 14:02:43 INFO - PROCESS | 23279 | 14:03:34 INFO - PROCESS | 23279 | 1457129014571 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:05:42 INFO - PROCESS | 23279 | Cycle 1(1): loaded http://localhost:45647/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45647/tests/dromaeo/cssquery-ext.html) 14:05:43 INFO - PROCESS | 23279 | RSS: Main: 264134656 14:05:43 INFO - PROCESS | 23279 | 14:08:45 INFO - PROCESS | 23279 | Cycle 1(1): loaded http://localhost:45647/tests/dromaeo/cssquery-ext.html (next: http://localhost:45647/tests/dromaeo/cssquery-jquery.html) 14:08:46 INFO - PROCESS | 23279 | RSS: Main: 235913216 14:08:46 INFO - PROCESS | 23279 | 14:11:48 INFO - PROCESS | 23279 | Cycle 1(1): loaded http://localhost:45647/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45647/tests/dromaeo/cssquery-mootools.html) 14:11:49 INFO - PROCESS | 23279 | RSS: Main: 243933184 14:11:49 INFO - PROCESS | 23279 | 14:14:50 INFO - PROCESS | 23279 | Cycle 1(1): loaded http://localhost:45647/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45647/tests/dromaeo/cssquery-prototype.html) 14:14:51 INFO - PROCESS | 23279 | RSS: Main: 206594048 14:14:51 INFO - PROCESS | 23279 | 14:17:53 INFO - PROCESS | 23279 | Cycle 1(1): loaded http://localhost:45647/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45647/tests/dromaeo/cssquery-yui.html) 14:17:54 INFO - PROCESS | 23279 | RSS: Main: 217018368 14:17:54 INFO - PROCESS | 23279 | 14:20:57 INFO - PROCESS | 23279 | Cycle 1(1): loaded http://localhost:45647/tests/dromaeo/cssquery-yui.html (next: http://localhost:45647/tests/dromaeo/cssquery-dojo.html) 14:20:57 INFO - PROCESS | 23279 | RSS: Main: 276647936 14:20:57 INFO - PROCESS | 23279 | 14:20:57 INFO - PROCESS | 23279 | __start_tp_report 14:20:57 INFO - PROCESS | 23279 | _x_x_mozilla_page_load 14:20:57 INFO - PROCESS | 23279 | _x_x_mozilla_page_load_details 14:20:57 INFO - PROCESS | 23279 | |i|pagename|runs| 14:20:57 INFO - PROCESS | 23279 | |0;dojo.html;3154.6056742907135;3189.091109033926;3198.9680103198975;3200.4399230134736;3234.126785767842;5013.323201367814;5100.948990510094;5156.149235376159;5162.586993040557;5208.76560554775;5046.596272298217;5083.974580127104;5085.821996230133;5104.591632669387;5163.432022477534;4647.34937108805;4678.204705200115;4682.227432473638;4745.738984355859;4822.879428014293;4651.720896746206;4668;4748.477667456577;4763.2378819388905;4822.541858523452;4665.440147182359;4686.08621318843;4687.648426368002;4716.834910778123;4723.291506274069;4655.2784318430695;4673.415823022122;4696.178168820443;4696.741679207642;4719.5752382285755;4621.930671039937;4628.421447319085;4665.766711664437;4670.136024835382;4683.8360657376825;4873.415190177166;4883.511648835123;4893.339399181101;4899.608031357483;4908.288298196777;5389.865253368658;5394.73026348681;5404.405515393303;5407.945920540784;5461.1262198048125;5377.435369286247;5451.236826844245;5452.672839629635;5519.668819870821;5561.193626924114;5160.225966105077;5162.74186290684;5175.0167468180925;5176.456472070416;5217.3999990000875;5610.438956104438;5615.185798059259;5623.409541998113;5625.943740562624;5628.549716022709;5338.8665283367445;5417.729113544307;5419.051665958442;5456.890862182734;5496.120620700669;5546.057170281062;5562.694051827108;5572.637778544382;5576.693281869536;5590.273264475592;5403.405625381205;5530.640508366943;5579.218909352694;5584.274044374287;5615.578831587647;5503.449655034465;5514.420985796514;5535.640183388147;5538.778448862;5597.776088956478;4244.830206791756;4248.044190057274;4249.022724773319;4261.786910654455;4288.935665965013;3784.1863999239745;3809.1429428378947;3836.290286297044;3852.9807350963065;3867.916983244696;5141.640085194075;5151.639385243072;5178.326817513699;5187.19598462239;5226.398964119099;5491.176323551419;5508.283923090053;5516.062269414209;5530.281063461724;5568.582356323292;4960.156773348539;5124.743762811919;5171.5862730981435;5194.818181363634;5239.187925871496;4698.3187437821325;4718.504557021532;4720.0087981523575;4749.4775574686755;4751.596114330251;5731.942680573141;5732.3407808101765;5735.627184233012;5736.627119237236;5739.311282646026;5404.135338345845;5495.203195536545;5509.559235261089;5518.779248830002;5530.225768392509;5622.409646987007;5639.661620302795;5652.095664693794;5688.857778555569;5694.316681998021;5413.945860541502;5417.918731218956;5419.2413062170535;5422.132458806572;5464.836054918359;5317.282166907418;5515.779368825362;5543.722813859372;5564.248826408383;5617.5505959522325;5385.138377859524;5406;5409.107497262908;5414.756335964812;5415.052365835884;5253.737313134405;5366.436524165063;5380.650257733235;5385.946140538701;5431.945680543144;5291.417944026231;5341.439148889466;5354.063038968243;5355.5983301253345;5407.107827208467;5381.085215513293;5404.918926216032;5417.187421886749;5425.430329815313;5464.754086066216;5203.791848326176;5255.2379904912805;5278.313819203632;5310.893782124259;5319.973400132974 14:20:57 INFO - PROCESS | 23279 | |1;ext.html;524.6956765076256;527.8944211157769;578.7453520451003;588.3910152991655;593.8693487432764;28456.304709722895;29164.416711665755;29171.270718232;29184.854075729618;29238.853805730996;37232.81383593085;37421.62578374215;37642.24715505688;37774.8111259444;37787.24425511495;8436.957815210915;8582.44214126083;8586.742397728078;8604;8608.698695545658;8700.738977830644;8867.113288671146;8872.911270887273;8876.289896808239;8883.333749968779;8837.072107428723;8908.51003194824;8915.821683566324;8921.464712117262;8931;8759.16787905148;8805.163509466622;8819.29445644347;8890.44417226986;8890.511021893826;8696.913030869673;8829.293656507529;8834.425762325429;8839.292856571523;8843.911560884373;39949.40075898864;40206.19587608232;40349;40543.59456405428;40604.39093413601;3524.947125793115;3555.306715190539;4072.6334629883454;4162.084341444877;4215.852445164435;29982;30290.242743931358;30494;30544.389112217854;31263.37473250545;3865.439511270878;3947.50656167979;3981.2634662587225;3988;4069.0844559974066;200448;200535;200786;201874.99999999854;201937;56377.43622563804;57494.53801888814;57513.71243143841;57516.42483575195;57548;61083;61193.38806611966;61588.69205653943;61596.38403615906;61707.6914615424;16135.273912673958;16316.021038737714;16326.102064386572;16389.262483188286;16391.098489583186;12514.061445391631;12541.059420543314;12577.937110314573;12594.81107783384;12597.559085431965;17641.79173722415;19736.70394944077;19779;19854.50363740918;19910.50223744418;6189.81430557084;7521.5111017783665;7721.53670779755;7887.763367098996;7930.960345198352;947.6493697332031;949.8955114937352;990.1732053735068;1052.7736536644659;1091.4542728635681;26098;28066.579001314996;28929.42141157165;29260;29505.409891802043;1062.3413483640193;1065.8667666541683;1073.9731506712394;1082.8105081610686;1097.1825989637612;14913.70172596542;15148.545543633709;15263.3894644213;15361;15406;297754;298936;300919;300920;301482;53828.46171538234;54185.1872221917;54337.45662543324;54366.72816635892;54377.456225437236;1126.8366086917351;1316.5063101336998;1322.2463195978391;1360.0343755933397;1372.1218420211073;25126.623100653138;26362;26551.601725974513;26755.33111672146;26857.194284171506;39829.80085099556;40140.197196055335;40276.56957734588;40297;40311.1937761249;172159.6448337406;173494;173609;173802;173811;26628.600570991064;32085.679143209203;32510.83744581262;32576.185595360304;32645;37376.6262337384;37997.81001094977;38563.2287354257;38583.80708096441;39151;34456.13859653529;34674.47988280228;34826;35336;35375;34979.65020349764;35184.12039699028;35302.29395412129;35638.109047274025;35672;34068.318633627685;34810.12974675552;34938.65061349354;35229.64770352366;35291.647083528835;29804.55293170561;31185.8440707795;31634;32028.67971320257;32094.358112837144;24670;24990.875045624656;25013.11457391342;25067.49865002726;25236.369090772878 14:20:57 INFO - PROCESS | 23279 | |2;jquery.html;354.6187848063333;362.8113381041857;364.58801554243706;366.3826452427661;369.57683452446946;16437.506874793762;16619.16904154792;16944.237509312065;16963.201071823136;16965.236564354604;16559.66880662386;16961.151942402892;17289.827101728977;17297.39459118931;17302.56743581408;5188.455212202721;5223.8432847014465;5446.700431476267;5451.454854514556;5452.509274165324;5322.547583455411;5426.023315803154;5430;5433.293671822657;5438.184272359138;5081.161608334621;5277.340332458442;5278.894422111574;5395.622306438551;5406.162044883049;5111;5214.348206474191;5219.712915789611;5267.499587539178;5290.470952904717;5273.683578985235;5300.549453296474;5302.151655735102;5307.548858347007;5308.442613525563;12540.686482838002;12769.425375858016;12786.041046921519;17883.28466861324;19283.614327713367;2083.364573804989;2095.497080700636;2271.670607761882;2281.7261928568514;2297.1500544798364;9445;9503.334766566342;10589.299728569242;11292.717682057932;12690.238585684796;1811.4746723450316;1860.6650802855481;1870.69133592957;1954.4625228062255;1997.900104994759;47152.52847471516;55745.44254557403;56980.71509642467;63058.684706576176;64483.35516644821;8923;9764.267679924034;9819;10081.243906707026;10390.376577405379;12730.936345318214;13131.671708207372;13135.802962955564;13167.802482962763;13189.802152967713;7481.738139165103;7571.3564347030015;7577.204393538709;7697.268114674153;7846.33306168982;7530.9246907531315;7561.2060733622175;7622.2758837910305;7687.6156192190165;7725.7295994641045;4458.554144585581;4487.439070116236;4500.504944456107;4506.616937560344;4548.909021819545;1766.3287950578697;1796.8023517413073;1817.274587096447;1846.2614954018231;1852.397970659541;899.2491269789799;919.0901008002163;945.3666043750703;999.4003597841237;1008.2387797213057;15648;16597.41909033178;16703;17055.31778728862;17181.91409042947;904.7964208053266;938.7934654376163;952.2619969523674;958.8226178157063;963.2775418436173;9205.539723013822;9680.370775899544;9686.806263874683;9703.514824258758;9855.852162217572;424226;427469;446590;447424;447722;69631;69932.65033674799;71809.2819071813;72618.2738172622;72858;993.8857031441332;1001.2690735762789;1002.3334482569155;1005.7435353984833;1020.4081632653043;14821.777673334693;14920.253987300808;14959.850401496282;14994.250287485364;15427.228638568251;33773.83113084419;33837.492437612964;33852.66147338495;33876;33942.15144621404;47015;47023.52976470192;47306.29040564325;47325.52674473211;47585.04829903452;7727.381809455118;7750.224977502205;7837.647305871364;7903.802404939923;7939.325157361689;8654.82690346177;11436.428178591204;11593.88406115928;11863.288202707865;12170.878291216974;10368.22238332113;10515.894841051491;10602;10702.625408110678;10841;10406.323588966692;10584.84122738175;10640.308379955279;10697.572097116028;10757.784844303227;10429.739256518647;10705.304155229886;10807.405592692478;10958.671239862817;11227.71930701739;7753.224677532427;7877.566733829465;7882.108294009282;8105.797355066171;8165.142660020612;10762.085222756154;10868.891311086787;10876.18428617841;10907.29102608328;10953.780924381626 14:20:57 INFO - PROCESS | 23279 | |3;mootools.html;1280.5838102616651;1451.8185226846645;1459.919704416257;1604.6549991751772;1785.803561608223;7289.125304963405;7443.813904652387;7468.103827540689;7469.962650186755;7475.73834915778;7264.237255088219;7406.222346653604;7423.740169094082;7429.814254643623;7431.739889103883;1947.3379051122615;2216.966745498819;2263.15131825565;2268.6029944759684;2286.6112760830697;2267.7051983242154;2277.39648993017;2279.601069812776;2280.464090938628;2280.703508543887;2208.8785116818567;2269.931902042933;2276.4195130241765;2277.271273192579;2285.7714228577092;2236.194969810867;2244.6408574628063;2263.9434014149697;2264.773522647722;2281.452451411666;2211.060299372776;2230.208276062007;2231.141010710872;2235.698180745595;2244.7418546866993;7645.579493127876;7702.345300649452;7709.267619576131;7710.653020614086;7726.227377262285;4592;4663.090697314025;4681.6020638245445;4689.155951928651;4718;2908.3020075181803;2938.7942844000927;2990.1627544287635;2992.880284788606;3050.4661684205175;937.6671281694968;949.3212353167519;949.4398305000083;964.5273815830262;1033.731229880229;10469.37183768984;10514.421706806123;10538.683839484751;10562.630307939186;10600.522976466078;4129.132882094734;4211.810468528924;4276.8289268429535;4326.091520780671;4326.502452217972;8969.416987895896;8995.955020224857;9015.954920225488;9021.188093071654;9048.321375896834;4172.144710334374;4692.906141877143;4736.289556566542;4739.004808990082;4741.952580474152;4144.48193975753;4188.68584856137;4202.2646036943415;4205.306124489425;4206.137741762931;3557.5553055868018;3622.9094272643397;3629.637036296402;3670.724695647837;3685.3734865073;1160.6692092753694;1189.6133756528989;1193.9641810745518;1194.1103877611063;1196.7845787758113;1151.7293436042523;1153.4866984192122;1254.0782524844233;1325.6023193042242;1347.1916849889988;7191.7842464726145;7284.70861165558;7290.890636640454;7303.160136584254;7361.043064401593;478.1107140718261;484.6074679509608;486.41144215498934;486.5134865134865;488.98044078237183;5511.503964643121;5568.693721845257;5573.303337082864;5580;5607.52336051432;8957.910420895838;9240.7689807754;9336.579853906454;9488.810223795486;9493.288003399774;9248.445093294424;9293.070692930789;9311;9344.392614480174;9364.438133712;7196.316349946746;7278.636068196569;7344.449166312548;7419.332260096509;7419.85160296791;6984.930150698631;7026.473014523829;7028.367446929801;7042.084529011196;7105.502614816914;8141.755747327589;8190.7952301192945;8218.506889586644;8425.157484251526;8482;8497.447665901696;8672.566371681516;8821.603027863634;8845.734627961172;8847.690330838648;5957.702114894151;6283.277423096402;6471.805845824444;6515.381038801306;6592.571482853599;7208.927910720826;7242.89135662955;7250.927490725026;7282.453815963718;7290.56256624583;6404.583702059351;6594.142761440982;6635.668216589248;6684.4318232950745;6727.125473688389;6384.521160912857;6403.743850246125;6588.4399826013405;6634;6703.899441508479;6876.277990810893;6909.205441374306;6919.827004324932;6928.341807528277;6931.306869313028;6345.206849143857;6392.232932048184;6408.935910640834;6415.839604009937;6416.807495775134;6333.524985626004;6365.681715914093;6376;6379.075034120119;6386 14:20:57 INFO - PROCESS | 23279 | |4;prototype.html;344.5882170805887;350.69664739999894;351.03640506808796;351.53948327690745;355.8718861209964;5990.460858522738;6010.429009244121;6016.3382027976995;6034.125051867482;6067.362926892679;5919.88160236795;5934.109883517474;5955.166276721263;5964.254468191476;5964.880702385961;4373.890652733675;4529.773511324437;4609.939713865813;4634.536546345355;4638.652101092414;4602.585767280944;4616.3537104805355;4630.467496237925;4636.698614590057;4653.185692503798;4580.908381832362;4582;4587.724736515803;4596.678232523725;4599.563041511051;4394.1651086293505;4492.685512014144;4554.88612784683;4572.657050721209;4581.61056310214;4033.737807042533;4043.3126368517424;4050.10897602527;4051.6758659307184;4069.7965101744794;5674.063779476382;5682.119271512922;5690.430956904318;5696.458836410535;5720.11338242573;5357.303550538444;5364.624476286662;5365.222042803811;5371.516563509303;5374.811881584164;6271.686415679198;6290.465310448617;6315.179026726542;6328.841778955517;6329.1772069631115;4277.358396240557;4416.359627853975;4430.822767089313;4435.379046933432;4520.3219517072375;6581.3418658133805;6637.435817955479;6651.368120028589;6660.567063140928;6662.133922590081;4510.503844577094;4513.413256276663;4516.548345165457;4519.728816271035;4521.073179998092;4528.162289976299;4534.433195850519;4540.250858608359;4555.40779698637;4580.267157254823;5287.312649355559;5295.894082118336;5297.311349524537;5300;5300.575953923677;6258;6266.874662506724;6393.552451328363;6409.327020662857;6409.391107844747;1572.8820338474661;1574.3230410923413;1577.597712583284;1583.4853672556465;1584.7622856571606;1000.4247557654378;1050.99474502627;1064.3081996702206;1071.4803320389606;1099.923005389631;5929.673867937305;5984.461398474158;5989.580729348903;5993.280806303184;5996;6464;6467.773627923;6473.029045643191;6482.157319548429;6483.481321494269;5943.07882278239;5983.222181116514;5984.700764961822;5985.521158307325;5986.132010858489;3456.187795867969;3494.4408894576745;3500.4224302990233;3500.632433594487;3501.28223714138;6610.603363798187;6667.666616669244;6751.392374686302;6756.695948682321;6757.8648427031185;6561.507886908501;6574.506911981621;6615.17310336208;6615.4046135848;6623.569467984566;6634.237062737847;6666.733330666719;6684.86630267392;6728.42808361285;6738.494612904052;6395.616263024233;6425.421712045938;6437.678116094083;6443.548951573345;6449.097126402401;6227.844303892258;6380.330065343072;6392.744290228339;6395.808125756234;6408.487321014401;6705.899411508929;6716.798496045127;6728.629925353956;6735.831604209738;6742.6628668567355;4506.391637128946;4510.481294651026;4513.413256276663;4515.14212299662;4520.2089634314525;6470.6441145737435;6476.5466417350335;6476.643784591893;6478.870422591616;6481.416672499309;6287.30839607652;6342.809715708536;6343.111964324906;6346.524010699124;6351.333110023381;6026.789062382795;6258.624482531062;6264.154339164154;6273.15312432834;6277.748890044347;6133.723982420713;6138.324784273637;6159.322474527888;6160.44555989963;6161.507079433724;6232.906506402498;6262.091996660368;6267.4986001120715;6284.654344011124;6296.496280297657;6030.90953635687;6114.816555503342;6125.326214116532;6125.6018358808315;6132.693365331805 14:20:57 INFO - PROCESS | 23279 | |5;yui.html;755.2296657409439;771.651742431399;777.308195705822;781.5037451218475;789.6170357376672;13839.723205535884;14072.648183795398;14078;14109.858901410982;14150.080244784094;12885.5490057848;12893.355332233374;12927;12928.224306541613;12949.028822838278;817.2481317188186;829.8464784014947;833.9291160251386;834.1283358889945;835.7701632051173;680.2483256002121;816.603947085663;832.9167083291653;837.6440012994453;837.7026155714725;856.4861083349971;861.6079683743882;870.2863651805523;872.1757938747886;872.9083446238149;701.5475018613017;850.808568072185;864.6671031652796;867.0159369116036;868.6655637579546;619.1239396254294;630.6310808177221;631.2929518938818;632.0172132334219;632.822809613309;12111.515539378413;12148.939255303756;12151.453184606715;12163;12163.695907602292;12223.511059557695;13011.544595939191;13043.08698391113;13089.934550327187;13107.737845243042;10367.77792734179;10487.423191724452;10560.419176945265;10600.469976501221;10688.305260158142;3535.522704434894;3574.12433953683;3610.765300255475;3635.1820840310984;3685.2261025184475;45954.31068533975;45985.77007114943;46013;46016;46207.30689039667;9549.188318992963;9663.226941844636;9765.609375625038;9882.851757223647;10056.49717514136;16923;17018.829811701973;17041.40355087566;17068.829311706722;17083.658326833644;7079.469039822034;7128.215896251409;7236.746713864989;7303.45224108194;7307.7807665770115;4208.342890194206;4303.2469317869245;4330.39374487572;4430.069685366045;4476.485204201494;3175.984120079385;3204.295055087877;3208.3743669984597;3214.72674822638;3217.6782321767637;525.2856115682745;532.5819231903015;538.8388023808699;541.8103663717667;545.2530033853645;453.3294808630208;528.9973550132224;543.4185421598851;554.2572952244012;569.35947059558;7827.726029588937;7867.331276841418;7893.447458677838;7971.322437592754;8141.674333026731;561.430148399375;573.3378145944156;599.8200539838031;639.6002498438476;641.5573254454412;3584.390653588896;3666.50502182202;3729.813509324523;3819.7394859696233;3836.405357169643;51822.48177518252;53625.463745362824;53998.19002714963;54112.72943635335;54211.18683219755;49035.79616116482;49835;50224.748876255384;50344.74827625912;51827.74086129545;43128.56871431245;43767;44028.77985610116;44196;44579.777101113636;7946.404019698662;7970.242826931432;7982.181916243169;8240.340772738287;8311.95844020776;31699.20751981219;32331.35337293288;32465.188370290933;33560;33827.32345353128;37840.62159378371;37947;38910.22179556336;41264;41549.58450415457;10306.639267625596;10442.63450779219;10528.736781580521;10575.894241057491;10760.762512311185;11238;11303.604373846876;11361.829572556253;11681.299122052704;11982.520699171935;10480;10491.370517768959;10603.89396106029;10610.310329828537;10929;9927.503624818586;10214;10329.638462653771;10479.318844275098;10537;10431.37411755297;10472.476376181314;10685.091767199565;10799.406032667965;11078.11375090007;9193.713614671457;9325.21925899406;9470.905290947003;9702.660406885725;9909.851352229578;8151.918480815353;8707.390482666153;8807.559622019002;8895.822083558422;9018.954905225432 14:20:57 INFO - PROCESS | 23279 | __end_tp_report 14:20:57 INFO - PROCESS | 23279 | __start_cc_report 14:20:57 INFO - PROCESS | 23279 | _x_x_mozilla_cycle_collect,833 14:20:57 INFO - PROCESS | 23279 | __end_cc_report 14:20:57 INFO - PROCESS | 23279 | __startTimestamp1457130057490__endTimestamp 14:20:57 INFO - PROCESS | 23279 | 14:20:57 INFO - PROCESS | 23279 | ------- Summary: start ------- 14:20:57 INFO - PROCESS | 23279 | Number of tests: 6 14:20:57 INFO - PROCESS | 23279 | 14:20:57 INFO - PROCESS | 23279 | [#0] dojo.html Cycles:165 Average:5116.59 Median:5319.97 stddev:549.95 (10.3%) stddev-sans-first:529.66 14:20:57 INFO - PROCESS | 23279 | Values: 3154.6 3189.1 3199.0 3200.4 3234.1 5013.3 5100.9 5156.1 5162.6 5208.8 5046.6 5084.0 5085.8 5104.6 5163.4 4647.3 4678.2 4682.2 4745.7 4822.9 4651.7 4668.0 4748.5 4763.2 4822.5 4665.4 4686.1 4687.6 4716.8 4723.3 4655.3 4673.4 4696.2 4696.7 4719.6 4621.9 4628.4 4665.8 4670.1 4683.8 4873.4 4883.5 4893.3 4899.6 4908.3 5389.9 5394.7 5404.4 5407.9 5461.1 5377.4 5451.2 5452.7 5519.7 5561.2 5160.2 5162.7 5175.0 5176.5 5217.4 5610.4 5615.2 5623.4 5625.9 5628.5 5338.9 5417.7 5419.1 5456.9 5496.1 5546.1 5562.7 5572.6 5576.7 5590.3 5403.4 5530.6 5579.2 5584.3 5615.6 5503.4 5514.4 5535.6 5538.8 5597.8 4244.8 4248.0 4249.0 4261.8 4288.9 3784.2 3809.1 3836.3 3853.0 3867.9 5141.6 5151.6 5178.3 5187.2 5226.4 5491.2 5508.3 5516.1 5530.3 5568.6 4960.2 5124.7 5171.6 5194.8 5239.2 4698.3 4718.5 4720.0 4749.5 4751.6 5731.9 5732.3 5735.6 5736.6 5739.3 5404.1 5495.2 5509.6 5518.8 5530.2 5622.4 5639.7 5652.1 5688.9 5694.3 5413.9 5417.9 5419.2 5422.1 5464.8 5317.3 5515.8 5543.7 5564.2 5617.6 5385.1 5406.0 5409.1 5414.8 5415.1 5253.7 5366.4 5380.7 5385.9 5431.9 5291.4 5341.4 5354.1 5355.6 5407.1 5381.1 5404.9 5417.2 5425.4 5464.8 5203.8 5255.2 5278.3 5310.9 5320.0 14:20:57 INFO - PROCESS | 23279 | 14:20:57 INFO - PROCESS | 23279 | [#1] ext.html Cycles:180 Average:39933.20 Median:19377.30 stddev:60326.24 (311.3%) stddev-sans-first:60422.90 14:20:57 INFO - PROCESS | 23279 | Values: 524.7 527.9 578.7 588.4 593.9 28456.3 29164.4 29171.3 29184.9 29238.9 37232.8 37421.6 37642.2 37774.8 37787.2 8437.0 8582.4 8586.7 8604.0 8608.7 8700.7 8867.1 8872.9 8876.3 8883.3 8837.1 8908.5 8915.8 8921.5 8931.0 8759.2 8805.2 8819.3 8890.4 8890.5 8696.9 8829.3 8834.4 8839.3 8843.9 39949.4 40206.2 40349.0 40543.6 40604.4 3524.9 3555.3 4072.6 4162.1 4215.9 29982.0 30290.2 30494.0 30544.4 31263.4 3865.4 3947.5 3981.3 3988.0 4069.1 200448.0 200535.0 200786.0 201875.0 201937.0 56377.4 57494.5 57513.7 57516.4 57548.0 61083.0 61193.4 61588.7 61596.4 61707.7 16135.3 16316.0 16326.1 16389.3 16391.1 12514.1 12541.1 12577.9 12594.8 12597.6 17641.8 19736.7 19779.0 19854.5 19910.5 6189.8 7521.5 7721.5 7887.8 7931.0 947.6 949.9 990.2 1052.8 1091.5 26098.0 28066.6 28929.4 29260.0 29505.4 1062.3 1065.9 1074.0 1082.8 1097.2 14913.7 15148.5 15263.4 15361.0 15406.0 297754.0 298936.0 300919.0 300920.0 301482.0 53828.5 54185.2 54337.5 54366.7 54377.5 1126.8 1316.5 1322.2 1360.0 1372.1 25126.6 26362.0 26551.6 26755.3 26857.2 39829.8 40140.2 40276.6 40297.0 40311.2 172159.6 173494.0 173609.0 173802.0 173811.0 26628.6 32085.7 32510.8 32576.2 32645.0 37376.6 37997.8 38563.2 38583.8 39151.0 34456.1 34674.5 34826.0 35336.0 35375.0 34979.7 35184.1 35302.3 35638.1 35672.0 34068.3 34810.1 34938.7 35229.6 35291.6 29804.6 31185.8 31634.0 32028.7 32094.4 24670.0 24990.9 25013.1 25067.5 25236.4 14:20:57 INFO - PROCESS | 23279 | 14:20:57 INFO - PROCESS | 23279 | [#2] jquery.html Cycles:180 Average:24938.88 Median:215963.78 stddev:71842.25 (33.3%) stddev-sans-first:72020.07 14:20:57 INFO - PROCESS | 23279 | Values: 354.6 362.8 364.6 366.4 369.6 16437.5 16619.2 16944.2 16963.2 16965.2 16559.7 16961.2 17289.8 17297.4 17302.6 5188.5 5223.8 5446.7 5451.5 5452.5 5322.5 5426.0 5430.0 5433.3 5438.2 5081.2 5277.3 5278.9 5395.6 5406.2 5111.0 5214.3 5219.7 5267.5 5290.5 5273.7 5300.5 5302.2 5307.5 5308.4 12540.7 12769.4 12786.0 17883.3 19283.6 2083.4 2095.5 2271.7 2281.7 2297.2 9445.0 9503.3 10589.3 11292.7 12690.2 1811.5 1860.7 1870.7 1954.5 1997.9 47152.5 55745.4 56980.7 63058.7 64483.4 8923.0 9764.3 9819.0 10081.2 10390.4 12730.9 13131.7 13135.8 13167.8 13189.8 7481.7 7571.4 7577.2 7697.3 7846.3 7530.9 7561.2 7622.3 7687.6 7725.7 4458.6 4487.4 4500.5 4506.6 4548.9 1766.3 1796.8 1817.3 1846.3 1852.4 899.2 919.1 945.4 999.4 1008.2 15648.0 16597.4 16703.0 17055.3 17181.9 904.8 938.8 952.3 958.8 963.3 9205.5 9680.4 9686.8 9703.5 9855.9 424226.0 427469.0 446590.0 447424.0 447722.0 69631.0 69932.7 71809.3 72618.3 72858.0 993.9 1001.3 1002.3 1005.7 1020.4 14821.8 14920.3 14959.9 14994.3 15427.2 33773.8 33837.5 33852.7 33876.0 33942.2 47015.0 47023.5 47306.3 47325.5 47585.0 7727.4 7750.2 7837.6 7903.8 7939.3 8654.8 11436.4 11593.9 11863.3 12170.9 10368.2 10515.9 10602.0 10702.6 10841.0 10406.3 10584.8 10640.3 10697.6 10757.8 10429.7 10705.3 10807.4 10958.7 11227.7 7753.2 7877.6 7882.1 8105.8 8165.1 10762.1 10868.9 10876.2 10907.3 10953.8 14:20:57 INFO - PROCESS | 23279 | 14:20:57 INFO - PROCESS | 23279 | [#3] mootools.html Cycles:180 Average:5343.03 Median:6370.84 stddev:2801.42 (44.0%) stddev-sans-first:2792.63 14:20:57 INFO - PROCESS | 23279 | Values: 1280.6 1451.8 1459.9 1604.7 1785.8 7289.1 7443.8 7468.1 7470.0 7475.7 7264.2 7406.2 7423.7 7429.8 7431.7 1947.3 2217.0 2263.2 2268.6 2286.6 2267.7 2277.4 2279.6 2280.5 2280.7 2208.9 2269.9 2276.4 2277.3 2285.8 2236.2 2244.6 2263.9 2264.8 2281.5 2211.1 2230.2 2231.1 2235.7 2244.7 7645.6 7702.3 7709.3 7710.7 7726.2 4592.0 4663.1 4681.6 4689.2 4718.0 2908.3 2938.8 2990.2 2992.9 3050.5 937.7 949.3 949.4 964.5 1033.7 10469.4 10514.4 10538.7 10562.6 10600.5 4129.1 4211.8 4276.8 4326.1 4326.5 8969.4 8996.0 9016.0 9021.2 9048.3 4172.1 4692.9 4736.3 4739.0 4742.0 4144.5 4188.7 4202.3 4205.3 4206.1 3557.6 3622.9 3629.6 3670.7 3685.4 1160.7 1189.6 1194.0 1194.1 1196.8 1151.7 1153.5 1254.1 1325.6 1347.2 7191.8 7284.7 7290.9 7303.2 7361.0 478.1 484.6 486.4 486.5 489.0 5511.5 5568.7 5573.3 5580.0 5607.5 8957.9 9240.8 9336.6 9488.8 9493.3 9248.4 9293.1 9311.0 9344.4 9364.4 7196.3 7278.6 7344.4 7419.3 7419.9 6984.9 7026.5 7028.4 7042.1 7105.5 8141.8 8190.8 8218.5 8425.2 8482.0 8497.4 8672.6 8821.6 8845.7 8847.7 5957.7 6283.3 6471.8 6515.4 6592.6 7208.9 7242.9 7250.9 7282.5 7290.6 6404.6 6594.1 6635.7 6684.4 6727.1 6384.5 6403.7 6588.4 6634.0 6703.9 6876.3 6909.2 6919.8 6928.3 6931.3 6345.2 6392.2 6408.9 6415.8 6416.8 6333.5 6365.7 6376.0 6379.1 6386.0 14:20:57 INFO - PROCESS | 23279 | 14:20:57 INFO - PROCESS | 23279 | [#4] prototype.html Cycles:180 Average:5275.95 Median:5985.83 stddev:1575.54 (26.3%) stddev-sans-first:1535.87 14:20:57 INFO - PROCESS | 23279 | Values: 344.6 350.7 351.0 351.5 355.9 5990.5 6010.4 6016.3 6034.1 6067.4 5919.9 5934.1 5955.2 5964.3 5964.9 4373.9 4529.8 4609.9 4634.5 4638.7 4602.6 4616.4 4630.5 4636.7 4653.2 4580.9 4582.0 4587.7 4596.7 4599.6 4394.2 4492.7 4554.9 4572.7 4581.6 4033.7 4043.3 4050.1 4051.7 4069.8 5674.1 5682.1 5690.4 5696.5 5720.1 5357.3 5364.6 5365.2 5371.5 5374.8 6271.7 6290.5 6315.2 6328.8 6329.2 4277.4 4416.4 4430.8 4435.4 4520.3 6581.3 6637.4 6651.4 6660.6 6662.1 4510.5 4513.4 4516.5 4519.7 4521.1 4528.2 4534.4 4540.3 4555.4 4580.3 5287.3 5295.9 5297.3 5300.0 5300.6 6258.0 6266.9 6393.6 6409.3 6409.4 1572.9 1574.3 1577.6 1583.5 1584.8 1000.4 1051.0 1064.3 1071.5 1099.9 5929.7 5984.5 5989.6 5993.3 5996.0 6464.0 6467.8 6473.0 6482.2 6483.5 5943.1 5983.2 5984.7 5985.5 5986.1 3456.2 3494.4 3500.4 3500.6 3501.3 6610.6 6667.7 6751.4 6756.7 6757.9 6561.5 6574.5 6615.2 6615.4 6623.6 6634.2 6666.7 6684.9 6728.4 6738.5 6395.6 6425.4 6437.7 6443.5 6449.1 6227.8 6380.3 6392.7 6395.8 6408.5 6705.9 6716.8 6728.6 6735.8 6742.7 4506.4 4510.5 4513.4 4515.1 4520.2 6470.6 6476.5 6476.6 6478.9 6481.4 6287.3 6342.8 6343.1 6346.5 6351.3 6026.8 6258.6 6264.2 6273.2 6277.7 6133.7 6138.3 6159.3 6160.4 6161.5 6232.9 6262.1 6267.5 6284.7 6296.5 6030.9 6114.8 6125.3 6125.6 6132.7 14:20:57 INFO - PROCESS | 23279 | 14:20:57 INFO - PROCESS | 23279 | [#5] yui.html Cycles:180 Average:13106.76 Median:23203.82 stddev:15003.54 (64.7%) stddev-sans-first:15016.96 14:20:57 INFO - PROCESS | 23279 | Values: 755.2 771.7 777.3 781.5 789.6 13839.7 14072.6 14078.0 14109.9 14150.1 12885.5 12893.4 12927.0 12928.2 12949.0 817.2 829.8 833.9 834.1 835.8 680.2 816.6 832.9 837.6 837.7 856.5 861.6 870.3 872.2 872.9 701.5 850.8 864.7 867.0 868.7 619.1 630.6 631.3 632.0 632.8 12111.5 12148.9 12151.5 12163.0 12163.7 12223.5 13011.5 13043.1 13089.9 13107.7 10367.8 10487.4 10560.4 10600.5 10688.3 3535.5 3574.1 3610.8 3635.2 3685.2 45954.3 45985.8 46013.0 46016.0 46207.3 9549.2 9663.2 9765.6 9882.9 10056.5 16923.0 17018.8 17041.4 17068.8 17083.7 7079.5 7128.2 7236.7 7303.5 7307.8 4208.3 4303.2 4330.4 4430.1 4476.5 3176.0 3204.3 3208.4 3214.7 3217.7 525.3 532.6 538.8 541.8 545.3 453.3 529.0 543.4 554.3 569.4 7827.7 7867.3 7893.4 7971.3 8141.7 561.4 573.3 599.8 639.6 641.6 3584.4 3666.5 3729.8 3819.7 3836.4 51822.5 53625.5 53998.2 54112.7 54211.2 49035.8 49835.0 50224.7 50344.7 51827.7 43128.6 43767.0 44028.8 44196.0 44579.8 7946.4 7970.2 7982.2 8240.3 8312.0 31699.2 32331.4 32465.2 33560.0 33827.3 37840.6 37947.0 38910.2 41264.0 41549.6 10306.6 10442.6 10528.7 10575.9 10760.8 11238.0 11303.6 11361.8 11681.3 11982.5 10480.0 10491.4 10603.9 10610.3 10929.0 9927.5 10214.0 10329.6 10479.3 10537.0 10431.4 10472.5 10685.1 10799.4 11078.1 9193.7 9325.2 9470.9 9702.7 9909.9 8151.9 8707.4 8807.6 8895.8 9019.0 14:20:57 INFO - PROCESS | 23279 | -------- Summary: end -------- 14:20:57 INFO - PROCESS | 23279 | 14:20:58 INFO - TEST-INFO | 23279: exit 0 14:20:58 INFO - TEST-OK | dromaeo_css | took 1113328ms 14:20:58 INFO - TEST-START | kraken 14:20:58 INFO - operating with platform_type : linux_ 14:20:58 INFO - Initialising browser for kraken test... 14:20:58 INFO - TEST-INFO | started process 23472 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpO4SNas/profile http://localhost:45647/getInfo.html) 14:21:02 INFO - PROCESS | 23472 | __metrics Screen width/height:1600/1200 14:21:02 INFO - PROCESS | 23472 | colorDepth:24 14:21:02 INFO - PROCESS | 23472 | Browser inner width/height: 1024/697 14:21:02 INFO - PROCESS | 23472 | __metrics 14:21:03 INFO - PROCESS | 23472 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:21:04 INFO - TEST-INFO | 23472: exit 0 14:21:04 INFO - Browser initialized. 14:21:04 INFO - Running cycle 1/1 for kraken test... 14:21:04 INFO - TEST-INFO | started process 23556 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpO4SNas/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:21:16 INFO - PROCESS | 23556 | RSS: Main: 154292224 14:21:16 INFO - PROCESS | 23556 | 14:21:18 INFO - PROCESS | 23556 | Cycle 1(1): loaded http://localhost:45647/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45647/tests/kraken/driver.html?testName=audio-beat-detection) 14:21:19 INFO - PROCESS | 23556 | RSS: Main: 197804032 14:21:19 INFO - PROCESS | 23556 | 14:21:22 INFO - PROCESS | 23556 | Cycle 1(1): loaded http://localhost:45647/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45647/tests/kraken/driver.html?testName=audio-dft) 14:21:22 INFO - PROCESS | 23556 | RSS: Main: 187359232 14:21:22 INFO - PROCESS | 23556 | 14:21:25 INFO - PROCESS | 23556 | Cycle 1(1): loaded http://localhost:45647/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45647/tests/kraken/driver.html?testName=audio-fft) 14:21:26 INFO - PROCESS | 23556 | RSS: Main: 169897984 14:21:26 INFO - PROCESS | 23556 | 14:21:28 INFO - PROCESS | 23556 | Cycle 1(1): loaded http://localhost:45647/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45647/tests/kraken/driver.html?testName=audio-oscillator) 14:21:28 INFO - PROCESS | 23556 | RSS: Main: 173916160 14:21:28 INFO - PROCESS | 23556 | 14:21:30 INFO - PROCESS | 23556 | Cycle 1(1): loaded http://localhost:45647/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45647/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:21:31 INFO - PROCESS | 23556 | RSS: Main: 174465024 14:21:31 INFO - PROCESS | 23556 | 14:21:34 INFO - PROCESS | 23556 | Cycle 1(1): loaded http://localhost:45647/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45647/tests/kraken/driver.html?testName=imaging-darkroom) 14:21:35 INFO - PROCESS | 23556 | RSS: Main: 175595520 14:21:35 INFO - PROCESS | 23556 | 14:21:38 INFO - PROCESS | 23556 | Cycle 1(1): loaded http://localhost:45647/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45647/tests/kraken/driver.html?testName=imaging-desaturate) 14:21:39 INFO - PROCESS | 23556 | RSS: Main: 177049600 14:21:39 INFO - PROCESS | 23556 | 14:21:41 INFO - PROCESS | 23556 | Cycle 1(1): loaded http://localhost:45647/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45647/tests/kraken/driver.html?testName=json-parse-financial) 14:21:42 INFO - PROCESS | 23556 | RSS: Main: 176545792 14:21:42 INFO - PROCESS | 23556 | 14:21:43 INFO - PROCESS | 23556 | Cycle 1(1): loaded http://localhost:45647/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45647/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:21:44 INFO - PROCESS | 23556 | RSS: Main: 187699200 14:21:44 INFO - PROCESS | 23556 | 14:21:46 INFO - PROCESS | 23556 | Cycle 1(1): loaded http://localhost:45647/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45647/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:21:46 INFO - PROCESS | 23556 | RSS: Main: 185724928 14:21:46 INFO - PROCESS | 23556 | 14:21:48 INFO - PROCESS | 23556 | Cycle 1(1): loaded http://localhost:45647/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45647/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:21:49 INFO - PROCESS | 23556 | RSS: Main: 196427776 14:21:49 INFO - PROCESS | 23556 | 14:21:51 INFO - PROCESS | 23556 | Cycle 1(1): loaded http://localhost:45647/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45647/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:21:52 INFO - PROCESS | 23556 | RSS: Main: 202297344 14:21:52 INFO - PROCESS | 23556 | 14:21:55 INFO - PROCESS | 23556 | Cycle 1(1): loaded http://localhost:45647/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45647/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:21:55 INFO - PROCESS | 23556 | RSS: Main: 202858496 14:21:55 INFO - PROCESS | 23556 | 14:21:57 INFO - PROCESS | 23556 | Cycle 1(1): loaded http://localhost:45647/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45647/tests/kraken/driver.html?testName=ai-astar) 14:21:57 INFO - PROCESS | 23556 | RSS: Main: 262934528 14:21:57 INFO - PROCESS | 23556 | 14:21:57 INFO - PROCESS | 23556 | __start_tp_report 14:21:57 INFO - PROCESS | 23556 | _x_x_mozilla_page_load 14:21:57 INFO - PROCESS | 23556 | _x_x_mozilla_page_load_details 14:21:57 INFO - PROCESS | 23556 | |i|pagename|runs| 14:21:57 INFO - PROCESS | 23556 | |0;ai-astar;112;112;106;111;112;112;101;111;112;111 14:21:57 INFO - PROCESS | 23556 | |1;audio-beat-detection;161;128;157;168;132;150;159;130;166;127 14:21:57 INFO - PROCESS | 23556 | |2;audio-dft;162;162;160;160;160;161;158;162;161;164 14:21:57 INFO - PROCESS | 23556 | |3;audio-fft;73;76;93;96;73;76;75;116;95;75 14:21:57 INFO - PROCESS | 23556 | |4;audio-oscillator;92;94;138;92;93;94;146;93;93;145 14:21:57 INFO - PROCESS | 23556 | |5;imaging-gaussian-blur;117;117;117;116;118;117;118;117;118;118 14:21:57 INFO - PROCESS | 23556 | |6;imaging-darkroom;145;145;145;145;145;145;145;192;145;145 14:21:57 INFO - PROCESS | 23556 | |7;imaging-desaturate;95;96;96;96;96;95;97;95;95;95 14:21:57 INFO - PROCESS | 23556 | |8;json-parse-financial;59;59;59;59;60;60;58;67;56;56 14:21:57 INFO - PROCESS | 23556 | |9;json-stringify-tinderbox;67;66;66;67;67;67;67;67;66;67 14:21:57 INFO - PROCESS | 23556 | |10;stanford-crypto-aes;81;82;82;82;82;81;82;81;82;81 14:21:57 INFO - PROCESS | 23556 | |11;stanford-crypto-ccm;123;117;115;119;115;115;120;119;117;116 14:21:57 INFO - PROCESS | 23556 | |12;stanford-crypto-pbkdf2;142;145;152;144;154;142;151;153;148;151 14:21:57 INFO - PROCESS | 23556 | |13;stanford-crypto-sha256-iterative;68;70;70;68;70;68;67;69;69;70 14:21:57 INFO - PROCESS | 23556 | __end_tp_report 14:21:57 INFO - PROCESS | 23556 | __start_cc_report 14:21:57 INFO - PROCESS | 23556 | _x_x_mozilla_cycle_collect,1062 14:21:57 INFO - PROCESS | 23556 | __end_cc_report 14:21:57 INFO - PROCESS | 23556 | __startTimestamp1457130117673__endTimestamp 14:21:57 INFO - PROCESS | 23556 | 14:21:57 INFO - PROCESS | 23556 | ------- Summary: start ------- 14:21:57 INFO - PROCESS | 23556 | Number of tests: 14 14:21:57 INFO - PROCESS | 23556 | 14:21:57 INFO - PROCESS | 23556 | [#0] ai-astar Cycles:10 Average:110.00 Median:112.00 stddev:3.65 (3.3%) stddev-sans-first:3.80 14:21:57 INFO - PROCESS | 23556 | Values: 112.0 112.0 106.0 111.0 112.0 112.0 101.0 111.0 112.0 111.0 14:21:57 INFO - PROCESS | 23556 | 14:21:57 INFO - PROCESS | 23556 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:158.00 stddev:16.73 (10.6%) stddev-sans-first:17.05 14:21:57 INFO - PROCESS | 23556 | Values: 161.0 128.0 157.0 168.0 132.0 150.0 159.0 130.0 166.0 127.0 14:21:57 INFO - PROCESS | 23556 | 14:21:57 INFO - PROCESS | 23556 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:1.63 (1.0%) stddev-sans-first:1.69 14:21:57 INFO - PROCESS | 23556 | Values: 162.0 162.0 160.0 160.0 160.0 161.0 158.0 162.0 161.0 164.0 14:21:57 INFO - PROCESS | 23556 | 14:21:57 INFO - PROCESS | 23556 | [#3] audio-fft Cycles:10 Average:84.80 Median:76.00 stddev:14.51 (19.1%) stddev-sans-first:14.75 14:21:57 INFO - PROCESS | 23556 | Values: 73.0 76.0 93.0 96.0 73.0 76.0 75.0 116.0 95.0 75.0 14:21:57 INFO - PROCESS | 23556 | 14:21:57 INFO - PROCESS | 23556 | [#4] audio-oscillator Cycles:10 Average:108.00 Median:93.00 stddev:24.25 (26.1%) stddev-sans-first:25.02 14:21:57 INFO - PROCESS | 23556 | Values: 92.0 94.0 138.0 92.0 93.0 94.0 146.0 93.0 93.0 145.0 14:21:57 INFO - PROCESS | 23556 | 14:21:57 INFO - PROCESS | 23556 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.67 (0.6%) stddev-sans-first:0.71 14:21:57 INFO - PROCESS | 23556 | Values: 117.0 117.0 117.0 116.0 118.0 117.0 118.0 117.0 118.0 118.0 14:21:57 INFO - PROCESS | 23556 | 14:21:57 INFO - PROCESS | 23556 | [#6] imaging-darkroom Cycles:10 Average:149.70 Median:145.00 stddev:14.86 (10.3%) stddev-sans-first:15.67 14:21:57 INFO - PROCESS | 23556 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 145.0 192.0 145.0 145.0 14:21:57 INFO - PROCESS | 23556 | 14:21:57 INFO - PROCESS | 23556 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 14:21:57 INFO - PROCESS | 23556 | Values: 95.0 96.0 96.0 96.0 96.0 95.0 97.0 95.0 95.0 95.0 14:21:57 INFO - PROCESS | 23556 | 14:21:57 INFO - PROCESS | 23556 | [#8] json-parse-financial Cycles:10 Average:59.30 Median:59.00 stddev:3.06 (5.2%) stddev-sans-first:3.24 14:21:57 INFO - PROCESS | 23556 | Values: 59.0 59.0 59.0 59.0 60.0 60.0 58.0 67.0 56.0 56.0 14:21:57 INFO - PROCESS | 23556 | 14:21:57 INFO - PROCESS | 23556 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:67.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 14:21:57 INFO - PROCESS | 23556 | Values: 67.0 66.0 66.0 67.0 67.0 67.0 67.0 67.0 66.0 67.0 14:21:57 INFO - PROCESS | 23556 | 14:21:57 INFO - PROCESS | 23556 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:82.00 stddev:0.52 (0.6%) stddev-sans-first:0.50 14:21:57 INFO - PROCESS | 23556 | Values: 81.0 82.0 82.0 82.0 82.0 81.0 82.0 81.0 82.0 81.0 14:21:57 INFO - PROCESS | 23556 | 14:21:57 INFO - PROCESS | 23556 | [#11] stanford-crypto-ccm Cycles:10 Average:117.60 Median:118.00 stddev:2.63 (2.2%) stddev-sans-first:1.94 14:21:57 INFO - PROCESS | 23556 | Values: 123.0 117.0 115.0 119.0 115.0 115.0 120.0 119.0 117.0 116.0 14:21:57 INFO - PROCESS | 23556 | 14:21:57 INFO - PROCESS | 23556 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.20 Median:151.00 stddev:4.61 (3.1%) stddev-sans-first:4.31 14:21:57 INFO - PROCESS | 23556 | Values: 142.0 145.0 152.0 144.0 154.0 142.0 151.0 153.0 148.0 151.0 14:21:57 INFO - PROCESS | 23556 | 14:21:57 INFO - PROCESS | 23556 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.50 stddev:1.10 (1.6%) stddev-sans-first:1.12 14:21:57 INFO - PROCESS | 23556 | Values: 68.0 70.0 70.0 68.0 70.0 68.0 67.0 69.0 69.0 70.0 14:21:57 INFO - PROCESS | 23556 | -------- Summary: end -------- 14:21:57 INFO - PROCESS | 23556 | 14:21:58 INFO - TEST-INFO | 23556: exit 0 14:21:58 INFO - TEST-OK | kraken | took 60428ms 14:21:58 INFO - SUITE-END | took 1173s 14:21:58 INFO - Completed test suite (00:19:33) 14:21:58 INFO - javascript benchmark 14:21:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3154.6056742907135, 3189.091109033926, 3198.9680103198975, 3200.4399230134736, 3234.126785767842, 5013.323201367814, 5100.948990510094, 5156.149235376159, 5162.586993040557, 5208.76560554775, 5046.596272298217, 5083.974580127104, 5085.821996230133, 5104.591632669387, 5163.432022477534, 4647.34937108805, 4678.204705200115, 4682.227432473638, 4745.738984355859, 4822.879428014293, 4651.720896746206, 4668.0, 4748.477667456577, 4763.2378819388905, 4822.541858523452, 4665.440147182359, 4686.08621318843, 4687.648426368002, 4716.834910778123, 4723.291506274069, 4655.2784318430695, 4673.415823022122, 4696.178168820443, 4696.741679207642, 4719.5752382285755, 4621.930671039937, 4628.421447319085, 4665.766711664437, 4670.136024835382, 4683.8360657376825, 4873.415190177166, 4883.511648835123, 4893.339399181101, 4899.608031357483, 4908.288298196777, 5389.865253368658, 5394.73026348681, 5404.405515393303, 5407.945920540784, 5461.1262198048125, 5377.435369286247, 5451.236826844245, 5452.672839629635, 5519.668819870821, 5561.193626924114, 5160.225966105077, 5162.74186290684, 5175.0167468180925, 5176.456472070416, 5217.3999990000875, 5610.438956104438, 5615.185798059259, 5623.409541998113, 5625.943740562624, 5628.549716022709, 5338.8665283367445, 5417.729113544307, 5419.051665958442, 5456.890862182734, 5496.120620700669, 5546.057170281062, 5562.694051827108, 5572.637778544382, 5576.693281869536, 5590.273264475592, 5403.405625381205, 5530.640508366943, 5579.218909352694, 5584.274044374287, 5615.578831587647, 5503.449655034465, 5514.420985796514, 5535.640183388147, 5538.778448862, 5597.776088956478, 4244.830206791756, 4248.044190057274, 4249.022724773319, 4261.786910654455, 4288.935665965013, 3784.1863999239745, 3809.1429428378947, 3836.290286297044, 3852.9807350963065, 3867.916983244696, 5141.640085194075, 5151.639385243072, 5178.326817513699, 5187.19598462239, 5226.398964119099, 5491.176323551419, 5508.283923090053, 5516.062269414209, 5530.281063461724, 5568.582356323292, 4960.156773348539, 5124.743762811919, 5171.5862730981435, 5194.818181363634, 5239.187925871496, 4698.3187437821325, 4718.504557021532, 4720.0087981523575, 4749.4775574686755, 4751.596114330251, 5731.942680573141, 5732.3407808101765, 5735.627184233012, 5736.627119237236, 5739.311282646026, 5404.135338345845, 5495.203195536545, 5509.559235261089, 5518.779248830002, 5530.225768392509, 5622.409646987007, 5639.661620302795, 5652.095664693794, 5688.857778555569, 5694.316681998021, 5413.945860541502, 5417.918731218956, 5419.2413062170535, 5422.132458806572, 5464.836054918359, 5317.282166907418, 5515.779368825362, 5543.722813859372, 5564.248826408383, 5617.5505959522325, 5385.138377859524, 5406.0, 5409.107497262908, 5414.756335964812, 5415.052365835884, 5253.737313134405, 5366.436524165063, 5380.650257733235, 5385.946140538701, 5431.945680543144, 5291.417944026231, 5341.439148889466, 5354.063038968243, 5355.5983301253345, 5407.107827208467, 5381.085215513293, 5404.918926216032, 5417.187421886749, 5425.430329815313, 5464.754086066216, 5203.791848326176, 5255.2379904912805, 5278.313819203632, 5310.893782124259, 5319.973400132974], "unit": "score", "name": "dojo.html", "value": 5082.6240213921565}, {"lowerIsBetter": false, "replicates": [524.6956765076256, 527.8944211157769, 578.7453520451003, 588.3910152991655, 593.8693487432764, 28456.304709722895, 29164.416711665755, 29171.270718232, 29184.854075729618, 29238.853805730996, 37232.81383593085, 37421.62578374215, 37642.24715505688, 37774.8111259444, 37787.24425511495, 8436.957815210915, 8582.44214126083, 8586.742397728078, 8604.0, 8608.698695545658, 8700.738977830644, 8867.113288671146, 8872.911270887273, 8876.289896808239, 8883.333749968779, 8837.072107428723, 8908.51003194824, 8915.821683566324, 8921.464712117262, 8931.0, 8759.16787905148, 8805.163509466622, 8819.29445644347, 8890.44417226986, 8890.511021893826, 8696.913030869673, 8829.293656507529, 8834.425762325429, 8839.292856571523, 8843.911560884373, 39949.40075898864, 40206.19587608232, 40349.0, 40543.59456405428, 40604.39093413601, 3524.947125793115, 3555.306715190539, 4072.6334629883454, 4162.084341444877, 4215.852445164435, 29982.0, 30290.242743931358, 30494.0, 30544.389112217854, 31263.37473250545, 3865.439511270878, 3947.50656167979, 3981.2634662587225, 3988.0, 4069.0844559974066, 200448.0, 200535.0, 200786.0, 201874.99999999854, 201937.0, 56377.43622563804, 57494.53801888814, 57513.71243143841, 57516.42483575195, 57548.0, 61083.0, 61193.38806611966, 61588.69205653943, 61596.38403615906, 61707.6914615424, 16135.273912673958, 16316.021038737714, 16326.102064386572, 16389.262483188286, 16391.098489583186, 12514.061445391631, 12541.059420543314, 12577.937110314573, 12594.81107783384, 12597.559085431965, 17641.79173722415, 19736.70394944077, 19779.0, 19854.50363740918, 19910.50223744418, 6189.81430557084, 7521.5111017783665, 7721.53670779755, 7887.763367098996, 7930.960345198352, 947.6493697332031, 949.8955114937352, 990.1732053735068, 1052.7736536644659, 1091.4542728635681, 26098.0, 28066.579001314996, 28929.42141157165, 29260.0, 29505.409891802043, 1062.3413483640193, 1065.8667666541683, 1073.9731506712394, 1082.8105081610686, 1097.1825989637612, 14913.70172596542, 15148.545543633709, 15263.3894644213, 15361.0, 15406.0, 297754.0, 298936.0, 300919.0, 300920.0, 301482.0, 53828.46171538234, 54185.1872221917, 54337.45662543324, 54366.72816635892, 54377.456225437236, 1126.8366086917351, 1316.5063101336998, 1322.2463195978391, 1360.0343755933397, 1372.1218420211073, 25126.623100653138, 26362.0, 26551.601725974513, 26755.33111672146, 26857.194284171506, 39829.80085099556, 40140.197196055335, 40276.56957734588, 40297.0, 40311.1937761249, 172159.6448337406, 173494.0, 173609.0, 173802.0, 173811.0, 26628.600570991064, 32085.679143209203, 32510.83744581262, 32576.185595360304, 32645.0, 37376.6262337384, 37997.81001094977, 38563.2287354257, 38583.80708096441, 39151.0, 34456.13859653529, 34674.47988280228, 34826.0, 35336.0, 35375.0, 34979.65020349764, 35184.12039699028, 35302.29395412129, 35638.109047274025, 35672.0, 34068.318633627685, 34810.12974675552, 34938.65061349354, 35229.64770352366, 35291.647083528835, 29804.55293170561, 31185.8440707795, 31634.0, 32028.67971320257, 32094.358112837144, 24670.0, 24990.875045624656, 25013.11457391342, 25067.49865002726, 25236.369090772878], "unit": "score", "name": "ext.html", "value": 17757.054832717964}, {"lowerIsBetter": false, "replicates": [354.6187848063333, 362.8113381041857, 364.58801554243706, 366.3826452427661, 369.57683452446946, 16437.506874793762, 16619.16904154792, 16944.237509312065, 16963.201071823136, 16965.236564354604, 16559.66880662386, 16961.151942402892, 17289.827101728977, 17297.39459118931, 17302.56743581408, 5188.455212202721, 5223.8432847014465, 5446.700431476267, 5451.454854514556, 5452.509274165324, 5322.547583455411, 5426.023315803154, 5430.0, 5433.293671822657, 5438.184272359138, 5081.161608334621, 5277.340332458442, 5278.894422111574, 5395.622306438551, 5406.162044883049, 5111.0, 5214.348206474191, 5219.712915789611, 5267.499587539178, 5290.470952904717, 5273.683578985235, 5300.549453296474, 5302.151655735102, 5307.548858347007, 5308.442613525563, 12540.686482838002, 12769.425375858016, 12786.041046921519, 17883.28466861324, 19283.614327713367, 2083.364573804989, 2095.497080700636, 2271.670607761882, 2281.7261928568514, 2297.1500544798364, 9445.0, 9503.334766566342, 10589.299728569242, 11292.717682057932, 12690.238585684796, 1811.4746723450316, 1860.6650802855481, 1870.69133592957, 1954.4625228062255, 1997.900104994759, 47152.52847471516, 55745.44254557403, 56980.71509642467, 63058.684706576176, 64483.35516644821, 8923.0, 9764.267679924034, 9819.0, 10081.243906707026, 10390.376577405379, 12730.936345318214, 13131.671708207372, 13135.802962955564, 13167.802482962763, 13189.802152967713, 7481.738139165103, 7571.3564347030015, 7577.204393538709, 7697.268114674153, 7846.33306168982, 7530.9246907531315, 7561.2060733622175, 7622.2758837910305, 7687.6156192190165, 7725.7295994641045, 4458.554144585581, 4487.439070116236, 4500.504944456107, 4506.616937560344, 4548.909021819545, 1766.3287950578697, 1796.8023517413073, 1817.274587096447, 1846.2614954018231, 1852.397970659541, 899.2491269789799, 919.0901008002163, 945.3666043750703, 999.4003597841237, 1008.2387797213057, 15648.0, 16597.41909033178, 16703.0, 17055.31778728862, 17181.91409042947, 904.7964208053266, 938.7934654376163, 952.2619969523674, 958.8226178157063, 963.2775418436173, 9205.539723013822, 9680.370775899544, 9686.806263874683, 9703.514824258758, 9855.852162217572, 424226.0, 427469.0, 446590.0, 447424.0, 447722.0, 69631.0, 69932.65033674799, 71809.2819071813, 72618.2738172622, 72858.0, 993.8857031441332, 1001.2690735762789, 1002.3334482569155, 1005.7435353984833, 1020.4081632653043, 14821.777673334693, 14920.253987300808, 14959.850401496282, 14994.250287485364, 15427.228638568251, 33773.83113084419, 33837.492437612964, 33852.66147338495, 33876.0, 33942.15144621404, 47015.0, 47023.52976470192, 47306.29040564325, 47325.52674473211, 47585.04829903452, 7727.381809455118, 7750.224977502205, 7837.647305871364, 7903.802404939923, 7939.325157361689, 8654.82690346177, 11436.428178591204, 11593.88406115928, 11863.288202707865, 12170.878291216974, 10368.22238332113, 10515.894841051491, 10602.0, 10702.625408110678, 10841.0, 10406.323588966692, 10584.84122738175, 10640.308379955279, 10697.572097116028, 10757.784844303227, 10429.739256518647, 10705.304155229886, 10807.405592692478, 10958.671239862817, 11227.71930701739, 7753.224677532427, 7877.566733829465, 7882.108294009282, 8105.797355066171, 8165.142660020612, 10762.085222756154, 10868.891311086787, 10876.18428617841, 10907.29102608328, 10953.780924381626], "unit": "score", "name": "jquery.html", "value": 8266.064749968702}, {"lowerIsBetter": false, "replicates": [1280.5838102616651, 1451.8185226846645, 1459.919704416257, 1604.6549991751772, 1785.803561608223, 7289.125304963405, 7443.813904652387, 7468.103827540689, 7469.962650186755, 7475.73834915778, 7264.237255088219, 7406.222346653604, 7423.740169094082, 7429.814254643623, 7431.739889103883, 1947.3379051122615, 2216.966745498819, 2263.15131825565, 2268.6029944759684, 2286.6112760830697, 2267.7051983242154, 2277.39648993017, 2279.601069812776, 2280.464090938628, 2280.703508543887, 2208.8785116818567, 2269.931902042933, 2276.4195130241765, 2277.271273192579, 2285.7714228577092, 2236.194969810867, 2244.6408574628063, 2263.9434014149697, 2264.773522647722, 2281.452451411666, 2211.060299372776, 2230.208276062007, 2231.141010710872, 2235.698180745595, 2244.7418546866993, 7645.579493127876, 7702.345300649452, 7709.267619576131, 7710.653020614086, 7726.227377262285, 4592.0, 4663.090697314025, 4681.6020638245445, 4689.155951928651, 4718.0, 2908.3020075181803, 2938.7942844000927, 2990.1627544287635, 2992.880284788606, 3050.4661684205175, 937.6671281694968, 949.3212353167519, 949.4398305000083, 964.5273815830262, 1033.731229880229, 10469.37183768984, 10514.421706806123, 10538.683839484751, 10562.630307939186, 10600.522976466078, 4129.132882094734, 4211.810468528924, 4276.8289268429535, 4326.091520780671, 4326.502452217972, 8969.416987895896, 8995.955020224857, 9015.954920225488, 9021.188093071654, 9048.321375896834, 4172.144710334374, 4692.906141877143, 4736.289556566542, 4739.004808990082, 4741.952580474152, 4144.48193975753, 4188.68584856137, 4202.2646036943415, 4205.306124489425, 4206.137741762931, 3557.5553055868018, 3622.9094272643397, 3629.637036296402, 3670.724695647837, 3685.3734865073, 1160.6692092753694, 1189.6133756528989, 1193.9641810745518, 1194.1103877611063, 1196.7845787758113, 1151.7293436042523, 1153.4866984192122, 1254.0782524844233, 1325.6023193042242, 1347.1916849889988, 7191.7842464726145, 7284.70861165558, 7290.890636640454, 7303.160136584254, 7361.043064401593, 478.1107140718261, 484.6074679509608, 486.41144215498934, 486.5134865134865, 488.98044078237183, 5511.503964643121, 5568.693721845257, 5573.303337082864, 5580.0, 5607.52336051432, 8957.910420895838, 9240.7689807754, 9336.579853906454, 9488.810223795486, 9493.288003399774, 9248.445093294424, 9293.070692930789, 9311.0, 9344.392614480174, 9364.438133712, 7196.316349946746, 7278.636068196569, 7344.449166312548, 7419.332260096509, 7419.85160296791, 6984.930150698631, 7026.473014523829, 7028.367446929801, 7042.084529011196, 7105.502614816914, 8141.755747327589, 8190.7952301192945, 8218.506889586644, 8425.157484251526, 8482.0, 8497.447665901696, 8672.566371681516, 8821.603027863634, 8845.734627961172, 8847.690330838648, 5957.702114894151, 6283.277423096402, 6471.805845824444, 6515.381038801306, 6592.571482853599, 7208.927910720826, 7242.89135662955, 7250.927490725026, 7282.453815963718, 7290.56256624583, 6404.583702059351, 6594.142761440982, 6635.668216589248, 6684.4318232950745, 6727.125473688389, 6384.521160912857, 6403.743850246125, 6588.4399826013405, 6634.0, 6703.899441508479, 6876.277990810893, 6909.205441374306, 6919.827004324932, 6928.341807528277, 6931.306869313028, 6345.206849143857, 6392.232932048184, 6408.935910640834, 6415.839604009937, 6416.807495775134, 6333.524985626004, 6365.681715914093, 6376.0, 6379.075034120119, 6386.0], "unit": "score", "name": "mootools.html", "value": 4317.973744153193}, {"lowerIsBetter": false, "replicates": [344.5882170805887, 350.69664739999894, 351.03640506808796, 351.53948327690745, 355.8718861209964, 5990.460858522738, 6010.429009244121, 6016.3382027976995, 6034.125051867482, 6067.362926892679, 5919.88160236795, 5934.109883517474, 5955.166276721263, 5964.254468191476, 5964.880702385961, 4373.890652733675, 4529.773511324437, 4609.939713865813, 4634.536546345355, 4638.652101092414, 4602.585767280944, 4616.3537104805355, 4630.467496237925, 4636.698614590057, 4653.185692503798, 4580.908381832362, 4582.0, 4587.724736515803, 4596.678232523725, 4599.563041511051, 4394.1651086293505, 4492.685512014144, 4554.88612784683, 4572.657050721209, 4581.61056310214, 4033.737807042533, 4043.3126368517424, 4050.10897602527, 4051.6758659307184, 4069.7965101744794, 5674.063779476382, 5682.119271512922, 5690.430956904318, 5696.458836410535, 5720.11338242573, 5357.303550538444, 5364.624476286662, 5365.222042803811, 5371.516563509303, 5374.811881584164, 6271.686415679198, 6290.465310448617, 6315.179026726542, 6328.841778955517, 6329.1772069631115, 4277.358396240557, 4416.359627853975, 4430.822767089313, 4435.379046933432, 4520.3219517072375, 6581.3418658133805, 6637.435817955479, 6651.368120028589, 6660.567063140928, 6662.133922590081, 4510.503844577094, 4513.413256276663, 4516.548345165457, 4519.728816271035, 4521.073179998092, 4528.162289976299, 4534.433195850519, 4540.250858608359, 4555.40779698637, 4580.267157254823, 5287.312649355559, 5295.894082118336, 5297.311349524537, 5300.0, 5300.575953923677, 6258.0, 6266.874662506724, 6393.552451328363, 6409.327020662857, 6409.391107844747, 1572.8820338474661, 1574.3230410923413, 1577.597712583284, 1583.4853672556465, 1584.7622856571606, 1000.4247557654378, 1050.99474502627, 1064.3081996702206, 1071.4803320389606, 1099.923005389631, 5929.673867937305, 5984.461398474158, 5989.580729348903, 5993.280806303184, 5996.0, 6464.0, 6467.773627923, 6473.029045643191, 6482.157319548429, 6483.481321494269, 5943.07882278239, 5983.222181116514, 5984.700764961822, 5985.521158307325, 5986.132010858489, 3456.187795867969, 3494.4408894576745, 3500.4224302990233, 3500.632433594487, 3501.28223714138, 6610.603363798187, 6667.666616669244, 6751.392374686302, 6756.695948682321, 6757.8648427031185, 6561.507886908501, 6574.506911981621, 6615.17310336208, 6615.4046135848, 6623.569467984566, 6634.237062737847, 6666.733330666719, 6684.86630267392, 6728.42808361285, 6738.494612904052, 6395.616263024233, 6425.421712045938, 6437.678116094083, 6443.548951573345, 6449.097126402401, 6227.844303892258, 6380.330065343072, 6392.744290228339, 6395.808125756234, 6408.487321014401, 6705.899411508929, 6716.798496045127, 6728.629925353956, 6735.831604209738, 6742.6628668567355, 4506.391637128946, 4510.481294651026, 4513.413256276663, 4515.14212299662, 4520.2089634314525, 6470.6441145737435, 6476.5466417350335, 6476.643784591893, 6478.870422591616, 6481.416672499309, 6287.30839607652, 6342.809715708536, 6343.111964324906, 6346.524010699124, 6351.333110023381, 6026.789062382795, 6258.624482531062, 6264.154339164154, 6273.15312432834, 6277.748890044347, 6133.723982420713, 6138.324784273637, 6159.322474527888, 6160.44555989963, 6161.507079433724, 6232.906506402498, 6262.091996660368, 6267.4986001120715, 6284.654344011124, 6296.496280297657, 6030.90953635687, 6114.816555503342, 6125.326214116532, 6125.6018358808315, 6132.693365331805], "unit": "score", "name": "prototype.html", "value": 4766.061894497552}, {"lowerIsBetter": false, "replicates": [755.2296657409439, 771.651742431399, 777.308195705822, 781.5037451218475, 789.6170357376672, 13839.723205535884, 14072.648183795398, 14078.0, 14109.858901410982, 14150.080244784094, 12885.5490057848, 12893.355332233374, 12927.0, 12928.224306541613, 12949.028822838278, 817.2481317188186, 829.8464784014947, 833.9291160251386, 834.1283358889945, 835.7701632051173, 680.2483256002121, 816.603947085663, 832.9167083291653, 837.6440012994453, 837.7026155714725, 856.4861083349971, 861.6079683743882, 870.2863651805523, 872.1757938747886, 872.9083446238149, 701.5475018613017, 850.808568072185, 864.6671031652796, 867.0159369116036, 868.6655637579546, 619.1239396254294, 630.6310808177221, 631.2929518938818, 632.0172132334219, 632.822809613309, 12111.515539378413, 12148.939255303756, 12151.453184606715, 12163.0, 12163.695907602292, 12223.511059557695, 13011.544595939191, 13043.08698391113, 13089.934550327187, 13107.737845243042, 10367.77792734179, 10487.423191724452, 10560.419176945265, 10600.469976501221, 10688.305260158142, 3535.522704434894, 3574.12433953683, 3610.765300255475, 3635.1820840310984, 3685.2261025184475, 45954.31068533975, 45985.77007114943, 46013.0, 46016.0, 46207.30689039667, 9549.188318992963, 9663.226941844636, 9765.609375625038, 9882.851757223647, 10056.49717514136, 16923.0, 17018.829811701973, 17041.40355087566, 17068.829311706722, 17083.658326833644, 7079.469039822034, 7128.215896251409, 7236.746713864989, 7303.45224108194, 7307.7807665770115, 4208.342890194206, 4303.2469317869245, 4330.39374487572, 4430.069685366045, 4476.485204201494, 3175.984120079385, 3204.295055087877, 3208.3743669984597, 3214.72674822638, 3217.6782321767637, 525.2856115682745, 532.5819231903015, 538.8388023808699, 541.8103663717667, 545.2530033853645, 453.3294808630208, 528.9973550132224, 543.4185421598851, 554.2572952244012, 569.35947059558, 7827.726029588937, 7867.331276841418, 7893.447458677838, 7971.322437592754, 8141.674333026731, 561.430148399375, 573.3378145944156, 599.8200539838031, 639.6002498438476, 641.5573254454412, 3584.390653588896, 3666.50502182202, 3729.813509324523, 3819.7394859696233, 3836.405357169643, 51822.48177518252, 53625.463745362824, 53998.19002714963, 54112.72943635335, 54211.18683219755, 49035.79616116482, 49835.0, 50224.748876255384, 50344.74827625912, 51827.74086129545, 43128.56871431245, 43767.0, 44028.77985610116, 44196.0, 44579.777101113636, 7946.404019698662, 7970.242826931432, 7982.181916243169, 8240.340772738287, 8311.95844020776, 31699.20751981219, 32331.35337293288, 32465.188370290933, 33560.0, 33827.32345353128, 37840.62159378371, 37947.0, 38910.22179556336, 41264.0, 41549.58450415457, 10306.639267625596, 10442.63450779219, 10528.736781580521, 10575.894241057491, 10760.762512311185, 11238.0, 11303.604373846876, 11361.829572556253, 11681.299122052704, 11982.520699171935, 10480.0, 10491.370517768959, 10603.89396106029, 10610.310329828537, 10929.0, 9927.503624818586, 10214.0, 10329.638462653771, 10479.318844275098, 10537.0, 10431.37411755297, 10472.476376181314, 10685.091767199565, 10799.406032667965, 11078.11375090007, 9193.713614671457, 9325.21925899406, 9470.905290947003, 9702.660406885725, 9909.851352229578, 8151.918480815353, 8707.390482666153, 8807.559622019002, 8895.822083558422, 9018.954905225432], "unit": "score", "name": "yui.html", "value": 6057.407482291011}], "name": "dromaeo_css", "value": 6731.117152430578}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 112.0, 106.0, 111.0, 112.0, 112.0, 101.0, 111.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.0}, {"lowerIsBetter": true, "replicates": [161.0, 128.0, 157.0, 168.0, 132.0, 150.0, 159.0, 130.0, 166.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 147.8}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 160.0, 160.0, 160.0, 161.0, 158.0, 162.0, 161.0, 164.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [73.0, 76.0, 93.0, 96.0, 73.0, 76.0, 75.0, 116.0, 95.0, 75.0], "unit": "score", "name": "audio-fft", "value": 84.8}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 138.0, 92.0, 93.0, 94.0, 146.0, 93.0, 93.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 108.0}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 116.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.3}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 192.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 149.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 97.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 59.0, 59.0, 60.0, 60.0, 58.0, 67.0, 56.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 59.3}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 66.0, 67.0, 67.0, 67.0, 67.0, 67.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.7}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 82.0, 82.0, 82.0, 81.0, 82.0, 81.0, 82.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.6}, {"lowerIsBetter": true, "replicates": [123.0, 117.0, 115.0, 119.0, 115.0, 115.0, 120.0, 119.0, 117.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.6}, {"lowerIsBetter": true, "replicates": [142.0, 145.0, 152.0, 144.0, 154.0, 142.0, 151.0, 153.0, 148.0, 151.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.2}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 70.0, 68.0, 70.0, 68.0, 67.0, 69.0, 69.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1516.5}]} 14:21:58 INFO - Return code: 0 14:21:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:21:58 INFO - # TBPL SUCCESS # 14:21:58 INFO - Running post-action listener: _resource_record_post_action 14:21:58 INFO - Running post-run listener: _resource_record_post_run 14:22:00 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 533049344; Read time: 0; Write time: 1003032 14:22:00 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 240644096; Read time: 0; Write time: 633764 14:22:00 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 292253696; Read time: 0; Write time: 369220 14:22:00 INFO - Running post-run listener: _upload_blobber_files 14:22:00 INFO - Blob upload gear active. 14:22:00 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:22:00 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:22:00 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', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 14:22:00 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 Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 14:22:00 INFO - (blobuploader) - INFO - Open directory for files ... 14:22:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 14:22:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:22:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:22:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:22:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:22:01 INFO - (blobuploader) - INFO - Done attempting. 14:22:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:22:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:22:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:22:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:22:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:22:02 INFO - (blobuploader) - INFO - Done attempting. 14:22:02 INFO - (blobuploader) - INFO - Iteration through files over. 14:22:02 INFO - Return code: 0 14:22:02 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:22:02 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:22:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/31b3dbb1f05ce297a2becd66668e6791cb4a9abd9489ad9b62a8f3e98fae37794efda45a1642791d97338a57f0f611c1ae7794384ee6093cf93f07d63c2d24ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fea7152adefd18fbac1c51f3b37dd778a3a564c1cd6651e641aa1e2e545b7a92afc2d6692502a943fbca5b12f6f6a1a80cd2da0f82f9320ef8b52b994aa9cb8e"} 14:22:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:22:02 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:22:02 INFO - Contents: 14:22:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/31b3dbb1f05ce297a2becd66668e6791cb4a9abd9489ad9b62a8f3e98fae37794efda45a1642791d97338a57f0f611c1ae7794384ee6093cf93f07d63c2d24ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fea7152adefd18fbac1c51f3b37dd778a3a564c1cd6651e641aa1e2e545b7a92afc2d6692502a943fbca5b12f6f6a1a80cd2da0f82f9320ef8b52b994aa9cb8e"} 14:22:02 INFO - Running post-run listener: copy_logs_to_upload_dir 14:22:02 INFO - Copying logs to upload dir... 14:22:02 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 14:22:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.632938 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-03-04 14:22:02.684779) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-04 14:22:02.688158) ========= 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=745a4373a2a16df560f216e000000264-1457126135.895393-1607768215 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/31b3dbb1f05ce297a2becd66668e6791cb4a9abd9489ad9b62a8f3e98fae37794efda45a1642791d97338a57f0f611c1ae7794384ee6093cf93f07d63c2d24ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fea7152adefd18fbac1c51f3b37dd778a3a564c1cd6651e641aa1e2e545b7a92afc2d6692502a943fbca5b12f6f6a1a80cd2da0f82f9320ef8b52b994aa9cb8e"} build_url:https://queue.taskcluster.net/v1/task/clHn5J3tRcWBvu1-cRevfg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011534 build_url: 'https://queue.taskcluster.net/v1/task/clHn5J3tRcWBvu1-cRevfg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/31b3dbb1f05ce297a2becd66668e6791cb4a9abd9489ad9b62a8f3e98fae37794efda45a1642791d97338a57f0f611c1ae7794384ee6093cf93f07d63c2d24ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fea7152adefd18fbac1c51f3b37dd778a3a564c1cd6651e641aa1e2e545b7a92afc2d6692502a943fbca5b12f6f6a1a80cd2da0f82f9320ef8b52b994aa9cb8e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-04 14:22:02.713936) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 14:22:02.714314) ========= 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=745a4373a2a16df560f216e000000264-1457126135.895393-1607768215 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004474 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 14:22:02.796914) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-04 14:22:02.797272) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-04 14:22:02.797605) ========= ========= Total master_lag: 0.32 =========